Name | CMS_4120382_1700046786.185346_0 |
Workunit | 2350877 |
Created | 15 Nov 2023, 11:13:08 UTC |
Sent | 16 Nov 2023, 21:20:39 UTC |
Report deadline | 23 Nov 2023, 21:20:39 UTC |
Received | 19 Nov 2023, 15:26:48 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 4441 |
Run time | 18 hours 1 min 23 sec |
CPU time | 10 hours 44 min 25 sec |
Validate state | Valid |
Credit | 5,532.86 |
Device peak FLOPS | 3.81 GFLOPS |
Application version | CMS Simulation v60.70 (vbox64_mt_mcore_cms) windows_x86_64 |
Peak working set size | 82.83 MB |
Peak swap size | 107.39 MB |
Peak disk usage | 1.65 GB |
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> 2023-11-16 22:20:42 (15984): Detected: vboxwrapper 26206 2023-11-16 22:20:43 (15984): Detected: BOINC client v7.16.11 2023-11-16 22:20:44 (15984): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-11-16 22:20:44 (15984): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-11-16 22:20:44 (15984): Successfully copied 'init_data.xml' to the shared directory. 2023-11-16 22:20:45 (15984): Create VM. (boinc_85fb5cc4b6d1be08, slot#0) 2023-11-16 22:20:45 (15984): Setting Memory Size for VM. (1896MB) 2023-11-16 22:20:46 (15984): Setting CPU Count for VM. (1) 2023-11-16 22:20:47 (15984): Setting Chipset Options for VM. 2023-11-16 22:20:48 (15984): Setting Graphics Controller Options for VM. 2023-11-16 22:20:48 (15984): Setting Boot Options for VM. 2023-11-16 22:20:48 (15984): Setting Network Configuration for NAT. 2023-11-16 22:20:49 (15984): Enabling VM Network Access. 2023-11-16 22:20:49 (15984): Disabling USB Support for VM. 2023-11-16 22:20:49 (15984): Disabling COM Port Support for VM. 2023-11-16 22:20:49 (15984): Disabling LPT Port Support for VM. 2023-11-16 22:20:50 (15984): Disabling Audio Support for VM. 2023-11-16 22:20:50 (15984): Disabling Clipboard Support for VM. 2023-11-16 22:20:50 (15984): Disabling Drag and Drop Support for VM. 2023-11-16 22:20:51 (15984): Adding storage controller(s) to VM. 2023-11-16 22:20:52 (15984): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi) 2023-11-16 22:20:54 (15984): Adding VirtualBox Guest Additions to VM. 2023-11-16 22:20:54 (15984): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2023-11-16 22:20:55 (15984): forwarding host port 52689 to guest port 80 2023-11-16 22:20:55 (15984): Enabling remote desktop for VM. 2023-11-16 22:20:56 (15984): Enabling shared directory for VM. 2023-11-16 22:20:57 (15984): Starting VM using VBoxManage interface. (boinc_85fb5cc4b6d1be08, slot#0) 2023-11-16 22:21:05 (15984): Successfully started VM. (PID = '9932') 2023-11-16 22:21:05 (15984): Reporting VM Process ID to BOINC. 2023-11-16 22:21:05 (15984): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-16 22:21:05 (15984): Guest Log: CPUID EDX: 0x178bfbff 2023-11-16 22:21:05 (15984): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-16 22:21:05 (15984): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-16 22:21:05 (15984): VM state change detected. (old = 'poweredoff', new = 'running') 2023-11-16 22:21:05 (15984): Detected: Web Application Enabled (http://localhost:52689) 2023-11-16 22:21:05 (15984): Detected: Remote Desktop Enabled (localhost:52691) 2023-11-16 22:21:06 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 22:21:19 (15984): Preference change detected 2023-11-16 22:21:19 (15984): Setting CPU throttle for VM. (50%) 2023-11-16 22:21:19 (15984): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-11-16 22:21:20 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 22:21:21 (15984): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-16 22:21:21 (15984): Guest Log: BIOS: Booting from Hard Disk... 2023-11-16 22:21:24 (15984): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-16 22:21:24 (15984): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-16 22:22:00 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 22:22:10 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 22:22:16 (15984): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-16 22:22:17 (15984): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-16 22:22:22 (15984): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.000466 main Log opened 2023-11-16T21:22:19.989390000Z 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.003229 main OS Product: Linux 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.003524 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.003704 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.003863 main Executable: /usr/sbin/VBoxService 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.003868 main Process ID: 2174 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.003872 main Package type: LINUX_64BITS_GENERIC 2023-11-16 22:22:22 (15984): Guest Log: 00:00:00.061881 main 5.2.6 r120293 started. Verbose level = 0 2023-11-16 22:23:19 (15984): Guest Log: [INFO] Mounting the shared directory 2023-11-16 22:23:19 (15984): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-16 22:23:20 (15984): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-16 22:23:20 (15984): Guest Log: [INFO] Testing connection to cern.ch 2023-11-16 22:23:21 (15984): Guest Log: [INFO] Testing connection to VCCS 2023-11-16 22:23:21 (15984): Guest Log: [INFO] Testing connection to HTCondor 2023-11-16 22:23:22 (15984): Guest Log: [INFO] Testing connection to WMAgent 2023-11-16 22:23:22 (15984): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-16 22:23:23 (15984): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-16 22:23:23 (15984): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-16 22:23:24 (15984): Guest Log: [INFO] Testing connection to Frontier 2023-11-16 22:23:25 (15984): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-16 22:23:25 (15984): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-16 22:23:26 (15984): Guest Log: [INFO] This makes the application less efficient 2023-11-16 22:23:26 (15984): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-16 22:23:26 (15984): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-16 22:23:27 (15984): Guest Log: [INFO] Advice can be found in the project forum 2023-11-16 22:23:28 (15984): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-16 22:23:30 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 22:23:50 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 22:24:29 (15984): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-16 22:25:00 (15984): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-16 22:25:03 (15984): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-16 22:25:04 (15984): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-16 22:25:06 (15984): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-16 22:25:09 (15984): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-16 22:25:10 (15984): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2023-11-16 22:25:10 (15984): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-16 22:25:11 (15984): Guest Log: [INFO] Reading volunteer information 2023-11-16 22:25:19 (15984): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-16 22:25:23 (15984): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-16 22:25:26 (15984): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-16 22:25:28 (15984): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-16 22:25:29 (15984): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-16 23:11:36 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:11:46 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 23:17:26 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:17:36 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 23:21:27 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:21:37 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 23:24:57 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:25:07 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 23:39:29 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:39:39 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 23:41:49 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:41:59 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 23:49:20 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:49:50 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-16 23:53:50 (15984): VM state change detected. (old = 'running', new = 'paused') 2023-11-16 23:54:10 (15984): VM state change detected. (old = 'paused', new = 'running') 2023-11-17 00:03:56 (15984): Status Report: Job Duration: '64800.000000' 2023-11-17 00:03:56 (15984): Status Report: Elapsed Time: '6000.000000' 2023-11-17 00:03:56 (15984): Status Report: CPU Time: '3592.015625' 2023-11-17 08:27:03 (17224): Detected: vboxwrapper 26206 2023-11-17 08:27:03 (17224): Detected: BOINC client v7.16.11 2023-11-17 08:27:04 (17224): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-11-17 08:27:04 (17224): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-11-17 08:27:05 (17224): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-17 08:27:05 (17224): Guest Log: CPUID EDX: 0x178bfbff 2023-11-17 08:27:05 (17224): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-17 08:27:05 (17224): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-17 08:27:05 (17224): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-17 08:27:05 (17224): Guest Log: BIOS: Booting from Hard Disk... 2023-11-17 08:27:05 (17224): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-17 08:27:05 (17224): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-17 08:27:05 (17224): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-17 08:27:05 (17224): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-17 08:27:05 (17224): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.000466 main Log opened 2023-11-16T21:22:19.989390000Z 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.003229 main OS Product: Linux 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.003524 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.003704 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.003863 main Executable: /usr/sbin/VBoxService 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.003868 main Process ID: 2174 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.003872 main Package type: LINUX_64BITS_GENERIC 2023-11-17 08:27:05 (17224): Guest Log: 00:00:00.061881 main 5.2.6 r120293 started. Verbose level = 0 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Mounting the shared directory 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to cern.ch 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to VCCS 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to HTCondor 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to WMAgent 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Testing connection to Frontier 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-17 08:27:05 (17224): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-17 08:27:05 (17224): Guest Log: [INFO] This makes the application less efficient 2023-11-17 08:27:05 (17224): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Advice can be found in the project forum 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-17 08:27:05 (17224): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Reading volunteer information 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-17 08:27:05 (17224): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-17 08:27:05 (17224): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-17 08:27:05 (17224): Starting VM using VBoxManage interface. (boinc_85fb5cc4b6d1be08, slot#0) 2023-11-17 08:27:09 (17224): Successfully started VM. (PID = '5544') 2023-11-17 08:27:09 (17224): Reporting VM Process ID to BOINC. 2023-11-17 08:27:09 (17224): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-17 08:27:09 (17224): Guest Log: CPUID EDX: 0x178bfbff 2023-11-17 08:27:09 (17224): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-17 08:27:09 (17224): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-17 08:27:09 (17224): VM state change detected. (old = 'poweredoff', new = 'running') 2023-11-17 08:27:09 (17224): Detected: Web Application Enabled (http://localhost:52689) 2023-11-17 08:27:09 (17224): Detected: Remote Desktop Enabled (localhost:52691) 2023-11-17 08:27:09 (17224): Status Report: Job Duration: '64800.000000' 2023-11-17 08:27:09 (17224): Status Report: Elapsed Time: '7826.000000' 2023-11-17 08:27:09 (17224): Status Report: CPU Time: '4698.671875' 2023-11-17 08:27:09 (17224): Preference change detected 2023-11-17 08:27:09 (17224): Setting CPU throttle for VM. (50%) 2023-11-17 08:27:10 (17224): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-11-17 08:27:11 (17224): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-17 08:27:11 (17224): Guest Log: BIOS: Booting from Hard Disk... 2023-11-17 08:27:15 (17224): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-17 08:27:15 (17224): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-17 08:27:48 (17224): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-17 08:27:48 (17224): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-17 08:27:50 (17224): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.000146 main Log opened 2023-11-17T07:27:50.820940000Z 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.000243 main OS Product: Linux 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.000278 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.000308 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.000337 main Executable: /usr/sbin/VBoxService 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.000338 main Process ID: 2170 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.000339 main Package type: LINUX_64BITS_GENERIC 2023-11-17 08:27:50 (17224): Guest Log: 00:00:00.003592 main 5.2.6 r120293 started. Verbose level = 0 2023-11-17 08:28:16 (17224): Guest Log: [INFO] Mounting the shared directory 2023-11-17 08:28:16 (17224): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-17 08:28:17 (17224): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-17 08:28:17 (17224): Guest Log: [INFO] Testing connection to cern.ch 2023-11-17 08:28:18 (17224): Guest Log: [INFO] Testing connection to VCCS 2023-11-17 08:28:18 (17224): Guest Log: [INFO] Testing connection to HTCondor 2023-11-17 08:28:19 (17224): Guest Log: [INFO] Testing connection to WMAgent 2023-11-17 08:28:20 (17224): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-17 08:28:20 (17224): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-17 08:28:21 (17224): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-17 08:28:22 (17224): Guest Log: [INFO] Testing connection to Frontier 2023-11-17 08:28:23 (17224): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-17 08:28:24 (17224): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-17 08:28:24 (17224): VM state change detected. (old = 'running', new = 'paused') 2023-11-17 08:28:34 (17224): Guest Log: [INFO] This makes the application less efficient 2023-11-17 08:28:34 (17224): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-17 08:28:35 (17224): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-17 08:28:35 (17224): VM state change detected. (old = 'paused', new = 'running') 2023-11-17 08:28:35 (17224): Guest Log: [INFO] Advice can be found in the project forum 2023-11-17 08:28:35 (17224): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-17 08:29:11 (17224): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-17 08:29:45 (17224): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-17 08:29:46 (17224): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-17 08:29:46 (17224): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-17 08:29:47 (17224): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-17 08:29:51 (17224): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-17 08:29:51 (17224): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT 2023-11-17 08:29:51 (17224): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-17 08:29:52 (17224): Guest Log: [INFO] Reading volunteer information 2023-11-17 08:29:55 (17224): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-17 08:29:57 (17224): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-17 08:30:00 (17224): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-17 08:30:01 (17224): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-17 08:30:02 (17224): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-17 09:22:18 (17224): VM state change detected. (old = 'running', new = 'paused') 2023-11-17 09:22:28 (17224): VM state change detected. (old = 'paused', new = 'running') 2023-11-17 09:35:09 (17224): VM state change detected. (old = 'running', new = 'paused') 2023-11-17 09:35:18 (17224): VM state change detected. (old = 'paused', new = 'running') 2023-11-17 10:07:46 (17224): Status Report: Job Duration: '64800.000000' 2023-11-17 10:07:46 (17224): Status Report: Elapsed Time: '13826.000000' 2023-11-17 10:07:46 (17224): Status Report: CPU Time: '8269.156250' 2023-11-17 11:47:51 (17224): Status Report: Job Duration: '64800.000000' 2023-11-17 11:47:51 (17224): Status Report: Elapsed Time: '19826.000000' 2023-11-17 11:47:51 (17224): Status Report: CPU Time: '11887.578125' 2023-11-18 10:12:42 (15476): Detected: vboxwrapper 26206 2023-11-18 10:12:42 (15476): Detected: BOINC client v7.16.11 2023-11-18 10:12:43 (15476): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-11-18 10:12:44 (15476): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-11-18 10:12:44 (15476): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-18 10:12:44 (15476): Guest Log: CPUID EDX: 0x178bfbff 2023-11-18 10:12:44 (15476): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-18 10:12:44 (15476): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-18 10:12:44 (15476): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-18 10:12:44 (15476): Guest Log: BIOS: Booting from Hard Disk... 2023-11-18 10:12:44 (15476): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-18 10:12:44 (15476): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-18 10:12:44 (15476): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-18 10:12:44 (15476): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-18 10:12:44 (15476): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.000146 main Log opened 2023-11-17T07:27:50.820940000Z 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.000243 main OS Product: Linux 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.000278 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.000308 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.000337 main Executable: /usr/sbin/VBoxService 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.000338 main Process ID: 2170 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.000339 main Package type: LINUX_64BITS_GENERIC 2023-11-18 10:12:44 (15476): Guest Log: 00:00:00.003592 main 5.2.6 r120293 started. Verbose level = 0 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Mounting the shared directory 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to cern.ch 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to VCCS 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to HTCondor 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to WMAgent 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Testing connection to Frontier 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-18 10:12:44 (15476): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-18 10:12:44 (15476): Guest Log: [INFO] This makes the application less efficient 2023-11-18 10:12:44 (15476): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Advice can be found in the project forum 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-18 10:12:44 (15476): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Reading volunteer information 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-18 10:12:44 (15476): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-18 10:12:44 (15476): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-18 10:12:45 (15476): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-18 10:12:45 (15476): Starting VM using VBoxManage interface. (boinc_85fb5cc4b6d1be08, slot#0) 2023-11-18 10:12:52 (15476): Successfully started VM. (PID = '15768') 2023-11-18 10:12:52 (15476): Reporting VM Process ID to BOINC. 2023-11-18 10:12:52 (15476): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-18 10:12:52 (15476): Guest Log: CPUID EDX: 0x178bfbff 2023-11-18 10:12:52 (15476): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-18 10:12:52 (15476): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-18 10:12:52 (15476): VM state change detected. (old = 'poweredoff', new = 'running') 2023-11-18 10:12:52 (15476): Detected: Web Application Enabled (http://localhost:52689) 2023-11-18 10:12:52 (15476): Detected: Remote Desktop Enabled (localhost:52691) 2023-11-18 10:12:53 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 10:13:23 (15476): Status Report: Job Duration: '64800.000000' 2023-11-18 10:13:23 (15476): Status Report: Elapsed Time: '21122.000000' 2023-11-18 10:13:23 (15476): Status Report: CPU Time: '12669.078125' 2023-11-18 10:13:23 (15476): Preference change detected 2023-11-18 10:13:23 (15476): Setting CPU throttle for VM. (50%) 2023-11-18 10:13:23 (15476): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-11-18 10:13:23 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 10:13:24 (15476): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-18 10:13:24 (15476): Guest Log: BIOS: Booting from Hard Disk... 2023-11-18 10:13:27 (15476): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-18 10:13:27 (15476): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-18 10:14:03 (15476): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-18 10:14:03 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 10:14:13 (15476): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-18 10:14:13 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 10:14:14 (15476): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.000093 main Log opened 2023-11-18T09:14:05.107979000Z 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.000187 main OS Product: Linux 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.000221 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.000262 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.000292 main Executable: /usr/sbin/VBoxService 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.000293 main Process ID: 2177 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.000294 main Package type: LINUX_64BITS_GENERIC 2023-11-18 10:14:14 (15476): Guest Log: 00:00:00.004057 main 5.2.6 r120293 started. Verbose level = 0 2023-11-18 10:14:37 (15476): Guest Log: [INFO] Mounting the shared directory 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Testing connection to cern.ch 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Testing connection to VCCS 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Testing connection to HTCondor 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Testing connection to WMAgent 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-18 10:14:38 (15476): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-18 10:14:39 (15476): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-18 10:14:39 (15476): Guest Log: [INFO] Testing connection to Frontier 2023-11-18 10:14:45 (15476): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-18 10:14:46 (15476): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-18 10:14:46 (15476): Guest Log: [INFO] This makes the application less efficient 2023-11-18 10:14:46 (15476): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-18 10:14:46 (15476): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-18 10:14:46 (15476): Guest Log: [INFO] Advice can be found in the project forum 2023-11-18 10:14:46 (15476): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-18 10:15:05 (15476): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-18 10:15:18 (15476): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-18 10:15:18 (15476): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-18 10:15:19 (15476): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-18 10:15:20 (15476): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-18 10:15:21 (15476): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-18 10:15:21 (15476): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2023-11-18 10:15:21 (15476): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-18 10:15:21 (15476): Guest Log: [INFO] Reading volunteer information 2023-11-18 10:15:25 (15476): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-18 10:15:26 (15476): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-18 10:15:27 (15476): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-18 10:15:27 (15476): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-18 10:15:28 (15476): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-18 11:53:38 (15476): Status Report: Job Duration: '64800.000000' 2023-11-18 11:53:38 (15476): Status Report: Elapsed Time: '27122.558867' 2023-11-18 11:53:38 (15476): Status Report: CPU Time: '16203.875000' 2023-11-18 11:57:43 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 11:57:53 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 13:33:54 (15476): Status Report: Job Duration: '64800.000000' 2023-11-18 13:33:54 (15476): Status Report: Elapsed Time: '33122.558867' 2023-11-18 13:33:54 (15476): Status Report: CPU Time: '19812.421875' 2023-11-18 15:13:58 (15476): Status Report: Job Duration: '64800.000000' 2023-11-18 15:13:58 (15476): Status Report: Elapsed Time: '39122.558867' 2023-11-18 15:13:58 (15476): Status Report: CPU Time: '23342.984375' 2023-11-18 16:54:04 (15476): Status Report: Job Duration: '64800.000000' 2023-11-18 16:54:04 (15476): Status Report: Elapsed Time: '45122.558867' 2023-11-18 16:54:04 (15476): Status Report: CPU Time: '26952.875000' 2023-11-18 18:34:09 (15476): Status Report: Job Duration: '64800.000000' 2023-11-18 18:34:09 (15476): Status Report: Elapsed Time: '51123.386515' 2023-11-18 18:34:09 (15476): Status Report: CPU Time: '30562.281250' 2023-11-18 18:38:51 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 18:39:01 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 18:52:43 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 18:52:53 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 18:54:13 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 18:54:23 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 18:56:03 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 18:56:13 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 19:05:54 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 19:06:04 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 19:08:44 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 19:08:54 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-18 19:28:56 (15476): VM state change detected. (old = 'running', new = 'paused') 2023-11-18 19:29:06 (15476): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 10:51:42 (10048): Detected: vboxwrapper 26206 2023-11-19 10:51:42 (10048): Detected: BOINC client v7.16.11 2023-11-19 10:51:43 (10048): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-11-19 10:51:43 (10048): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-11-19 10:51:44 (10048): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-19 10:51:44 (10048): Guest Log: CPUID EDX: 0x178bfbff 2023-11-19 10:51:44 (10048): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-19 10:51:44 (10048): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-19 10:51:44 (10048): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-19 10:51:44 (10048): Guest Log: BIOS: Booting from Hard Disk... 2023-11-19 10:51:44 (10048): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-19 10:51:44 (10048): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-19 10:51:44 (10048): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-19 10:51:44 (10048): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-19 10:51:44 (10048): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.000093 main Log opened 2023-11-18T09:14:05.107979000Z 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.000187 main OS Product: Linux 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.000221 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.000262 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.000292 main Executable: /usr/sbin/VBoxService 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.000293 main Process ID: 2177 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.000294 main Package type: LINUX_64BITS_GENERIC 2023-11-19 10:51:44 (10048): Guest Log: 00:00:00.004057 main 5.2.6 r120293 started. Verbose level = 0 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Mounting the shared directory 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to cern.ch 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to VCCS 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to HTCondor 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to WMAgent 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Testing connection to Frontier 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-19 10:51:44 (10048): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-19 10:51:44 (10048): Guest Log: [INFO] This makes the application less efficient 2023-11-19 10:51:44 (10048): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Advice can be found in the project forum 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-19 10:51:44 (10048): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Reading volunteer information 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-19 10:51:44 (10048): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-19 10:51:44 (10048): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-19 10:51:44 (10048): Starting VM using VBoxManage interface. (boinc_85fb5cc4b6d1be08, slot#0) 2023-11-19 10:51:50 (10048): Successfully started VM. (PID = '1016') 2023-11-19 10:51:50 (10048): Reporting VM Process ID to BOINC. 2023-11-19 10:51:50 (10048): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-19 10:51:50 (10048): Guest Log: CPUID EDX: 0x178bfbff 2023-11-19 10:51:50 (10048): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-19 10:51:50 (10048): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-19 10:51:50 (10048): VM state change detected. (old = 'poweredoff', new = 'running') 2023-11-19 10:51:50 (10048): Detected: Web Application Enabled (http://localhost:52689) 2023-11-19 10:51:50 (10048): Detected: Remote Desktop Enabled (localhost:52691) 2023-11-19 10:51:50 (10048): Status Report: Job Duration: '64800.000000' 2023-11-19 10:51:50 (10048): Status Report: Elapsed Time: '55069.386515' 2023-11-19 10:51:50 (10048): Status Report: CPU Time: '32885.109375' 2023-11-19 10:51:50 (10048): Preference change detected 2023-11-19 10:51:50 (10048): Setting CPU throttle for VM. (50%) 2023-11-19 10:51:51 (10048): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-11-19 10:51:52 (10048): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-19 10:51:52 (10048): Guest Log: BIOS: Booting from Hard Disk... 2023-11-19 10:51:54 (10048): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-19 10:51:54 (10048): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-19 10:52:04 (10048): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 10:52:34 (10048): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 10:52:53 (10048): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 10:53:13 (10048): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 10:53:27 (10048): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-19 10:53:27 (10048): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-19 10:53:32 (10048): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.000314 main Log opened 2023-11-19T09:53:13.476120000Z 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.000574 main OS Product: Linux 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.000717 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.000827 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.002629 main Executable: /usr/sbin/VBoxService 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.002636 main Process ID: 2165 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.002638 main Package type: LINUX_64BITS_GENERIC 2023-11-19 10:53:32 (10048): Guest Log: 00:00:00.309655 main 5.2.6 r120293 started. Verbose level = 0 2023-11-19 10:54:26 (10048): Guest Log: [INFO] Mounting the shared directory 2023-11-19 10:54:26 (10048): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-19 10:54:27 (10048): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-19 10:54:27 (10048): Guest Log: [INFO] Testing connection to cern.ch 2023-11-19 10:54:28 (10048): Guest Log: [INFO] Testing connection to VCCS 2023-11-19 10:54:28 (10048): Guest Log: [INFO] Testing connection to HTCondor 2023-11-19 10:54:29 (10048): Guest Log: [INFO] Testing connection to WMAgent 2023-11-19 10:54:29 (10048): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-19 10:54:30 (10048): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-19 10:54:30 (10048): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-19 10:54:31 (10048): Guest Log: [INFO] Testing connection to Frontier 2023-11-19 10:54:32 (10048): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-19 10:54:33 (10048): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-19 10:54:33 (10048): Guest Log: [INFO] This makes the application less efficient 2023-11-19 10:54:33 (10048): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-19 10:54:34 (10048): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-19 10:54:34 (10048): Guest Log: [INFO] Advice can be found in the project forum 2023-11-19 10:54:34 (10048): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-19 10:55:16 (10048): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-19 10:55:43 (10048): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 10:55:53 (10048): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 10:55:54 (10048): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-19 10:55:55 (10048): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-19 10:55:55 (10048): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-19 10:55:58 (10048): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-19 10:56:01 (10048): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-19 10:56:02 (10048): Guest Log: [INFO] 2.7.2.0 http://s1bnl-cvmfs.openhtc.io DIRECT 2023-11-19 10:56:02 (10048): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-19 10:56:03 (10048): Guest Log: [INFO] Reading volunteer information 2023-11-19 10:56:15 (10048): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-19 10:56:16 (10048): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-19 10:56:20 (10048): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-19 10:56:21 (10048): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-19 10:56:23 (10048): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-19 10:56:33 (10048): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 10:56:43 (10048): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 11:40:31 (10048): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 11:40:39 (10048): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 11:44:19 (10048): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 11:44:29 (10048): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 15:02:36 (7968): Detected: vboxwrapper 26206 2023-11-19 15:02:36 (7968): Detected: BOINC client v7.16.11 2023-11-19 15:02:37 (7968): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-11-19 15:02:37 (7968): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-11-19 15:02:37 (7968): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-19 15:02:37 (7968): Guest Log: CPUID EDX: 0x178bfbff 2023-11-19 15:02:37 (7968): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-19 15:02:37 (7968): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-19 15:02:37 (7968): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-19 15:02:37 (7968): Guest Log: BIOS: Booting from Hard Disk... 2023-11-19 15:02:37 (7968): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-19 15:02:37 (7968): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-19 15:02:37 (7968): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-19 15:02:37 (7968): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-19 15:02:37 (7968): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.000314 main Log opened 2023-11-19T09:53:13.476120000Z 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.000574 main OS Product: Linux 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.000717 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.000827 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.002629 main Executable: /usr/sbin/VBoxService 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.002636 main Process ID: 2165 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.002638 main Package type: LINUX_64BITS_GENERIC 2023-11-19 15:02:37 (7968): Guest Log: 00:00:00.309655 main 5.2.6 r120293 started. Verbose level = 0 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Mounting the shared directory 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to cern.ch 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to VCCS 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to HTCondor 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to WMAgent 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Testing connection to Frontier 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-19 15:02:37 (7968): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-19 15:02:37 (7968): Guest Log: [INFO] This makes the application less efficient 2023-11-19 15:02:37 (7968): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Advice can be found in the project forum 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-19 15:02:37 (7968): Guest Log: [INFO] 2.7.2.0 http://s1bnl-cvmfs.openhtc.io DIRECT 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Reading volunteer information 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-19 15:02:37 (7968): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-19 15:02:37 (7968): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-19 15:02:37 (7968): Starting VM using VBoxManage interface. (boinc_85fb5cc4b6d1be08, slot#0) 2023-11-19 15:02:42 (7968): Successfully started VM. (PID = '6856') 2023-11-19 15:02:42 (7968): Reporting VM Process ID to BOINC. 2023-11-19 15:02:42 (7968): Guest Log: BIOS: VirtualBox 6.1.12 2023-11-19 15:02:42 (7968): Guest Log: CPUID EDX: 0x178bfbff 2023-11-19 15:02:42 (7968): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-11-19 15:02:42 (7968): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-11-19 15:02:42 (7968): VM state change detected. (old = 'poweredoff', new = 'running') 2023-11-19 15:02:42 (7968): Detected: Web Application Enabled (http://localhost:52689) 2023-11-19 15:02:42 (7968): Detected: Remote Desktop Enabled (localhost:52691) 2023-11-19 15:02:42 (7968): Status Report: Job Duration: '64800.000000' 2023-11-19 15:02:42 (7968): Status Report: Elapsed Time: '59808.860598' 2023-11-19 15:02:42 (7968): Status Report: CPU Time: '35708.906250' 2023-11-19 15:02:42 (7968): Preference change detected 2023-11-19 15:02:42 (7968): Setting CPU throttle for VM. (50%) 2023-11-19 15:02:42 (7968): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-11-19 15:02:44 (7968): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-11-19 15:02:44 (7968): Guest Log: BIOS: Booting from Hard Disk... 2023-11-19 15:02:47 (7968): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-11-19 15:02:47 (7968): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-11-19 15:02:58 (7968): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 15:03:08 (7968): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 15:03:34 (7968): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-11-19 15:03:34 (7968): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-11-19 15:03:38 (7968): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.000088 main Log opened 2023-11-19T14:03:38.710666000Z 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.000175 main OS Product: Linux 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.000224 main OS Release: 4.14.232-19.cernvm.x86_64 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.000253 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.000290 main Executable: /usr/sbin/VBoxService 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.000291 main Process ID: 2170 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.000292 main Package type: LINUX_64BITS_GENERIC 2023-11-19 15:03:38 (7968): Guest Log: 00:00:00.003060 main 5.2.6 r120293 started. Verbose level = 0 2023-11-19 15:04:00 (7968): Guest Log: [INFO] Mounting the shared directory 2023-11-19 15:04:00 (7968): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-11-19 15:04:00 (7968): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-11-19 15:04:00 (7968): Guest Log: [INFO] Testing connection to cern.ch 2023-11-19 15:04:00 (7968): Guest Log: [INFO] Testing connection to VCCS 2023-11-19 15:04:00 (7968): Guest Log: [INFO] Testing connection to HTCondor 2023-11-19 15:04:01 (7968): Guest Log: [INFO] Testing connection to WMAgent 2023-11-19 15:04:01 (7968): Guest Log: [INFO] Testing connection to EOSCMS 2023-11-19 15:04:01 (7968): Guest Log: [INFO] Testing connection to CMS-Factory 2023-11-19 15:04:01 (7968): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-11-19 15:04:02 (7968): Guest Log: [INFO] Testing connection to Frontier 2023-11-19 15:04:03 (7968): Guest Log: [INFO] Could not find a local HTTP proxy 2023-11-19 15:04:03 (7968): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-11-19 15:04:03 (7968): Guest Log: [INFO] This makes the application less efficient 2023-11-19 15:04:03 (7968): Guest Log: [INFO] It also puts higher load on the project servers 2023-11-19 15:04:03 (7968): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-11-19 15:04:03 (7968): Guest Log: [INFO] Advice can be found in the project forum 2023-11-19 15:04:04 (7968): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-11-19 15:04:20 (7968): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-11-19 15:04:37 (7968): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-11-19 15:04:37 (7968): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-11-19 15:04:38 (7968): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-11-19 15:04:38 (7968): VM state change detected. (old = 'running', new = 'paused') 2023-11-19 15:04:58 (7968): VM state change detected. (old = 'paused', new = 'running') 2023-11-19 15:04:59 (7968): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-11-19 15:05:00 (7968): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-11-19 15:05:00 (7968): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2023-11-19 15:05:00 (7968): Guest Log: [INFO] Environment HTTP proxy: not set 2023-11-19 15:05:01 (7968): Guest Log: [INFO] Reading volunteer information 2023-11-19 15:05:02 (7968): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-11-19 15:05:03 (7968): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-11-19 15:05:04 (7968): Guest Log: [INFO] CMS application starting. Check log files. 2023-11-19 15:05:04 (7968): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-11-19 15:05:05 (7968): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-11-19 16:26:33 (7968): Powering off VM. 2023-11-19 16:26:34 (7968): Successfully stopped VM. 2023-11-19 16:26:34 (7968): Deregistering VM. (boinc_85fb5cc4b6d1be08, slot#0) 2023-11-19 16:26:34 (7968): Removing network bandwidth throttle group from VM. 2023-11-19 16:26:34 (7968): Removing VM from VirtualBox. 16:26:40 (7968): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN