Name | CMS_1301991_1652222352.778344_0 |
Workunit | 2182912 |
Created | 10 May 2022, 22:39:15 UTC |
Sent | 12 May 2022, 8:22:50 UTC |
Report deadline | 19 May 2022, 8:22:50 UTC |
Received | 30 May 2022, 9:10:04 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 4441 |
Run time | 18 hours 2 min 41 sec |
CPU time | 10 hours 41 min 9 sec |
Validate state | Valid |
Credit | 1,960.47 |
Device peak FLOPS | 3.54 GFLOPS |
Application version | CMS Simulation v60.55 (vbox64_mt_mcore_cms) windows_x86_64 |
Peak working set size | 66.83 MB |
Peak swap size | 87.59 MB |
Peak disk usage | 4.97 GB |
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> ch 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Testing connection to cern.ch 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Testing connection to VCCS 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Testing connection to HTCondor 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Testing connection to WMAgent 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Testing connection to Frontier 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov} 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-26 07:31:35 (11004): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Reading volunteer information 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-26 07:31:35 (11004): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-26 07:31:35 (11004): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-26 07:31:35 (11004): Guest Log: 02:30:07.415023 timesync vgsvcTimeSyncWorker: Radical host time change: 8 340 228 000 000ns (HostNow=1 653 488 188 443 000 000 ns HostLast=1 653 479 848 215 000 000 ns) 2022-05-26 07:31:35 (11004): Guest Log: 02:30:17.417973 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 362 270 453 000ns (GuestNow=1 653 488 198 675 557 000 ns GuestLast=1 653 479 836 405 104 000 ns fSetTimeLastLoop=true ) 2022-05-26 07:31:35 (11004): Starting VM using VBoxManage interface. (boinc_ba3a76779ec8105d, slot#4) 2022-05-26 07:31:41 (11004): Successfully started VM. (PID = '11884') 2022-05-26 07:31:41 (11004): Reporting VM Process ID to BOINC. 2022-05-26 07:31:41 (11004): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-26 07:31:41 (11004): Guest Log: CPUID EDX: 0x178bfbff 2022-05-26 07:31:41 (11004): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-26 07:31:41 (11004): VM state change detected. (old = 'poweredoff', new = 'running') 2022-05-26 07:31:41 (11004): Detected: Web Application Enabled (http://localhost:52215) 2022-05-26 07:31:41 (11004): Detected: Remote Desktop Enabled (localhost:52216) 2022-05-26 07:31:41 (11004): Status Report: Job Duration: '64800.000000' 2022-05-26 07:31:41 (11004): Status Report: Elapsed Time: '24256.000000' 2022-05-26 07:31:41 (11004): Status Report: CPU Time: '14182.234375' 2022-05-26 07:31:41 (11004): Preference change detected 2022-05-26 07:31:41 (11004): Setting CPU throttle for VM. (50%) 2022-05-26 07:31:41 (11004): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-05-26 07:31:43 (11004): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-26 07:31:43 (11004): Guest Log: BIOS: Booting from Hard Disk... 2022-05-26 07:31:44 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 07:32:05 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 07:32:06 (11004): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-26 07:32:06 (11004): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-26 07:32:38 (11004): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-26 07:32:38 (11004): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-26 07:32:42 (11004): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.000276 main Log opened 2022-05-26T05:32:41.813793000Z 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.000450 main OS Product: Linux 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.000547 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.000704 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.000799 main Executable: /usr/sbin/VBoxService 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.000803 main Process ID: 2167 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.000805 main Package type: LINUX_64BITS_GENERIC 2022-05-26 07:32:42 (11004): Guest Log: 00:00:00.006811 main 5.2.6 r120293 started. Verbose level = 0 2022-05-26 07:33:34 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 07:33:54 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 07:33:55 (11004): Guest Log: [INFO] Mounting the shared directory 2022-05-26 07:33:55 (11004): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-26 07:33:56 (11004): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-26 07:33:56 (11004): Guest Log: [INFO] Testing connection to cern.ch 2022-05-26 07:33:57 (11004): Guest Log: [INFO] Testing connection to VCCS 2022-05-26 07:33:57 (11004): Guest Log: [INFO] Testing connection to HTCondor 2022-05-26 07:33:58 (11004): Guest Log: [INFO] Testing connection to WMAgent 2022-05-26 07:33:58 (11004): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-26 07:33:58 (11004): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-26 07:33:59 (11004): Guest Log: [INFO] Testing connection to Frontier 2022-05-26 07:34:00 (11004): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-26 07:34:01 (11004): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-26 07:34:01 (11004): Guest Log: [INFO] This makes the application less efficient 2022-05-26 07:34:01 (11004): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-26 07:34:01 (11004): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-26 07:34:02 (11004): Guest Log: [INFO] Advice can be found in the project forum 2022-05-26 07:34:02 (11004): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-26 07:34:40 (11004): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-26 07:34:48 (11004): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-26 07:35:15 (11004): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-26 07:35:18 (11004): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-26 07:35:18 (11004): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-26 07:35:19 (11004): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-26 07:35:23 (11004): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-26 07:35:23 (11004): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-05-26 07:35:24 (11004): Guest Log: [INFO] Reading volunteer information 2022-05-26 07:35:29 (11004): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-26 07:35:32 (11004): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-26 07:35:35 (11004): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-26 07:40:26 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 07:40:35 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 07:44:16 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 07:44:26 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 07:46:16 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 07:46:26 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 07:51:06 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 07:52:37 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 08:26:30 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 08:26:40 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 08:27:30 (11004): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 08:27:40 (11004): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 21:33:03 (14636): Detected: vboxwrapper 26202 2022-05-26 21:33:03 (14636): Detected: BOINC client v7.16.11 2022-05-26 21:33:04 (14636): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-05-26 21:33:05 (14636): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-05-26 21:33:05 (14636): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-26 21:33:05 (14636): Guest Log: CPUID EDX: 0x178bfbff 2022-05-26 21:33:05 (14636): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-26 21:33:05 (14636): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-26 21:33:05 (14636): Guest Log: BIOS: Booting from Hard Disk... 2022-05-26 21:33:05 (14636): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-26 21:33:05 (14636): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-26 21:33:05 (14636): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-26 21:33:05 (14636): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-26 21:33:05 (14636): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.000276 main Log opened 2022-05-26T05:32:41.813793000Z 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.000450 main OS Product: Linux 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.000547 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.000704 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.000799 main Executable: /usr/sbin/VBoxService 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.000803 main Process ID: 2167 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.000805 main Package type: LINUX_64BITS_GENERIC 2022-05-26 21:33:05 (14636): Guest Log: 00:00:00.006811 main 5.2.6 r120293 started. Verbose level = 0 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Mounting the shared directory 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Testing connection to cern.ch 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Testing connection to VCCS 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Testing connection to HTCondor 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Testing connection to WMAgent 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Testing connection to Frontier 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-26 21:33:05 (14636): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-26 21:33:05 (14636): Guest Log: [INFO] This makes the application less efficient 2022-05-26 21:33:05 (14636): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Advice can be found in the project forum 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-26 21:33:05 (14636): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Reading volunteer information 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-26 21:33:05 (14636): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-26 21:33:05 (14636): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-26 21:33:05 (14636): Starting VM using VBoxManage interface. (boinc_ba3a76779ec8105d, slot#4) 2022-05-26 21:33:11 (14636): Successfully started VM. (PID = '16284') 2022-05-26 21:33:11 (14636): Reporting VM Process ID to BOINC. 2022-05-26 21:33:11 (14636): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-26 21:33:11 (14636): Guest Log: CPUID EDX: 0x178bfbff 2022-05-26 21:33:11 (14636): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-26 21:33:11 (14636): VM state change detected. (old = 'poweredoff', new = 'running') 2022-05-26 21:33:11 (14636): Detected: Web Application Enabled (http://localhost:52215) 2022-05-26 21:33:11 (14636): Detected: Remote Desktop Enabled (localhost:52216) 2022-05-26 21:33:11 (14636): Status Report: Job Duration: '64800.000000' 2022-05-26 21:33:11 (14636): Status Report: Elapsed Time: '27432.000000' 2022-05-26 21:33:11 (14636): Status Report: CPU Time: '16075.171875' 2022-05-26 21:33:11 (14636): Preference change detected 2022-05-26 21:33:11 (14636): Setting CPU throttle for VM. (50%) 2022-05-26 21:33:11 (14636): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-05-26 21:33:13 (14636): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-26 21:33:13 (14636): Guest Log: BIOS: Booting from Hard Disk... 2022-05-26 21:33:15 (14636): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-26 21:33:15 (14636): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-26 21:33:54 (14636): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-26 21:33:54 (14636): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-26 21:33:58 (14636): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.000458 main Log opened 2022-05-26T19:33:59.035381000Z 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.002525 main OS Product: Linux 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.002748 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.002953 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.003084 main Executable: /usr/sbin/VBoxService 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.003088 main Process ID: 2163 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.003144 main Package type: LINUX_64BITS_GENERIC 2022-05-26 21:33:58 (14636): Guest Log: 00:00:00.013423 main 5.2.6 r120293 started. Verbose level = 0 2022-05-26 21:34:25 (14636): VM state change detected. (old = 'running', new = 'paused') 2022-05-26 21:35:25 (14636): VM state change detected. (old = 'paused', new = 'running') 2022-05-26 21:35:51 (14636): Guest Log: [INFO] Mounting the shared directory 2022-05-26 21:35:52 (14636): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-26 21:35:52 (14636): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-26 21:35:53 (14636): Guest Log: [INFO] Testing connection to cern.ch 2022-05-26 21:35:53 (14636): Guest Log: [INFO] Testing connection to VCCS 2022-05-26 21:35:54 (14636): Guest Log: [INFO] Testing connection to HTCondor 2022-05-26 21:35:54 (14636): Guest Log: [INFO] Testing connection to WMAgent 2022-05-26 21:35:54 (14636): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-26 21:35:55 (14636): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-26 21:35:56 (14636): Guest Log: [INFO] Testing connection to Frontier 2022-05-26 21:35:57 (14636): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-26 21:35:57 (14636): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-26 21:35:58 (14636): Guest Log: [INFO] This makes the application less efficient 2022-05-26 21:35:58 (14636): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-26 21:35:58 (14636): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-26 21:35:59 (14636): Guest Log: [INFO] Advice can be found in the project forum 2022-05-26 21:35:59 (14636): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-27 00:02:25 (14280): Detected: vboxwrapper 26202 2022-05-27 00:02:25 (14280): Detected: BOINC client v7.16.11 2022-05-27 00:02:26 (14280): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-05-27 00:02:26 (14280): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-05-27 00:02:27 (14280): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-27 00:02:27 (14280): Guest Log: CPUID EDX: 0x178bfbff 2022-05-27 00:02:27 (14280): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-27 00:02:27 (14280): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-27 00:02:27 (14280): Guest Log: BIOS: Booting from Hard Disk... 2022-05-27 00:02:27 (14280): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-27 00:02:27 (14280): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-27 00:02:27 (14280): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-27 00:02:27 (14280): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-27 00:02:27 (14280): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.000458 main Log opened 2022-05-26T19:33:59.035381000Z 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.002525 main OS Product: Linux 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.002748 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.002953 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.003084 main Executable: /usr/sbin/VBoxService 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.003088 main Process ID: 2163 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.003144 main Package type: LINUX_64BITS_GENERIC 2022-05-27 00:02:27 (14280): Guest Log: 00:00:00.013423 main 5.2.6 r120293 started. Verbose level = 0 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Mounting the shared directory 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Testing connection to cern.ch 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Testing connection to VCCS 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Testing connection to HTCondor 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Testing connection to WMAgent 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Testing connection to Frontier 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-27 00:02:27 (14280): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-27 00:02:27 (14280): Guest Log: [INFO] This makes the application less efficient 2022-05-27 00:02:27 (14280): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Advice can be found in the project forum 2022-05-27 00:02:27 (14280): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-27 00:02:27 (14280): Starting VM using VBoxManage interface. (boinc_ba3a76779ec8105d, slot#4) 2022-05-27 00:02:33 (14280): Successfully started VM. (PID = '15744') 2022-05-27 00:02:33 (14280): Reporting VM Process ID to BOINC. 2022-05-27 00:02:33 (14280): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-27 00:02:33 (14280): Guest Log: CPUID EDX: 0x178bfbff 2022-05-27 00:02:33 (14280): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-27 00:02:33 (14280): VM state change detected. (old = 'poweredoff', new = 'running') 2022-05-27 00:02:33 (14280): Detected: Web Application Enabled (http://localhost:52215) 2022-05-27 00:02:33 (14280): Detected: Remote Desktop Enabled (localhost:52216) 2022-05-27 00:02:33 (14280): Status Report: Job Duration: '64800.000000' 2022-05-27 00:02:33 (14280): Status Report: Elapsed Time: '27562.000000' 2022-05-27 00:02:33 (14280): Status Report: CPU Time: '16140.296875' 2022-05-27 00:02:33 (14280): Preference change detected 2022-05-27 00:02:33 (14280): Setting CPU throttle for VM. (50%) 2022-05-27 00:02:33 (14280): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-05-27 00:02:35 (14280): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-27 00:02:35 (14280): Guest Log: BIOS: Booting from Hard Disk... 2022-05-27 00:02:36 (14280): VM state change detected. (old = 'running', new = 'paused') 2022-05-27 00:03:17 (14280): VM state change detected. (old = 'paused', new = 'running') 2022-05-27 00:03:18 (14280): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-27 00:03:18 (14280): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-27 00:03:57 (14280): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-27 00:03:57 (14280): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-27 00:04:02 (14280): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.000278 main Log opened 2022-05-26T22:04:01.814635000Z 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.000484 main OS Product: Linux 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.000566 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.000645 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.000747 main Executable: /usr/sbin/VBoxService 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.000750 main Process ID: 2165 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.000753 main Package type: LINUX_64BITS_GENERIC 2022-05-27 00:04:02 (14280): Guest Log: 00:00:00.005985 main 5.2.6 r120293 started. Verbose level = 0 2022-05-27 00:04:52 (14280): Guest Log: [INFO] Mounting the shared directory 2022-05-27 00:04:52 (14280): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-27 00:04:52 (14280): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-27 00:04:53 (14280): Guest Log: [INFO] Testing connection to cern.ch 2022-05-27 00:04:54 (14280): Guest Log: [INFO] Testing connection to VCCS 2022-05-27 00:04:54 (14280): Guest Log: [INFO] Testing connection to HTCondor 2022-05-27 00:04:55 (14280): Guest Log: [INFO] Testing connection to WMAgent 2022-05-27 00:04:56 (14280): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-27 00:04:56 (14280): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-27 00:04:57 (14280): Guest Log: [INFO] Testing connection to Frontier 2022-05-27 00:04:59 (14280): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-27 00:04:59 (14280): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-27 00:05:00 (14280): Guest Log: [INFO] This makes the application less efficient 2022-05-27 00:05:00 (14280): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-27 00:05:00 (14280): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-27 00:05:01 (14280): Guest Log: [INFO] Advice can be found in the project forum 2022-05-27 00:05:01 (14280): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-27 00:05:44 (14280): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-27 00:05:51 (14280): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-27 00:06:31 (14280): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-27 00:06:33 (14280): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-27 00:06:35 (14280): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-27 00:06:37 (14280): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-27 00:06:40 (14280): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-27 00:06:41 (14280): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-05-27 00:06:42 (14280): Guest Log: [INFO] Reading volunteer information 2022-05-27 00:06:48 (14280): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-27 00:06:50 (14280): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-27 00:06:53 (14280): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-27 00:28:19 (14280): VM state change detected. (old = 'running', new = 'paused') 2022-05-27 00:28:29 (14280): VM state change detected. (old = 'paused', new = 'running') 2022-05-27 00:34:10 (14280): VM state change detected. (old = 'running', new = 'paused') 2022-05-27 15:21:27 (1508): Detected: vboxwrapper 26202 2022-05-27 15:21:27 (1508): Detected: BOINC client v7.16.11 2022-05-27 15:21:29 (1508): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-05-27 15:21:29 (1508): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-05-27 15:21:30 (1508): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-27 15:21:30 (1508): Guest Log: CPUID EDX: 0x178bfbff 2022-05-27 15:21:30 (1508): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-27 15:21:30 (1508): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-27 15:21:30 (1508): Guest Log: BIOS: Booting from Hard Disk... 2022-05-27 15:21:30 (1508): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-27 15:21:30 (1508): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-27 15:21:30 (1508): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-27 15:21:30 (1508): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-27 15:21:30 (1508): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.000278 main Log opened 2022-05-26T22:04:01.814635000Z 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.000484 main OS Product: Linux 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.000566 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.000645 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.000747 main Executable: /usr/sbin/VBoxService 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.000750 main Process ID: 2165 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.000753 main Package type: LINUX_64BITS_GENERIC 2022-05-27 15:21:30 (1508): Guest Log: 00:00:00.005985 main 5.2.6 r120293 started. Verbose level = 0 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Mounting the shared directory 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Testing connection to cern.ch 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Testing connection to VCCS 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Testing connection to HTCondor 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Testing connection to WMAgent 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Testing connection to Frontier 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-27 15:21:30 (1508): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-27 15:21:30 (1508): Guest Log: [INFO] This makes the application less efficient 2022-05-27 15:21:30 (1508): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Advice can be found in the project forum 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-27 15:21:30 (1508): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Reading volunteer information 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-27 15:21:30 (1508): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-27 15:21:30 (1508): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-27 15:21:30 (1508): Starting VM using VBoxManage interface. (boinc_ba3a76779ec8105d, slot#4) 2022-05-27 15:21:38 (1508): Successfully started VM. (PID = '12512') 2022-05-27 15:21:38 (1508): Reporting VM Process ID to BOINC. 2022-05-27 15:21:38 (1508): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-27 15:21:38 (1508): Guest Log: CPUID EDX: 0x178bfbff 2022-05-27 15:21:38 (1508): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-27 15:21:38 (1508): VM state change detected. (old = 'poweredoff', new = 'running') 2022-05-27 15:21:38 (1508): Detected: Web Application Enabled (http://localhost:52215) 2022-05-27 15:21:38 (1508): Detected: Remote Desktop Enabled (localhost:52216) 2022-05-27 15:21:40 (1508): VM state change detected. (old = 'running', new = 'paused') 2022-05-27 15:22:08 (1508): Status Report: Job Duration: '64800.000000' 2022-05-27 15:22:08 (1508): Status Report: Elapsed Time: '29379.000000' 2022-05-27 15:22:08 (1508): Status Report: CPU Time: '17228.671875' 2022-05-27 15:22:08 (1508): Preference change detected 2022-05-27 15:22:08 (1508): Setting CPU throttle for VM. (50%) 2022-05-27 15:22:08 (1508): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-05-27 15:22:09 (1508): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-27 15:22:09 (1508): Guest Log: BIOS: Booting from Hard Disk... 2022-05-27 15:22:09 (1508): VM state change detected. (old = 'paused', new = 'running') 2022-05-27 15:22:12 (1508): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-27 15:22:12 (1508): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-27 15:22:41 (1508): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-27 15:22:41 (1508): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-27 15:22:44 (1508): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.000146 main Log opened 2022-05-27T13:22:43.694937000Z 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.000636 main OS Product: Linux 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.000690 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.000729 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.000762 main Executable: /usr/sbin/VBoxService 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.000763 main Process ID: 2162 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.000764 main Package type: LINUX_64BITS_GENERIC 2022-05-27 15:22:44 (1508): Guest Log: 00:00:00.003581 main 5.2.6 r120293 started. Verbose level = 0 2022-05-27 15:23:10 (1508): Guest Log: [INFO] Mounting the shared directory 2022-05-27 15:23:11 (1508): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-27 15:23:11 (1508): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-27 15:23:11 (1508): Guest Log: [INFO] Testing connection to cern.ch 2022-05-27 15:23:11 (1508): Guest Log: [INFO] Testing connection to VCCS 2022-05-27 15:23:12 (1508): Guest Log: [INFO] Testing connection to HTCondor 2022-05-27 15:23:12 (1508): Guest Log: [INFO] Testing connection to WMAgent 2022-05-27 15:23:12 (1508): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-27 15:23:13 (1508): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-27 15:23:13 (1508): Guest Log: [INFO] Testing connection to Frontier 2022-05-27 15:23:14 (1508): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov} 2022-05-27 15:23:15 (1508): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier 2022-05-27 15:23:15 (1508): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-27 15:23:19 (1508): VM state change detected. (old = 'running', new = 'paused') 2022-05-27 15:23:39 (1508): VM state change detected. (old = 'paused', new = 'running') 2022-05-27 15:23:49 (1508): VM state change detected. (old = 'running', new = 'paused') 2022-05-27 15:23:59 (1508): VM state change detected. (old = 'paused', new = 'running') 2022-05-27 15:24:07 (1508): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-27 15:24:08 (1508): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-27 15:24:24 (1508): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-27 15:24:24 (1508): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-27 15:24:25 (1508): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-27 15:24:33 (1508): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-27 15:24:34 (1508): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-27 15:24:34 (1508): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2022-05-27 15:24:35 (1508): Guest Log: [INFO] Reading volunteer information 2022-05-27 15:24:37 (1508): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-27 15:24:38 (1508): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-27 15:24:49 (1508): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-27 16:40:14 (1508): VM state change detected. (old = 'running', new = 'paused') 2022-05-27 16:40:24 (1508): VM state change detected. (old = 'paused', new = 'running') 2022-05-27 17:02:59 (1508): Status Report: Job Duration: '64800.000000' 2022-05-27 17:02:59 (1508): Status Report: Elapsed Time: '35379.966875' 2022-05-27 17:02:59 (1508): Status Report: CPU Time: '20795.656250' 2022-05-29 15:14:49 (10812): Detected: vboxwrapper 26202 2022-05-29 15:14:49 (10812): Detected: BOINC client v7.16.11 2022-05-29 15:14:50 (10812): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-05-29 15:14:50 (10812): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-05-29 15:14:51 (10812): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-29 15:14:51 (10812): Guest Log: CPUID EDX: 0x178bfbff 2022-05-29 15:14:51 (10812): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-29 15:14:51 (10812): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-29 15:14:51 (10812): Guest Log: BIOS: Booting from Hard Disk... 2022-05-29 15:14:51 (10812): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-29 15:14:51 (10812): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-29 15:14:51 (10812): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-29 15:14:51 (10812): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-29 15:14:51 (10812): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.000146 main Log opened 2022-05-27T13:22:43.694937000Z 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.000636 main OS Product: Linux 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.000690 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.000729 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.000762 main Executable: /usr/sbin/VBoxService 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.000763 main Process ID: 2162 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.000764 main Package type: LINUX_64BITS_GENERIC 2022-05-29 15:14:51 (10812): Guest Log: 00:00:00.003581 main 5.2.6 r120293 started. Verbose level = 0 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Mounting the shared directory 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Testing connection to cern.ch 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Testing connection to VCCS 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Testing connection to HTCondor 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Testing connection to WMAgent 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Testing connection to Frontier 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov} 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-29 15:14:51 (10812): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Reading volunteer information 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-29 15:14:51 (10812): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-29 15:14:51 (10812): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-29 15:14:51 (10812): Starting VM using VBoxManage interface. (boinc_ba3a76779ec8105d, slot#4) 2022-05-29 15:14:56 (10812): Successfully started VM. (PID = '11444') 2022-05-29 15:14:56 (10812): Reporting VM Process ID to BOINC. 2022-05-29 15:14:56 (10812): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-29 15:14:56 (10812): Guest Log: CPUID EDX: 0x178bfbff 2022-05-29 15:14:56 (10812): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-29 15:14:56 (10812): VM state change detected. (old = 'poweredoff', new = 'running') 2022-05-29 15:14:56 (10812): Detected: Web Application Enabled (http://localhost:52215) 2022-05-29 15:14:56 (10812): Detected: Remote Desktop Enabled (localhost:52216) 2022-05-29 15:14:56 (10812): Status Report: Job Duration: '64800.000000' 2022-05-29 15:14:56 (10812): Status Report: Elapsed Time: '39550.966875' 2022-05-29 15:14:56 (10812): Status Report: CPU Time: '23307.546875' 2022-05-29 15:14:56 (10812): Preference change detected 2022-05-29 15:14:56 (10812): Setting CPU throttle for VM. (50%) 2022-05-29 15:14:56 (10812): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-05-29 15:14:58 (10812): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-29 15:14:58 (10812): Guest Log: BIOS: Booting from Hard Disk... 2022-05-29 15:15:00 (10812): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-29 15:15:00 (10812): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-29 15:15:12 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 15:15:30 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 15:15:56 (10812): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-29 15:15:56 (10812): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-29 15:16:02 (10812): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.000151 main Log opened 2022-05-29T13:16:01.747384000Z 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.000708 main OS Product: Linux 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.000862 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.000937 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.001023 main Executable: /usr/sbin/VBoxService 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.001025 main Process ID: 2168 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.001027 main Package type: LINUX_64BITS_GENERIC 2022-05-29 15:16:02 (10812): Guest Log: 00:00:00.188392 main 5.2.6 r120293 started. Verbose level = 0 2022-05-29 15:16:41 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 15:18:11 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 15:18:20 (10812): Guest Log: [INFO] Mounting the shared directory 2022-05-29 15:18:21 (10812): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-29 15:18:21 (10812): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-29 15:18:21 (10812): Guest Log: [INFO] Testing connection to cern.ch 2022-05-29 15:18:22 (10812): Guest Log: [INFO] Testing connection to VCCS 2022-05-29 15:18:22 (10812): Guest Log: [INFO] Testing connection to HTCondor 2022-05-29 15:18:23 (10812): Guest Log: [INFO] Testing connection to WMAgent 2022-05-29 15:18:23 (10812): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-29 15:18:24 (10812): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-29 15:18:24 (10812): Guest Log: [INFO] Testing connection to Frontier 2022-05-29 15:18:26 (10812): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-29 15:18:26 (10812): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-29 15:18:27 (10812): Guest Log: [INFO] This makes the application less efficient 2022-05-29 15:18:27 (10812): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-29 15:18:27 (10812): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-29 15:18:27 (10812): Guest Log: [INFO] Advice can be found in the project forum 2022-05-29 15:18:28 (10812): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-29 15:18:31 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 15:18:41 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 15:19:14 (10812): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-29 15:19:19 (10812): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-29 15:19:41 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 15:21:01 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 15:21:04 (10812): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-29 15:21:04 (10812): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-29 15:21:06 (10812): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-29 15:21:07 (10812): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-29 15:21:09 (10812): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-29 15:21:10 (10812): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-05-29 15:21:10 (10812): Guest Log: [INFO] Reading volunteer information 2022-05-29 15:21:11 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 15:21:21 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 15:21:27 (10812): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-29 15:21:28 (10812): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-29 15:21:31 (10812): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-29 15:22:51 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 15:23:11 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 15:25:42 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 15:25:52 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 16:41:10 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 16:41:20 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 16:43:10 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 16:43:20 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 16:46:10 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 16:46:20 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 16:47:00 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 16:47:10 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 16:59:54 (10812): Status Report: Job Duration: '64800.000000' 2022-05-29 16:59:54 (10812): Status Report: Elapsed Time: '45551.311327' 2022-05-29 16:59:54 (10812): Status Report: CPU Time: '26897.312500' 2022-05-29 17:02:52 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 17:03:02 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 17:59:19 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 17:59:29 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 17:59:49 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 17:59:59 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 18:00:19 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 18:00:29 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 18:03:29 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 18:03:39 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 18:33:41 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 18:33:51 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 18:41:15 (10812): Status Report: Job Duration: '64800.000000' 2022-05-29 18:41:15 (10812): Status Report: Elapsed Time: '51551.311327' 2022-05-29 18:41:15 (10812): Status Report: CPU Time: '30513.546875' 2022-05-29 18:46:01 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 18:46:11 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 18:46:51 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 18:47:01 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 18:54:52 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 18:55:02 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 18:55:12 (10812): VM state change detected. (old = 'running', new = 'paused') 2022-05-29 18:55:22 (10812): VM state change detected. (old = 'paused', new = 'running') 2022-05-29 20:22:05 (10812): Status Report: Job Duration: '64800.000000' 2022-05-29 20:22:05 (10812): Status Report: Elapsed Time: '57551.311327' 2022-05-29 20:22:05 (10812): Status Report: CPU Time: '34122.765625' 2022-05-30 09:07:43 (11088): Detected: vboxwrapper 26202 2022-05-30 09:07:43 (11088): Detected: BOINC client v7.16.11 2022-05-30 09:07:45 (11088): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-05-30 09:07:45 (11088): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-05-30 09:07:45 (11088): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-30 09:07:45 (11088): Guest Log: CPUID EDX: 0x178bfbff 2022-05-30 09:07:45 (11088): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-30 09:07:45 (11088): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-30 09:07:45 (11088): Guest Log: BIOS: Booting from Hard Disk... 2022-05-30 09:07:45 (11088): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-30 09:07:45 (11088): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-30 09:07:45 (11088): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-30 09:07:45 (11088): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-30 09:07:45 (11088): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.000151 main Log opened 2022-05-29T13:16:01.747384000Z 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.000708 main OS Product: Linux 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.000862 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.000937 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.001023 main Executable: /usr/sbin/VBoxService 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.001025 main Process ID: 2168 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.001027 main Package type: LINUX_64BITS_GENERIC 2022-05-30 09:07:45 (11088): Guest Log: 00:00:00.188392 main 5.2.6 r120293 started. Verbose level = 0 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Mounting the shared directory 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Testing connection to cern.ch 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Testing connection to VCCS 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Testing connection to HTCondor 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Testing connection to WMAgent 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Testing connection to Frontier 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-30 09:07:45 (11088): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-30 09:07:45 (11088): Guest Log: [INFO] This makes the application less efficient 2022-05-30 09:07:45 (11088): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Advice can be found in the project forum 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-30 09:07:45 (11088): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Reading volunteer information 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-30 09:07:45 (11088): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-30 09:07:45 (11088): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-30 09:07:45 (11088): Starting VM using VBoxManage interface. (boinc_ba3a76779ec8105d, slot#4) 2022-05-30 09:07:50 (11088): Successfully started VM. (PID = '11300') 2022-05-30 09:07:50 (11088): Reporting VM Process ID to BOINC. 2022-05-30 09:07:50 (11088): Guest Log: BIOS: VirtualBox 6.1.12 2022-05-30 09:07:50 (11088): Guest Log: CPUID EDX: 0x178bfbff 2022-05-30 09:07:50 (11088): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-05-30 09:07:50 (11088): VM state change detected. (old = 'poweredoff', new = 'running') 2022-05-30 09:07:50 (11088): Detected: Web Application Enabled (http://localhost:52215) 2022-05-30 09:07:50 (11088): Detected: Remote Desktop Enabled (localhost:52216) 2022-05-30 09:07:50 (11088): Status Report: Job Duration: '64800.000000' 2022-05-30 09:07:50 (11088): Status Report: Elapsed Time: '57669.311327' 2022-05-30 09:07:50 (11088): Status Report: CPU Time: '34195.000000' 2022-05-30 09:07:50 (11088): Preference change detected 2022-05-30 09:07:50 (11088): Setting CPU throttle for VM. (50%) 2022-05-30 09:07:50 (11088): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-05-30 09:07:52 (11088): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-05-30 09:07:52 (11088): Guest Log: BIOS: Booting from Hard Disk... 2022-05-30 09:07:54 (11088): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-05-30 09:07:54 (11088): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-05-30 09:08:05 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 09:08:25 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 09:08:49 (11088): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-05-30 09:08:49 (11088): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-05-30 09:08:52 (11088): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.000221 main Log opened 2022-05-30T07:08:51.918488000Z 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.000393 main OS Product: Linux 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.000505 main OS Release: 4.14.232-19.cernvm.x86_64 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.000567 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.000622 main Executable: /usr/sbin/VBoxService 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.000623 main Process ID: 2164 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.000625 main Package type: LINUX_64BITS_GENERIC 2022-05-30 09:08:52 (11088): Guest Log: 00:00:00.005297 main 5.2.6 r120293 started. Verbose level = 0 2022-05-30 09:09:42 (11088): Guest Log: [INFO] Mounting the shared directory 2022-05-30 09:09:42 (11088): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-05-30 09:09:42 (11088): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-05-30 09:09:43 (11088): Guest Log: [INFO] Testing connection to cern.ch 2022-05-30 09:09:43 (11088): Guest Log: [INFO] Testing connection to VCCS 2022-05-30 09:09:44 (11088): Guest Log: [INFO] Testing connection to HTCondor 2022-05-30 09:09:44 (11088): Guest Log: [INFO] Testing connection to WMAgent 2022-05-30 09:09:45 (11088): Guest Log: [INFO] Testing connection to EOSCMS 2022-05-30 09:09:45 (11088): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-05-30 09:09:46 (11088): Guest Log: [INFO] Testing connection to Frontier 2022-05-30 09:09:47 (11088): Guest Log: [INFO] Could not find a local HTTP proxy 2022-05-30 09:09:47 (11088): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-05-30 09:09:47 (11088): Guest Log: [INFO] This makes the application less efficient 2022-05-30 09:09:48 (11088): Guest Log: [INFO] It also puts higher load on the project servers 2022-05-30 09:09:48 (11088): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-05-30 09:09:48 (11088): Guest Log: [INFO] Advice can be found in the project forum 2022-05-30 09:09:48 (11088): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-05-30 09:09:55 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 09:10:25 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 09:10:57 (11088): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-05-30 09:10:57 (11088): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-05-30 09:11:30 (11088): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-05-30 09:11:33 (11088): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-05-30 09:11:34 (11088): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-05-30 09:11:34 (11088): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-05-30 09:11:37 (11088): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-05-30 09:11:37 (11088): Guest Log: [INFO] 2.7.2.0 http://s1bnl-cvmfs.openhtc.io DIRECT 2022-05-30 09:11:38 (11088): Guest Log: [INFO] Reading volunteer information 2022-05-30 09:11:46 (11088): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-05-30 09:11:48 (11088): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-05-30 09:11:50 (11088): Guest Log: [INFO] CMS application starting. Check log files. 2022-05-30 09:30:48 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 09:30:57 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:00:20 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:00:30 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:02:50 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:03:00 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:05:00 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:05:10 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:07:00 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:07:10 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:08:00 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:08:10 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:08:50 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:09:00 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:09:41 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:09:51 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:10:21 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 10:10:31 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 10:50:26 (11088): Status Report: Job Duration: '64800.000000' 2022-05-30 10:50:26 (11088): Status Report: Elapsed Time: '63669.311327' 2022-05-30 10:50:26 (11088): Status Report: CPU Time: '37787.734375' 2022-05-30 11:02:56 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 11:03:06 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 11:03:56 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 11:04:06 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 11:05:36 (11088): VM state change detected. (old = 'running', new = 'paused') 2022-05-30 11:05:46 (11088): VM state change detected. (old = 'paused', new = 'running') 2022-05-30 11:09:51 (11088): Powering off VM. 2022-05-30 11:09:52 (11088): Successfully stopped VM. 2022-05-30 11:09:52 (11088): Deregistering VM. (boinc_ba3a76779ec8105d, slot#4) 2022-05-30 11:09:52 (11088): Removing network bandwidth throttle group from VM. 2022-05-30 11:09:52 (11088): Removing VM from VirtualBox. 11:09:58 (11088): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN