Name | CMS_1699465_1666865999.262951_0 |
Workunit | 2227434 |
Created | 27 Oct 2022, 10:20:04 UTC |
Sent | 29 Oct 2022, 9:23:48 UTC |
Report deadline | 5 Nov 2022, 9:23:48 UTC |
Received | 4 Aug 2023, 8:02:46 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 4441 |
Run time | 13 hours 46 min 54 sec |
CPU time | 5 hours 21 min 2 sec |
Validate state | Valid |
Credit | 475.55 |
Device peak FLOPS | 3.98 GFLOPS |
Application version | CMS Simulation v60.66 (vbox64_mt_mcore_cms) windows_x86_64 |
Peak working set size | 81.38 MB |
Peak swap size | 107.38 MB |
Peak disk usage | 1.41 GB |
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> d') 2022-10-31 10:37:10 (11180): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 10:53:51 (11180): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 10:54:01 (11180): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 13:03:45 (4616): Detected: vboxwrapper 26205 2022-10-31 13:03:45 (4616): Detected: BOINC client v7.16.11 2022-10-31 13:03:47 (4616): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-10-31 13:03:47 (4616): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-10-31 13:03:47 (4616): Guest Log: BIOS: VirtualBox 6.1.12 2022-10-31 13:03:47 (4616): Guest Log: CPUID EDX: 0x178bfbff 2022-10-31 13:03:47 (4616): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-10-31 13:03:47 (4616): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-10-31 13:03:47 (4616): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-10-31 13:03:47 (4616): Guest Log: BIOS: Booting from Hard Disk... 2022-10-31 13:03:47 (4616): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-10-31 13:03:47 (4616): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-10-31 13:03:47 (4616): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-10-31 13:03:47 (4616): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-10-31 13:03:47 (4616): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-10-31 13:03:47 (4616): Guest Log: 00:00:00.005770 main 5.2.6 r120293 started. Verbose level = 0 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Mounting the shared directory 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to cern.ch 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to VCCS 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to HTCondor 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to WMAgent 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to EOSCMS 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to CMS-Factory 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Testing connection to Frontier 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Could not find a local HTTP proxy 2022-10-31 13:03:47 (4616): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-10-31 13:03:47 (4616): Guest Log: [INFO] This makes the application less efficient 2022-10-31 13:03:47 (4616): Guest Log: [INFO] It also puts higher load on the project servers 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Advice can be found in the project forum 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-10-31 13:03:47 (4616): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Environment HTTP proxy: not set 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Reading volunteer information 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-10-31 13:03:47 (4616): Guest Log: [INFO] CMS application starting. Check log files. 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-10-31 13:03:47 (4616): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-10-31 13:03:47 (4616): Starting VM using VBoxManage interface. (boinc_6a254bf76740adb7, slot#2) 2022-10-31 13:03:52 (4616): Successfully started VM. (PID = '11532') 2022-10-31 13:03:52 (4616): Reporting VM Process ID to BOINC. 2022-10-31 13:03:52 (4616): Guest Log: BIOS: VirtualBox 6.1.12 2022-10-31 13:03:52 (4616): Guest Log: CPUID EDX: 0x178bfbff 2022-10-31 13:03:52 (4616): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-10-31 13:03:52 (4616): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-10-31 13:03:52 (4616): VM state change detected. (old = 'poweredoff', new = 'running') 2022-10-31 13:03:52 (4616): Status Report: Job Duration: '64800.000000' 2022-10-31 13:03:52 (4616): Status Report: Elapsed Time: '9877.093176' 2022-10-31 13:03:52 (4616): Status Report: CPU Time: '5882.500000' 2022-10-31 13:03:52 (4616): Preference change detected 2022-10-31 13:03:52 (4616): Setting CPU throttle for VM. (50%) 2022-10-31 13:03:52 (4616): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-10-31 13:03:54 (4616): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-10-31 13:03:54 (4616): Guest Log: BIOS: Booting from Hard Disk... 2022-10-31 13:03:57 (4616): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-10-31 13:03:57 (4616): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-10-31 13:04:07 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 13:04:17 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 13:04:40 (4616): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-10-31 13:04:40 (4616): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-10-31 13:04:42 (4616): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.000132 main Log opened 2022-10-31T12:04:41.933950000Z 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.000305 main OS Product: Linux 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.000362 main OS Release: 4.14.232-19.cernvm.x86_64 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.000417 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.000467 main Executable: /usr/sbin/VBoxService 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.000469 main Process ID: 2171 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.000470 main Package type: LINUX_64BITS_GENERIC 2022-10-31 13:04:42 (4616): Guest Log: 00:00:00.004209 main 5.2.6 r120293 started. Verbose level = 0 2022-10-31 13:05:06 (4616): Guest Log: [INFO] Mounting the shared directory 2022-10-31 13:05:07 (4616): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-10-31 13:05:07 (4616): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-10-31 13:05:07 (4616): Guest Log: [INFO] Testing connection to cern.ch 2022-10-31 13:05:07 (4616): Guest Log: [INFO] Testing connection to VCCS 2022-10-31 13:05:07 (4616): Guest Log: [INFO] Testing connection to HTCondor 2022-10-31 13:05:07 (4616): Guest Log: [INFO] Testing connection to WMAgent 2022-10-31 13:05:08 (4616): Guest Log: [INFO] Testing connection to EOSCMS 2022-10-31 13:05:08 (4616): Guest Log: [INFO] Testing connection to CMS-Factory 2022-10-31 13:05:08 (4616): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-10-31 13:05:08 (4616): Guest Log: [INFO] Testing connection to Frontier 2022-10-31 13:05:08 (4616): Guest Log: [INFO] Could not find a local HTTP proxy 2022-10-31 13:05:09 (4616): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-10-31 13:05:09 (4616): Guest Log: [INFO] This makes the application less efficient 2022-10-31 13:05:09 (4616): Guest Log: [INFO] It also puts higher load on the project servers 2022-10-31 13:05:09 (4616): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-10-31 13:05:09 (4616): Guest Log: [INFO] Advice can be found in the project forum 2022-10-31 13:05:09 (4616): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-10-31 13:05:24 (4616): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-10-31 13:05:36 (4616): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-10-31 13:05:38 (4616): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-10-31 13:05:39 (4616): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-10-31 13:05:44 (4616): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-10-31 13:05:46 (4616): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-10-31 13:05:46 (4616): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-10-31 13:05:47 (4616): Guest Log: [INFO] Environment HTTP proxy: not set 2022-10-31 13:05:47 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 13:06:07 (4616): Guest Log: [INFO] Reading volunteer information 2022-10-31 13:06:07 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 13:06:08 (4616): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-10-31 13:06:08 (4616): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-10-31 13:06:09 (4616): Guest Log: [INFO] CMS application starting. Check log files. 2022-10-31 13:06:10 (4616): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-10-31 13:06:10 (4616): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-10-31 14:07:40 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 14:07:50 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 14:21:32 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 14:21:42 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 14:44:53 (4616): Status Report: Job Duration: '64800.000000' 2022-10-31 14:44:53 (4616): Status Report: Elapsed Time: '15877.157555' 2022-10-31 14:44:53 (4616): Status Report: CPU Time: '9435.781250' 2022-10-31 14:54:13 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 14:54:23 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 15:08:24 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 15:08:34 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 15:11:34 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 15:11:44 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 16:01:16 (4616): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 16:01:26 (4616): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 19:03:55 (11620): Detected: vboxwrapper 26205 2022-10-31 19:03:55 (11620): Detected: BOINC client v7.16.11 2022-10-31 19:03:56 (11620): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-10-31 19:03:56 (11620): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-10-31 19:03:57 (11620): Guest Log: BIOS: VirtualBox 6.1.12 2022-10-31 19:03:57 (11620): Guest Log: CPUID EDX: 0x178bfbff 2022-10-31 19:03:57 (11620): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-10-31 19:03:57 (11620): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-10-31 19:03:57 (11620): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-10-31 19:03:57 (11620): Guest Log: BIOS: Booting from Hard Disk... 2022-10-31 19:03:57 (11620): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-10-31 19:03:57 (11620): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-10-31 19:03:57 (11620): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-10-31 19:03:57 (11620): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-10-31 19:03:57 (11620): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.000132 main Log opened 2022-10-31T12:04:41.933950000Z 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.000305 main OS Product: Linux 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.000362 main OS Release: 4.14.232-19.cernvm.x86_64 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.000417 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.000467 main Executable: /usr/sbin/VBoxService 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.000469 main Process ID: 2171 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.000470 main Package type: LINUX_64BITS_GENERIC 2022-10-31 19:03:57 (11620): Guest Log: 00:00:00.004209 main 5.2.6 r120293 started. Verbose level = 0 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Mounting the shared directory 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to cern.ch 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to VCCS 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to HTCondor 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to WMAgent 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to EOSCMS 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to CMS-Factory 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Testing connection to Frontier 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Could not find a local HTTP proxy 2022-10-31 19:03:57 (11620): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-10-31 19:03:57 (11620): Guest Log: [INFO] This makes the application less efficient 2022-10-31 19:03:57 (11620): Guest Log: [INFO] It also puts higher load on the project servers 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Advice can be found in the project forum 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-10-31 19:03:57 (11620): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Environment HTTP proxy: not set 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Reading volunteer information 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-10-31 19:03:57 (11620): Guest Log: [INFO] CMS application starting. Check log files. 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-10-31 19:03:57 (11620): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-10-31 19:03:57 (11620): Starting VM using VBoxManage interface. (boinc_6a254bf76740adb7, slot#2) 2022-10-31 19:04:01 (11620): Successfully started VM. (PID = '12152') 2022-10-31 19:04:01 (11620): Reporting VM Process ID to BOINC. 2022-10-31 19:04:01 (11620): Guest Log: BIOS: VirtualBox 6.1.12 2022-10-31 19:04:01 (11620): Guest Log: CPUID EDX: 0x178bfbff 2022-10-31 19:04:01 (11620): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-10-31 19:04:01 (11620): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-10-31 19:04:01 (11620): VM state change detected. (old = 'poweredoff', new = 'running') 2022-10-31 19:04:01 (11620): Status Report: Job Duration: '64800.000000' 2022-10-31 19:04:01 (11620): Status Report: Elapsed Time: '20963.157555' 2022-10-31 19:04:01 (11620): Status Report: CPU Time: '12501.171875' 2022-10-31 19:04:01 (11620): Preference change detected 2022-10-31 19:04:01 (11620): Setting CPU throttle for VM. (50%) 2022-10-31 19:04:02 (11620): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-10-31 19:04:03 (11620): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-10-31 19:04:03 (11620): Guest Log: BIOS: Booting from Hard Disk... 2022-10-31 19:04:06 (11620): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-10-31 19:04:06 (11620): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-10-31 19:04:16 (11620): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 19:04:26 (11620): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 19:04:51 (11620): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-10-31 19:04:51 (11620): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-10-31 19:04:53 (11620): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.000103 main Log opened 2022-10-31T18:04:53.096186000Z 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.000325 main OS Product: Linux 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.000421 main OS Release: 4.14.232-19.cernvm.x86_64 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.000474 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.000518 main Executable: /usr/sbin/VBoxService 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.000519 main Process ID: 2167 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.000520 main Package type: LINUX_64BITS_GENERIC 2022-10-31 19:04:53 (11620): Guest Log: 00:00:00.004092 main 5.2.6 r120293 started. Verbose level = 0 2022-10-31 19:04:56 (11620): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 19:05:06 (11620): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 19:05:24 (11620): Guest Log: [INFO] Mounting the shared directory 2022-10-31 19:05:24 (11620): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-10-31 19:05:24 (11620): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-10-31 19:05:24 (11620): Guest Log: [INFO] Testing connection to cern.ch 2022-10-31 19:05:24 (11620): Guest Log: [INFO] Testing connection to VCCS 2022-10-31 19:05:24 (11620): Guest Log: [INFO] Testing connection to HTCondor 2022-10-31 19:05:25 (11620): Guest Log: [INFO] Testing connection to WMAgent 2022-10-31 19:05:25 (11620): Guest Log: [INFO] Testing connection to EOSCMS 2022-10-31 19:05:25 (11620): Guest Log: [INFO] Testing connection to CMS-Factory 2022-10-31 19:05:25 (11620): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-10-31 19:05:25 (11620): Guest Log: [INFO] Testing connection to Frontier 2022-10-31 19:05:26 (11620): Guest Log: [INFO] Could not find a local HTTP proxy 2022-10-31 19:05:26 (11620): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-10-31 19:05:26 (11620): Guest Log: [INFO] This makes the application less efficient 2022-10-31 19:05:26 (11620): Guest Log: [INFO] It also puts higher load on the project servers 2022-10-31 19:05:26 (11620): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-10-31 19:05:26 (11620): Guest Log: [INFO] Advice can be found in the project forum 2022-10-31 19:05:27 (11620): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-10-31 19:05:43 (11620): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-10-31 19:05:56 (11620): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 19:06:17 (11620): VM state change detected. (old = 'paused', new = 'running') 2022-10-31 19:06:20 (11620): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-10-31 19:06:21 (11620): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-10-31 19:06:21 (11620): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-10-31 19:06:22 (11620): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-10-31 19:06:22 (11620): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-10-31 19:06:23 (11620): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-10-31 19:06:23 (11620): Guest Log: [INFO] Environment HTTP proxy: not set 2022-10-31 19:06:23 (11620): Guest Log: [INFO] Reading volunteer information 2022-10-31 19:06:27 (11620): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-10-31 19:06:27 (11620): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-10-31 19:06:29 (11620): Guest Log: [INFO] CMS application starting. Check log files. 2022-10-31 19:06:29 (11620): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-10-31 19:06:30 (11620): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-10-31 19:23:28 (11620): VM state change detected. (old = 'running', new = 'paused') 2022-10-31 19:23:38 (11620): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 10:41:43 (3156): Detected: vboxwrapper 26205 2022-11-01 10:41:43 (3156): Detected: BOINC client v7.16.11 2022-11-01 10:41:45 (3156): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-11-01 10:41:45 (3156): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-11-01 10:41:45 (3156): Guest Log: BIOS: VirtualBox 6.1.12 2022-11-01 10:41:45 (3156): Guest Log: CPUID EDX: 0x178bfbff 2022-11-01 10:41:45 (3156): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-11-01 10:41:45 (3156): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-11-01 10:41:45 (3156): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-11-01 10:41:45 (3156): Guest Log: BIOS: Booting from Hard Disk... 2022-11-01 10:41:45 (3156): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-11-01 10:41:45 (3156): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-11-01 10:41:45 (3156): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-11-01 10:41:45 (3156): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-11-01 10:41:45 (3156): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.000103 main Log opened 2022-10-31T18:04:53.096186000Z 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.000325 main OS Product: Linux 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.000421 main OS Release: 4.14.232-19.cernvm.x86_64 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.000474 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.000518 main Executable: /usr/sbin/VBoxService 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.000519 main Process ID: 2167 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.000520 main Package type: LINUX_64BITS_GENERIC 2022-11-01 10:41:45 (3156): Guest Log: 00:00:00.004092 main 5.2.6 r120293 started. Verbose level = 0 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Mounting the shared directory 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to cern.ch 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to VCCS 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to HTCondor 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to WMAgent 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to EOSCMS 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to CMS-Factory 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Testing connection to Frontier 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Could not find a local HTTP proxy 2022-11-01 10:41:45 (3156): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-11-01 10:41:45 (3156): Guest Log: [INFO] This makes the application less efficient 2022-11-01 10:41:45 (3156): Guest Log: [INFO] It also puts higher load on the project servers 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Advice can be found in the project forum 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-11-01 10:41:45 (3156): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Environment HTTP proxy: not set 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Reading volunteer information 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-11-01 10:41:45 (3156): Guest Log: [INFO] CMS application starting. Check log files. 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-11-01 10:41:45 (3156): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-11-01 10:41:45 (3156): Starting VM using VBoxManage interface. (boinc_6a254bf76740adb7, slot#2) 2022-11-01 10:41:53 (3156): Successfully started VM. (PID = '8720') 2022-11-01 10:41:53 (3156): Reporting VM Process ID to BOINC. 2022-11-01 10:41:53 (3156): Guest Log: BIOS: VirtualBox 6.1.12 2022-11-01 10:41:53 (3156): Guest Log: CPUID EDX: 0x178bfbff 2022-11-01 10:41:53 (3156): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-11-01 10:41:53 (3156): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-11-01 10:41:53 (3156): VM state change detected. (old = 'poweredoff', new = 'running') 2022-11-01 10:41:53 (3156): Status Report: Job Duration: '64800.000000' 2022-11-01 10:41:53 (3156): Status Report: Elapsed Time: '22309.157555' 2022-11-01 10:41:53 (3156): Status Report: CPU Time: '13258.125000' 2022-11-01 10:41:53 (3156): Preference change detected 2022-11-01 10:41:53 (3156): Setting CPU throttle for VM. (50%) 2022-11-01 10:41:55 (3156): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-11-01 10:41:55 (3156): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-11-01 10:41:55 (3156): Guest Log: BIOS: Booting from Hard Disk... 2022-11-01 10:41:58 (3156): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 10:42:25 (3156): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-11-01 10:42:25 (3156): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-11-01 10:42:25 (3156): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 10:43:05 (3156): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-11-01 10:43:05 (3156): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-11-01 10:43:10 (3156): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.000442 main Log opened 2022-11-01T09:43:09.391625000Z 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.000756 main OS Product: Linux 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.000874 main OS Release: 4.14.232-19.cernvm.x86_64 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.000974 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.001119 main Executable: /usr/sbin/VBoxService 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.001123 main Process ID: 2176 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.001125 main Package type: LINUX_64BITS_GENERIC 2022-11-01 10:43:10 (3156): Guest Log: 00:00:00.008530 main 5.2.6 r120293 started. Verbose level = 0 2022-11-01 10:44:04 (3156): Guest Log: [INFO] Mounting the shared directory 2022-11-01 10:44:04 (3156): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-11-01 10:44:05 (3156): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-11-01 10:44:05 (3156): Guest Log: [INFO] Testing connection to cern.ch 2022-11-01 10:44:06 (3156): Guest Log: [INFO] Testing connection to VCCS 2022-11-01 10:44:06 (3156): Guest Log: [INFO] Testing connection to HTCondor 2022-11-01 10:44:07 (3156): Guest Log: [INFO] Testing connection to WMAgent 2022-11-01 10:44:08 (3156): Guest Log: [INFO] Testing connection to EOSCMS 2022-11-01 10:44:08 (3156): Guest Log: [INFO] Testing connection to CMS-Factory 2022-11-01 10:44:09 (3156): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-11-01 10:44:09 (3156): Guest Log: [INFO] Testing connection to Frontier 2022-11-01 10:44:11 (3156): Guest Log: [INFO] Could not find a local HTTP proxy 2022-11-01 10:44:12 (3156): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-11-01 10:44:12 (3156): Guest Log: [INFO] This makes the application less efficient 2022-11-01 10:44:12 (3156): Guest Log: [INFO] It also puts higher load on the project servers 2022-11-01 10:44:13 (3156): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-11-01 10:44:13 (3156): Guest Log: [INFO] Advice can be found in the project forum 2022-11-01 10:44:14 (3156): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-11-01 10:44:50 (3156): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-11-01 10:45:15 (3156): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-11-01 10:45:19 (3156): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-11-01 10:45:19 (3156): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-11-01 10:45:21 (3156): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-11-01 10:45:23 (3156): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-11-01 10:45:24 (3156): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-11-01 10:45:24 (3156): Guest Log: [INFO] Environment HTTP proxy: not set 2022-11-01 10:45:27 (3156): Guest Log: [INFO] Reading volunteer information 2022-11-01 10:45:28 (3156): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-11-01 10:45:30 (3156): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-11-01 10:45:31 (3156): Guest Log: [INFO] CMS application starting. Check log files. 2022-11-01 10:45:33 (3156): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-11-01 10:45:33 (3156): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-11-01 10:51:16 (3156): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 10:51:26 (3156): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 10:52:26 (3156): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 10:52:36 (3156): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 11:18:09 (3156): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 11:18:19 (3156): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 11:51:02 (3156): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 11:51:12 (3156): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 12:23:14 (3156): Status Report: Job Duration: '64800.000000' 2022-11-01 12:23:14 (3156): Status Report: Elapsed Time: '28309.157555' 2022-11-01 12:23:14 (3156): Status Report: CPU Time: '16834.734375' 2022-11-01 12:29:55 (3156): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 12:30:05 (3156): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 22:53:50 (8700): Detected: vboxwrapper 26205 2022-11-01 22:53:50 (8700): Detected: BOINC client v7.16.11 2022-11-01 22:53:51 (8700): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-11-01 22:53:51 (8700): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-11-01 22:53:52 (8700): Guest Log: BIOS: VirtualBox 6.1.12 2022-11-01 22:53:52 (8700): Guest Log: CPUID EDX: 0x178bfbff 2022-11-01 22:53:52 (8700): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-11-01 22:53:52 (8700): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-11-01 22:53:52 (8700): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-11-01 22:53:52 (8700): Guest Log: BIOS: Booting from Hard Disk... 2022-11-01 22:53:52 (8700): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-11-01 22:53:52 (8700): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-11-01 22:53:52 (8700): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-11-01 22:53:52 (8700): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-11-01 22:53:52 (8700): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.000442 main Log opened 2022-11-01T09:43:09.391625000Z 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.000756 main OS Product: Linux 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.000874 main OS Release: 4.14.232-19.cernvm.x86_64 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.000974 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.001119 main Executable: /usr/sbin/VBoxService 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.001123 main Process ID: 2176 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.001125 main Package type: LINUX_64BITS_GENERIC 2022-11-01 22:53:52 (8700): Guest Log: 00:00:00.008530 main 5.2.6 r120293 started. Verbose level = 0 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Mounting the shared directory 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to cern.ch 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to VCCS 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to HTCondor 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to WMAgent 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to EOSCMS 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to CMS-Factory 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Testing connection to Frontier 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Could not find a local HTTP proxy 2022-11-01 22:53:52 (8700): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-11-01 22:53:52 (8700): Guest Log: [INFO] This makes the application less efficient 2022-11-01 22:53:52 (8700): Guest Log: [INFO] It also puts higher load on the project servers 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Advice can be found in the project forum 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-11-01 22:53:52 (8700): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Environment HTTP proxy: not set 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Reading volunteer information 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-11-01 22:53:52 (8700): Guest Log: [INFO] CMS application starting. Check log files. 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-11-01 22:53:52 (8700): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-11-01 22:53:52 (8700): Starting VM using VBoxManage interface. (boinc_6a254bf76740adb7, slot#2) 2022-11-01 22:54:00 (8700): Successfully started VM. (PID = '12028') 2022-11-01 22:54:00 (8700): Reporting VM Process ID to BOINC. 2022-11-01 22:54:02 (8700): Guest Log: BIOS: VirtualBox 6.1.12 2022-11-01 22:54:02 (8700): Guest Log: CPUID EDX: 0x178bfbff 2022-11-01 22:54:02 (8700): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-11-01 22:54:02 (8700): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-11-01 22:54:02 (8700): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-11-01 22:54:02 (8700): Guest Log: BIOS: Booting from Hard Disk... 2022-11-01 22:54:02 (8700): VM state change detected. (old = 'poweredoff', new = 'running') 2022-11-01 22:54:03 (8700): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-11-01 22:54:03 (8700): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-11-01 22:54:03 (8700): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 22:54:31 (8700): Status Report: Job Duration: '64800.000000' 2022-11-01 22:54:31 (8700): Status Report: Elapsed Time: '28734.157555' 2022-11-01 22:54:31 (8700): Status Report: CPU Time: '17088.421875' 2022-11-01 22:54:31 (8700): Preference change detected 2022-11-01 22:54:31 (8700): Setting CPU throttle for VM. (50%) 2022-11-01 22:54:31 (8700): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-11-01 22:54:31 (8700): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 22:55:08 (8700): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-11-01 22:55:08 (8700): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-11-01 22:55:13 (8700): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.000235 main Log opened 2022-11-01T21:55:13.307861000Z 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.000550 main OS Product: Linux 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.000652 main OS Release: 4.14.232-19.cernvm.x86_64 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.000739 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.000821 main Executable: /usr/sbin/VBoxService 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.000824 main Process ID: 2178 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.000826 main Package type: LINUX_64BITS_GENERIC 2022-11-01 22:55:13 (8700): Guest Log: 00:00:00.065996 main 5.2.6 r120293 started. Verbose level = 0 2022-11-01 22:55:53 (8700): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 22:56:42 (8700): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 22:56:50 (8700): Guest Log: [INFO] Mounting the shared directory 2022-11-01 22:56:50 (8700): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-11-01 22:56:51 (8700): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-11-01 22:56:51 (8700): Guest Log: [INFO] Testing connection to cern.ch 2022-11-01 22:56:51 (8700): Guest Log: [INFO] Testing connection to VCCS 2022-11-01 22:56:52 (8700): Guest Log: [INFO] Testing connection to HTCondor 2022-11-01 22:56:52 (8700): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 22:57:52 (8700): Guest Log: [INFO] Testing connection to WMAgent 2022-11-01 22:57:52 (8700): Guest Log: [INFO] Testing connection to EOSCMS 2022-11-01 22:57:52 (8700): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 22:57:53 (8700): Guest Log: [INFO] Testing connection to CMS-Factory 2022-11-01 22:57:53 (8700): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-11-01 22:57:54 (8700): Guest Log: [INFO] Testing connection to Frontier 2022-11-01 22:57:56 (8700): Guest Log: [INFO] Could not find a local HTTP proxy 2022-11-01 22:57:56 (8700): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-11-01 22:57:56 (8700): Guest Log: [INFO] This makes the application less efficient 2022-11-01 22:57:57 (8700): Guest Log: [INFO] It also puts higher load on the project servers 2022-11-01 22:57:57 (8700): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-11-01 22:57:57 (8700): Guest Log: [INFO] Advice can be found in the project forum 2022-11-01 22:57:58 (8700): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-11-01 22:58:35 (8700): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-11-01 22:59:10 (8700): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-11-01 22:59:10 (8700): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-11-01 22:59:12 (8700): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-11-01 22:59:13 (8700): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-11-01 22:59:17 (8700): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-11-01 22:59:17 (8700): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-11-01 22:59:17 (8700): Guest Log: [INFO] Environment HTTP proxy: not set 2022-11-01 22:59:18 (8700): Guest Log: [INFO] Reading volunteer information 2022-11-01 22:59:21 (8700): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-11-01 22:59:22 (8700): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-11-01 22:59:25 (8700): Guest Log: [INFO] CMS application starting. Check log files. 2022-11-01 22:59:26 (8700): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-11-01 22:59:27 (8700): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-11-01 23:11:24 (8700): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 23:11:34 (8700): VM state change detected. (old = 'paused', new = 'running') 2022-11-01 23:43:17 (8700): VM state change detected. (old = 'running', new = 'paused') 2022-11-01 23:43:27 (8700): VM state change detected. (old = 'paused', new = 'running') 2022-11-02 18:01:39 (6672): Detected: vboxwrapper 26205 2022-11-02 18:01:39 (6672): Detected: BOINC client v7.16.11 2022-11-02 18:01:40 (6672): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2022-11-02 18:01:40 (6672): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-11-02 18:01:41 (6672): Guest Log: BIOS: VirtualBox 6.1.12 2022-11-02 18:01:41 (6672): Guest Log: CPUID EDX: 0x178bfbff 2022-11-02 18:01:41 (6672): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-11-02 18:01:41 (6672): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-11-02 18:01:41 (6672): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-11-02 18:01:41 (6672): Guest Log: BIOS: Booting from Hard Disk... 2022-11-02 18:01:41 (6672): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-11-02 18:01:41 (6672): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-11-02 18:01:41 (6672): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-11-02 18:01:41 (6672): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-11-02 18:01:41 (6672): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.000235 main Log opened 2022-11-01T21:55:13.307861000Z 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.000550 main OS Product: Linux 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.000652 main OS Release: 4.14.232-19.cernvm.x86_64 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.000739 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.000821 main Executable: /usr/sbin/VBoxService 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.000824 main Process ID: 2178 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.000826 main Package type: LINUX_64BITS_GENERIC 2022-11-02 18:01:41 (6672): Guest Log: 00:00:00.065996 main 5.2.6 r120293 started. Verbose level = 0 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Mounting the shared directory 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to cern.ch 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to VCCS 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to HTCondor 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to WMAgent 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to EOSCMS 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to CMS-Factory 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Testing connection to Frontier 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Could not find a local HTTP proxy 2022-11-02 18:01:41 (6672): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-11-02 18:01:41 (6672): Guest Log: [INFO] This makes the application less efficient 2022-11-02 18:01:41 (6672): Guest Log: [INFO] It also puts higher load on the project servers 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Advice can be found in the project forum 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-11-02 18:01:41 (6672): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Environment HTTP proxy: not set 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Reading volunteer information 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-11-02 18:01:41 (6672): Guest Log: [INFO] CMS application starting. Check log files. 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-11-02 18:01:41 (6672): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-11-02 18:01:41 (6672): Starting VM using VBoxManage interface. (boinc_6a254bf76740adb7, slot#2) 2022-11-02 18:01:47 (6672): Successfully started VM. (PID = '11776') 2022-11-02 18:01:47 (6672): Reporting VM Process ID to BOINC. 2022-11-02 18:01:47 (6672): Guest Log: BIOS: VirtualBox 6.1.12 2022-11-02 18:01:47 (6672): Guest Log: CPUID EDX: 0x178bfbff 2022-11-02 18:01:47 (6672): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-11-02 18:01:47 (6672): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-11-02 18:01:47 (6672): VM state change detected. (old = 'poweredoff', new = 'running') 2022-11-02 18:01:47 (6672): Status Report: Job Duration: '64800.000000' 2022-11-02 18:01:47 (6672): Status Report: Elapsed Time: '31840.157555' 2022-11-02 18:01:47 (6672): Status Report: CPU Time: '18930.140625' 2022-11-02 18:01:47 (6672): Preference change detected 2022-11-02 18:01:47 (6672): Setting CPU throttle for VM. (50%) 2022-11-02 18:01:47 (6672): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-11-02 18:01:49 (6672): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-11-02 18:01:49 (6672): Guest Log: BIOS: Booting from Hard Disk... 2022-11-02 18:01:52 (6672): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-11-02 18:01:52 (6672): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-11-02 18:02:01 (6672): VM state change detected. (old = 'running', new = 'paused') 2022-11-02 18:02:21 (6672): VM state change detected. (old = 'paused', new = 'running') 2022-11-02 18:02:44 (6672): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-11-02 18:02:44 (6672): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-11-02 18:02:46 (6672): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.000091 main Log opened 2022-11-02T17:02:46.133405000Z 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.000189 main OS Product: Linux 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.000222 main OS Release: 4.14.232-19.cernvm.x86_64 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.000262 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.000301 main Executable: /usr/sbin/VBoxService 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.000302 main Process ID: 2171 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.000303 main Package type: LINUX_64BITS_GENERIC 2022-11-02 18:02:46 (6672): Guest Log: 00:00:00.003697 main 5.2.6 r120293 started. Verbose level = 0 2022-11-02 18:03:09 (6672): Guest Log: [INFO] Mounting the shared directory 2022-11-02 18:03:09 (6672): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-11-02 18:03:10 (6672): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-11-02 18:03:10 (6672): Guest Log: [INFO] Testing connection to cern.ch 2022-11-02 18:03:10 (6672): Guest Log: [INFO] Testing connection to VCCS 2022-11-02 18:03:10 (6672): Guest Log: [INFO] Testing connection to HTCondor 2022-11-02 18:03:10 (6672): Guest Log: [INFO] Testing connection to WMAgent 2022-11-02 18:03:11 (6672): Guest Log: [INFO] Testing connection to EOSCMS 2022-11-02 18:03:11 (6672): Guest Log: [INFO] Testing connection to CMS-Factory 2022-11-02 18:03:11 (6672): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-11-02 18:03:11 (6672): Guest Log: [INFO] Testing connection to Frontier 2022-11-02 18:03:12 (6672): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov} 2022-11-02 18:03:12 (6672): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier 2022-11-02 18:03:12 (6672): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-11-02 18:03:35 (6672): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-11-02 18:03:41 (6672): VM state change detected. (old = 'running', new = 'paused') 2022-11-02 18:04:21 (6672): VM state change detected. (old = 'paused', new = 'running') 2022-11-02 18:04:34 (6672): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-11-02 18:04:34 (6672): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-11-02 18:04:35 (6672): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-11-02 18:04:38 (6672): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-11-02 18:04:40 (6672): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-11-02 18:04:40 (6672): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2022-11-02 18:04:40 (6672): Guest Log: [INFO] Environment HTTP proxy: not set 2022-11-02 18:04:40 (6672): Guest Log: [INFO] Reading volunteer information 2022-11-02 18:04:49 (6672): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-11-02 18:04:49 (6672): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-11-02 18:04:51 (6672): Guest Log: [INFO] CMS application starting. Check log files. 2022-11-02 18:04:51 (6672): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-11-02 18:04:52 (6672): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-11-02 18:08:59 (6672): Stopping VM. 2022-11-02 18:09:20 (6672): Successfully stopped VM. 2023-08-03 10:48:00 (18404): Detected: vboxwrapper 26205 2023-08-03 10:48:00 (18404): Detected: BOINC client v7.16.11 2023-08-03 10:48:01 (18404): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-08-03 10:48:02 (18404): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-08-03 10:48:02 (18404): Guest Log: BIOS: VirtualBox 6.1.12 2023-08-03 10:48:02 (18404): Guest Log: CPUID EDX: 0x178bfbff 2023-08-03 10:48:02 (18404): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-08-03 10:48:02 (18404): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-08-03 10:48:02 (18404): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-08-03 10:48:02 (18404): Guest Log: BIOS: Booting from Hard Disk... 2023-08-03 10:48:02 (18404): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-08-03 10:48:02 (18404): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-08-03 10:48:02 (18404): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-08-03 10:48:02 (18404): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-08-03 10:48:02 (18404): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.000091 main Log opened 2022-11-02T17:02:46.133405000Z 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.000189 main OS Product: Linux 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.000222 main OS Release: 4.14.232-19.cernvm.x86_64 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.000262 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.000301 main Executable: /usr/sbin/VBoxService 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.000302 main Process ID: 2171 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.000303 main Package type: LINUX_64BITS_GENERIC 2023-08-03 10:48:02 (18404): Guest Log: 00:00:00.003697 main 5.2.6 r120293 started. Verbose level = 0 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Mounting the shared directory 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to cern.ch 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to VCCS 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to HTCondor 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to WMAgent 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to EOSCMS 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to CMS-Factory 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Testing connection to Frontier 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov} 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Will use proxies from there for CVMFS and Frontier 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-08-03 10:48:02 (18404): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Environment HTTP proxy: not set 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Reading volunteer information 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-08-03 10:48:02 (18404): Guest Log: [INFO] CMS application starting. Check log files. 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-08-03 10:48:02 (18404): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-08-03 10:48:02 (18404): Starting VM using VBoxManage interface. (boinc_6a254bf76740adb7, slot#2) 2023-08-03 10:48:21 (18404): Successfully started VM. (PID = '13780') 2023-08-03 10:48:21 (18404): Reporting VM Process ID to BOINC. 2023-08-03 10:48:21 (18404): VM state change detected. (old = 'poweredoff', new = 'running') 2023-08-03 10:48:21 (18404): Status Report: Job Duration: '64800.000000' 2023-08-03 10:48:21 (18404): Status Report: Elapsed Time: '32208.157555' 2023-08-03 10:48:21 (18404): Status Report: CPU Time: '19131.921875' 2023-08-03 10:48:21 (18404): Preference change detected 2023-08-03 10:48:21 (18404): Setting CPU throttle for VM. (50%) 2023-08-03 10:48:21 (18404): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-08-03 10:48:26 (18404): Guest Log: 00:05:40.365965 timesync vgsvcTimeSyncWorker: Radical host time change: 23 643 570 467 000 000ns (HostNow=1 691 052 506 513 000 000 ns HostLast=1 667 408 936 046 000 000 ns) 2023-08-03 10:48:36 (18404): Guest Log: 00:05:50.378227 timesync vgsvcTimeSyncWorker: Radical guest time change: 23 643 610 026 205 000ns (GuestNow=1 691 052 516 525 314 000 ns GuestLast=1 667 408 906 499 109 000 ns fSetTimeLastLoop=true ) 2023-08-03 10:49:24 (18404): Stopping VM. 2023-08-03 10:49:43 (18404): Successfully stopped VM. 2023-08-04 09:41:27 (19064): Detected: vboxwrapper 26205 2023-08-04 09:41:27 (19064): Detected: BOINC client v7.16.11 2023-08-04 09:41:28 (19064): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-08-04 09:41:28 (19064): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-08-04 09:41:29 (19064): Guest Log: 00:05:40.365965 timesync vgsvcTimeSyncWorker: Radical host time change: 23 643 570 467 000 000ns (HostNow=1 691 052 506 513 000 000 ns HostLast=1 667 408 936 046 000 000 ns) 2023-08-04 09:41:29 (19064): Guest Log: 00:05:50.378227 timesync vgsvcTimeSyncWorker: Radical guest time change: 23 643 610 026 205 000ns (GuestNow=1 691 052 516 525 314 000 ns GuestLast=1 667 408 906 499 109 000 ns fSetTimeLastLoop=true ) 2023-08-04 09:41:29 (19064): Starting VM using VBoxManage interface. (boinc_6a254bf76740adb7, slot#2) 2023-08-04 09:41:43 (19064): Successfully started VM. (PID = '3268') 2023-08-04 09:41:43 (19064): Reporting VM Process ID to BOINC. 2023-08-04 09:41:43 (19064): VM state change detected. (old = 'poweredoff', new = 'running') 2023-08-04 09:41:43 (19064): Status Report: Job Duration: '64800.000000' 2023-08-04 09:41:43 (19064): Status Report: Elapsed Time: '32271.157555' 2023-08-04 09:41:43 (19064): Status Report: CPU Time: '19178.625000' 2023-08-04 09:41:43 (19064): Preference change detected 2023-08-04 09:41:43 (19064): Setting CPU throttle for VM. (50%) 2023-08-04 09:41:44 (19064): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-08-04 09:41:44 (19064): Guest Log: 00:06:40.500013 timesync vgsvcTimeSyncWorker: Radical host time change: 82 346 884 000 000ns (HostNow=1 691 134 903 513 000 000 ns HostLast=1 691 052 556 629 000 000 ns) 2023-08-04 09:41:54 (19064): Guest Log: 00:06:50.508164 timesync vgsvcTimeSyncWorker: Radical guest time change: 82 346 874 002 000ns (GuestNow=1 691 134 913 521 077 000 ns GuestLast=1 691 052 566 647 075 000 ns fSetTimeLastLoop=true ) 2023-08-04 10:02:30 (19064): Guest Log: [INFO] glidein exited with return value 1. 2023-08-04 10:02:30 (19064): Guest Log: [INFO] Shutting Down. 2023-08-04 10:02:30 (19064): VM Completion File Detected. 2023-08-04 10:02:30 (19064): VM Completion Message: glidein exited with return value 1. . 2023-08-04 10:02:30 (19064): Powering off VM. 2023-08-04 10:02:31 (19064): Successfully stopped VM. 2023-08-04 10:02:31 (19064): Deregistering VM. (boinc_6a254bf76740adb7, slot#2) 2023-08-04 10:02:31 (19064): Removing network bandwidth throttle group from VM. 2023-08-04 10:02:32 (19064): Removing VM from VirtualBox. 10:02:37 (19064): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN