| Name | CMS_603467_1711540201.126646_0 |
| Workunit | 2397066 |
| Created | 27 Mar 2024, 11:50:05 UTC |
| Sent | 28 Mar 2024, 12:27:51 UTC |
| Report deadline | 4 Apr 2024, 12:27:51 UTC |
| Received | 30 Mar 2024, 8:04:06 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 4292 |
| Run time | 17 hours 41 min 8 sec |
| CPU time | 2 days 20 hours 38 min 19 sec |
| Validate state | Valid |
| Credit | 468.17 |
| Device peak FLOPS | 17.95 GFLOPS |
| Application version | CMS Simulation v60.70 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 83.62 MB |
| Peak swap size | 111.26 MB |
| Peak disk usage | 1.69 GB |
Stderr output
<core_client_version>7.16.20</core_client_version> <![CDATA[ <stderr_txt> 2024-03-28 16:38:31 (10536): Detected: vboxwrapper 26206 2024-03-28 16:38:31 (10536): Detected: BOINC client v7.16.20 2024-03-28 16:38:32 (10536): Detected: VirtualBox VboxManage Interface (Version: 6.1.34) 2024-03-28 16:38:33 (10536): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-03-28 16:38:33 (10536): Successfully copied 'init_data.xml' to the shared directory. 2024-03-28 16:38:33 (10536): Create VM. (boinc_ad927e1cd25435c1, slot#4) 2024-03-28 16:38:34 (10536): Setting Memory Size for VM. (4584MB) 2024-03-28 16:38:34 (10536): Setting CPU Count for VM. (4) 2024-03-28 16:38:34 (10536): Setting Chipset Options for VM. 2024-03-28 16:38:35 (10536): Setting Graphics Controller Options for VM. 2024-03-28 16:38:35 (10536): Setting Boot Options for VM. 2024-03-28 16:38:35 (10536): Setting Network Configuration for NAT. 2024-03-28 16:38:35 (10536): Enabling VM Network Access. 2024-03-28 16:38:36 (10536): Disabling USB Support for VM. 2024-03-28 16:38:36 (10536): Disabling COM Port Support for VM. 2024-03-28 16:38:36 (10536): Disabling LPT Port Support for VM. 2024-03-28 16:38:37 (10536): Disabling Audio Support for VM. 2024-03-28 16:38:37 (10536): Disabling Clipboard Support for VM. 2024-03-28 16:38:37 (10536): Disabling Drag and Drop Support for VM. 2024-03-28 16:38:37 (10536): Adding storage controller(s) to VM. 2024-03-28 16:38:38 (10536): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi) 2024-03-28 16:38:39 (10536): Adding VirtualBox Guest Additions to VM. 2024-03-28 16:38:39 (10536): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-03-28 16:38:39 (10536): forwarding host port 55652 to guest port 80 2024-03-28 16:38:40 (10536): Enabling remote desktop for VM. 2024-03-28 16:38:40 (10536): Enabling shared directory for VM. 2024-03-28 16:38:41 (10536): Starting VM using VBoxManage interface. (boinc_ad927e1cd25435c1, slot#4) 2024-03-28 16:38:47 (10536): Successfully started VM. (PID = '5876') 2024-03-28 16:38:47 (10536): Reporting VM Process ID to BOINC. 2024-03-28 16:38:47 (10536): Guest Log: BIOS: VirtualBox 6.1.34 2024-03-28 16:38:47 (10536): Guest Log: CPUID EDX: 0x178bfbff 2024-03-28 16:38:47 (10536): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-03-28 16:38:47 (10536): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-03-28 16:38:47 (10536): VM state change detected. (old = 'poweredoff', new = 'running') 2024-03-28 16:38:47 (10536): Detected: Web Application Enabled (http://localhost:55652) 2024-03-28 16:38:47 (10536): Detected: Remote Desktop Enabled (localhost:55653) 2024-03-28 16:38:47 (10536): Preference change detected 2024-03-28 16:38:47 (10536): Setting CPU throttle for VM. (100%) 2024-03-28 16:38:48 (10536): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-03-28 16:38:49 (10536): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-03-28 16:38:49 (10536): Guest Log: BIOS: Booting from Hard Disk... 2024-03-28 16:38:51 (10536): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-03-28 16:38:51 (10536): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-03-28 16:39:19 (10536): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-03-28 16:39:19 (10536): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-03-28 16:39:20 (10536): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.000125 main Log opened 2024-03-28T15:39:20.835518000Z 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.000300 main OS Product: Linux 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.000352 main OS Release: 4.14.232-19.cernvm.x86_64 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.000388 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.000421 main Executable: /usr/sbin/VBoxService 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.000422 main Process ID: 2286 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.000423 main Package type: LINUX_64BITS_GENERIC 2024-03-28 16:39:20 (10536): Guest Log: 00:00:00.003633 main 5.2.6 r120293 started. Verbose level = 0 2024-03-28 16:39:43 (10536): Guest Log: [INFO] Mounting the shared directory 2024-03-28 16:39:44 (10536): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2024-03-28 16:39:44 (10536): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2024-03-28 16:39:44 (10536): Guest Log: [INFO] Testing connection to cern.ch 2024-03-28 16:39:44 (10536): Guest Log: [INFO] Testing connection to VCCS 2024-03-28 16:39:45 (10536): Guest Log: [INFO] Testing connection to HTCondor 2024-03-28 16:39:45 (10536): Guest Log: [INFO] Testing connection to WMAgent 2024-03-28 16:39:45 (10536): Guest Log: [INFO] Testing connection to EOSCMS 2024-03-28 16:39:46 (10536): Guest Log: [INFO] Testing connection to CMS-Factory 2024-03-28 16:39:46 (10536): Guest Log: [INFO] Testing connection to CMS-Frontier 2024-03-28 16:39:46 (10536): Guest Log: [INFO] Testing connection to Frontier 2024-03-28 16:39:47 (10536): Guest Log: [INFO] Could not find a local HTTP proxy 2024-03-28 16:39:47 (10536): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2024-03-28 16:39:47 (10536): Guest Log: [INFO] This makes the application less efficient 2024-03-28 16:39:47 (10536): Guest Log: [INFO] It also puts higher load on the project servers 2024-03-28 16:39:47 (10536): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2024-03-28 16:39:48 (10536): Guest Log: [INFO] Advice can be found in the project forum 2024-03-28 16:39:49 (10536): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2024-03-28 16:39:55 (10536): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2024-03-28 16:39:57 (10536): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2024-03-28 16:39:57 (10536): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2024-03-28 16:39:57 (10536): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2024-03-28 16:39:58 (10536): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2024-03-28 16:39:59 (10536): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2024-03-28 16:39:59 (10536): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2024-03-28 16:39:59 (10536): Guest Log: [INFO] Environment HTTP proxy: not set 2024-03-28 16:39:59 (10536): Guest Log: [INFO] Reading volunteer information 2024-03-28 16:40:11 (10536): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2024-03-28 16:40:12 (10536): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2024-03-28 16:40:14 (10536): Guest Log: [INFO] Requesting an idtoken from LHC@home 2024-03-28 16:40:14 (10536): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2024-03-28 16:40:15 (10536): Guest Log: [INFO] CMS application starting. Check log files. 2024-03-28 17:41:06 (10536): VM state change detected. (old = 'running', new = 'paused') 2024-03-28 17:54:38 (10536): VM state change detected. (old = 'paused', new = 'running') 2024-03-28 18:32:53 (10536): Status Report: Job Duration: '64800.000000' 2024-03-28 18:32:53 (10536): Status Report: Elapsed Time: '6000.000000' 2024-03-28 18:32:53 (10536): Status Report: CPU Time: '20518.984375' 2024-03-28 18:55:09 (10536): VM state change detected. (old = 'running', new = 'paused') 2024-03-28 20:56:00 (10536): VM state change detected. (old = 'paused', new = 'running') 2024-03-28 20:56:05 (10536): Guest Log: 02:02:23.081939 timesync vgsvcTimeSyncWorker: Radical host time change: 7 260 912 000 000ns (HostNow=1 711 655 764 974 000 000 ns HostLast=1 711 648 504 062 000 000 ns) 2024-03-28 20:56:15 (10536): Guest Log: 02:02:33.086360 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 071 061 540 000ns (GuestNow=1 711 655 774 978 602 000 ns GuestLast=1 711 647 703 917 062 000 ns fSetTimeLastLoop=true ) 2024-03-28 21:56:31 (10536): VM state change detected. (old = 'running', new = 'paused') 2024-03-28 21:59:16 (10536): VM state change detected. (old = 'paused', new = 'running') 2024-03-28 22:17:09 (10536): Status Report: Job Duration: '64800.000000' 2024-03-28 22:17:09 (10536): Status Report: Elapsed Time: '12000.000000' 2024-03-28 22:17:09 (10536): Status Report: CPU Time: '44629.359375' 2024-03-28 23:02:52 (10536): VM state change detected. (old = 'running', new = 'paused') 2024-03-28 23:03:51 (10536): VM state change detected. (old = 'paused', new = 'running') 2024-03-28 23:58:42 (10536): Status Report: Job Duration: '64800.000000' 2024-03-28 23:58:42 (10536): Status Report: Elapsed Time: '18000.000000' 2024-03-28 23:58:42 (10536): Status Report: CPU Time: '68695.687500' 2024-03-29 00:04:23 (10536): VM state change detected. (old = 'running', new = 'paused') 2024-03-29 01:41:34 (10536): VM state change detected. (old = 'paused', new = 'running') 2024-03-29 01:41:42 (10536): Guest Log: 05:07:08.003238 timesync vgsvcTimeSyncWorker: Radical host time change: 5 841 019 000 000ns (HostNow=1 711 672 901 780 000 000 ns HostLast=1 711 667 060 761 000 000 ns) 2024-03-29 01:41:52 (10536): Guest Log: 05:07:18.011100 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 061 892 981 000ns (GuestNow=1 711 672 911 788 148 000 ns GuestLast=1 711 666 849 895 167 000 ns fSetTimeLastLoop=true ) 2024-03-29 02:42:27 (10536): VM state change detected. (old = 'running', new = 'paused') 2024-03-29 14:47:31 (11148): Detected: vboxwrapper 26206 2024-03-29 14:47:31 (11148): Detected: BOINC client v7.16.20 2024-03-29 14:47:33 (11148): Detected: VirtualBox VboxManage Interface (Version: 6.1.34) 2024-03-29 14:47:33 (11148): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-03-29 14:47:34 (11148): Guest Log: BIOS: VirtualBox 6.1.34 2024-03-29 14:47:34 (11148): Guest Log: CPUID EDX: 0x178bfbff 2024-03-29 14:47:34 (11148): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-03-29 14:47:34 (11148): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-03-29 14:47:34 (11148): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-03-29 14:47:34 (11148): Guest Log: BIOS: Booting from Hard Disk... 2024-03-29 14:47:34 (11148): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-03-29 14:47:34 (11148): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-03-29 14:47:34 (11148): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-03-29 14:47:34 (11148): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-03-29 14:47:34 (11148): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.000125 main Log opened 2024-03-28T15:39:20.835518000Z 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.000300 main OS Product: Linux 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.000352 main OS Release: 4.14.232-19.cernvm.x86_64 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.000388 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.000421 main Executable: /usr/sbin/VBoxService 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.000422 main Process ID: 2286 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.000423 main Package type: LINUX_64BITS_GENERIC 2024-03-29 14:47:34 (11148): Guest Log: 00:00:00.003633 main 5.2.6 r120293 started. Verbose level = 0 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Mounting the shared directory 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to cern.ch 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to VCCS 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to HTCondor 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to WMAgent 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to EOSCMS 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to CMS-Factory 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to CMS-Frontier 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Testing connection to Frontier 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Could not find a local HTTP proxy 2024-03-29 14:47:34 (11148): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2024-03-29 14:47:34 (11148): Guest Log: [INFO] This makes the application less efficient 2024-03-29 14:47:34 (11148): Guest Log: [INFO] It also puts higher load on the project servers 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Advice can be found in the project forum 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2024-03-29 14:47:34 (11148): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Environment HTTP proxy: not set 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Reading volunteer information 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Requesting an idtoken from LHC@home 2024-03-29 14:47:34 (11148): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2024-03-29 14:47:34 (11148): Guest Log: [INFO] CMS application starting. Check log files. 2024-03-29 14:47:34 (11148): Guest Log: 02:02:23.081939 timesync vgsvcTimeSyncWorker: Radical host time change: 7 260 912 000 000ns (HostNow=1 711 655 764 974 000 000 ns HostLast=1 711 648 504 062 000 000 ns) 2024-03-29 14:47:34 (11148): Guest Log: 02:02:33.086360 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 071 061 540 000ns (GuestNow=1 711 655 774 978 602 000 ns GuestLast=1 711 647 703 917 062 000 ns fSetTimeLastLoop=true ) 2024-03-29 14:47:34 (11148): Guest Log: 05:07:08.003238 timesync vgsvcTimeSyncWorker: Radical host time change: 5 841 019 000 000ns (HostNow=1 711 672 901 780 000 000 ns HostLast=1 711 667 060 761 000 000 ns) 2024-03-29 14:47:34 (11148): Guest Log: 05:07:18.011100 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 061 892 981 000ns (GuestNow=1 711 672 911 788 148 000 ns GuestLast=1 711 666 849 895 167 000 ns fSetTimeLastLoop=true ) 2024-03-29 14:47:34 (11148): Starting VM using VBoxManage interface. (boinc_ad927e1cd25435c1, slot#4) 2024-03-29 14:47:41 (11148): Successfully started VM. (PID = '10244') 2024-03-29 14:47:41 (11148): Reporting VM Process ID to BOINC. 2024-03-29 14:47:41 (11148): Guest Log: BIOS: VirtualBox 6.1.34 2024-03-29 14:47:41 (11148): Guest Log: CPUID EDX: 0x178bfbff 2024-03-29 14:47:41 (11148): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-03-29 14:47:41 (11148): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-03-29 14:47:41 (11148): VM state change detected. (old = 'poweredoff', new = 'running') 2024-03-29 14:47:41 (11148): Detected: Web Application Enabled (http://localhost:55652) 2024-03-29 14:47:41 (11148): Detected: Remote Desktop Enabled (localhost:55653) 2024-03-29 14:47:41 (11148): Status Report: Job Duration: '64800.000000' 2024-03-29 14:47:41 (11148): Status Report: Elapsed Time: '21961.000000' 2024-03-29 14:47:41 (11148): Status Report: CPU Time: '84571.312500' 2024-03-29 14:47:41 (11148): Preference change detected 2024-03-29 14:47:41 (11148): Setting CPU throttle for VM. (100%) 2024-03-29 14:47:41 (11148): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-03-29 14:47:43 (11148): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-03-29 14:47:43 (11148): Guest Log: BIOS: Booting from Hard Disk... 2024-03-29 14:47:45 (11148): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-03-29 14:47:45 (11148): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-03-29 14:48:17 (11148): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-03-29 14:48:17 (11148): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-03-29 14:48:18 (11148): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.000225 main Log opened 2024-03-29T13:48:17.608144000Z 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.000499 main OS Product: Linux 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.000566 main OS Release: 4.14.232-19.cernvm.x86_64 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.000621 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.000668 main Executable: /usr/sbin/VBoxService 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.000669 main Process ID: 2278 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.000670 main Package type: LINUX_64BITS_GENERIC 2024-03-29 14:48:18 (11148): Guest Log: 00:00:00.003912 main 5.2.6 r120293 started. Verbose level = 0 2024-03-29 14:48:39 (11148): Guest Log: [INFO] Mounting the shared directory 2024-03-29 14:48:39 (11148): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2024-03-29 14:48:39 (11148): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2024-03-29 14:48:39 (11148): Guest Log: [INFO] Testing connection to cern.ch 2024-03-29 14:48:40 (11148): Guest Log: [INFO] Testing connection to VCCS 2024-03-29 14:48:41 (11148): Guest Log: [INFO] Testing connection to HTCondor 2024-03-29 14:48:41 (11148): Guest Log: [INFO] Testing connection to WMAgent 2024-03-29 14:48:41 (11148): Guest Log: [INFO] Testing connection to EOSCMS 2024-03-29 14:48:42 (11148): Guest Log: [INFO] Testing connection to CMS-Factory 2024-03-29 14:48:42 (11148): Guest Log: [INFO] Testing connection to CMS-Frontier 2024-03-29 14:48:42 (11148): Guest Log: [INFO] Testing connection to Frontier 2024-03-29 14:48:43 (11148): Guest Log: [INFO] Could not find a local HTTP proxy 2024-03-29 14:48:44 (11148): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2024-03-29 14:48:44 (11148): Guest Log: [INFO] This makes the application less efficient 2024-03-29 14:48:44 (11148): Guest Log: [INFO] It also puts higher load on the project servers 2024-03-29 14:48:44 (11148): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2024-03-29 14:48:44 (11148): Guest Log: [INFO] Advice can be found in the project forum 2024-03-29 14:48:44 (11148): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2024-03-29 14:48:53 (11148): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2024-03-29 14:48:55 (11148): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2024-03-29 14:48:55 (11148): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2024-03-29 14:48:55 (11148): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2024-03-29 14:48:56 (11148): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2024-03-29 14:48:57 (11148): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2024-03-29 14:48:57 (11148): Guest Log: [INFO] 2.7.2.0 http://s1ihep-cvmfs.openhtc.io:8080 DIRECT 2024-03-29 14:48:57 (11148): Guest Log: [INFO] Environment HTTP proxy: not set 2024-03-29 14:48:57 (11148): Guest Log: [INFO] Reading volunteer information 2024-03-29 14:49:22 (11148): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2024-03-29 14:49:23 (11148): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2024-03-29 14:49:24 (11148): Guest Log: [INFO] Requesting an idtoken from LHC@home 2024-03-29 14:49:25 (11148): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2024-03-29 14:49:26 (11148): Guest Log: [INFO] CMS application starting. Check log files. 2024-03-29 15:48:32 (11148): VM state change detected. (old = 'running', new = 'paused') 2024-03-29 16:51:43 (11148): VM state change detected. (old = 'paused', new = 'running') 2024-03-29 16:51:49 (11148): Guest Log: 01:00:21.652973 timesync vgsvcTimeSyncWorker: Radical host time change: 3 800 173 000 000ns (HostNow=1 711 727 509 459 000 000 ns HostLast=1 711 723 709 286 000 000 ns) 2024-03-29 16:52:00 (11148): Guest Log: 01:00:31.658283 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 800 203 728 000ns (GuestNow=1 711 727 519 464 454 000 ns GuestLast=1 711 723 719 260 726 000 ns fSetTimeLastLoop=true ) 2024-03-29 17:31:55 (11148): Status Report: Job Duration: '64800.000000' 2024-03-29 17:31:55 (11148): Status Report: Elapsed Time: '27961.704548' 2024-03-29 17:31:55 (11148): Status Report: CPU Time: '107012.906250' 2024-03-29 17:52:01 (11148): VM state change detected. (old = 'running', new = 'paused') 2024-03-29 22:52:54 (11148): VM state change detected. (old = 'paused', new = 'running') 2024-03-29 22:53:03 (11148): Guest Log: 02:00:43.196792 timesync vgsvcTimeSyncWorker: Radical host time change: 18 061 961 000 000ns (HostNow=1 711 749 182 959 000 000 ns HostLast=1 711 731 120 998 000 000 ns) 2024-03-29 22:53:13 (11148): Guest Log: 02:00:53.197994 timesync vgsvcTimeSyncWorker: Radical guest time change: 18 061 957 548 000ns (GuestNow=1 711 749 192 960 338 000 ns GuestLast=1 711 731 131 002 790 000 ns fSetTimeLastLoop=true ) 2024-03-29 23:53:33 (11148): VM state change detected. (old = 'running', new = 'paused') 2024-03-30 00:01:39 (11148): VM state change detected. (old = 'paused', new = 'running') 2024-03-30 00:21:40 (11148): Status Report: Job Duration: '64800.000000' 2024-03-30 00:21:40 (11148): Status Report: Elapsed Time: '33961.704548' 2024-03-30 00:21:40 (11148): Status Report: CPU Time: '130380.328125' 2024-03-30 01:02:08 (11148): VM state change detected. (old = 'running', new = 'paused') 2024-03-30 01:24:58 (11148): VM state change detected. (old = 'paused', new = 'running') 2024-03-30 01:25:10 (11148): Guest Log: 04:01:56.164682 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 863 819 425 000ns (GuestNow=1 711 758 309 746 198 000 ns GuestLast=1 711 756 445 926 773 000 ns fSetTimeLastLoop=true ) 2024-03-30 02:25:06 (11148): Status Report: Job Duration: '64800.000000' 2024-03-30 02:25:06 (11148): Status Report: Elapsed Time: '39961.704548' 2024-03-30 02:25:06 (11148): Status Report: CPU Time: '154473.859375' 2024-03-30 04:05:47 (11148): Status Report: Job Duration: '64800.000000' 2024-03-30 04:05:47 (11148): Status Report: Elapsed Time: '45961.704548' 2024-03-30 04:05:47 (11148): Status Report: CPU Time: '178552.359375' 2024-03-30 05:46:23 (11148): Status Report: Job Duration: '64800.000000' 2024-03-30 05:46:23 (11148): Status Report: Elapsed Time: '51961.704548' 2024-03-30 05:46:23 (11148): Status Report: CPU Time: '202602.421875' 2024-03-30 07:33:18 (11148): Status Report: Job Duration: '64800.000000' 2024-03-30 07:33:18 (11148): Status Report: Elapsed Time: '57962.273262' 2024-03-30 07:33:18 (11148): Status Report: CPU Time: '228168.484375' 2024-03-30 08:25:57 (11148): VM state change detected. (old = 'running', new = 'paused') 2024-03-30 08:34:43 (11148): VM state change detected. (old = 'paused', new = 'running') 2024-03-30 09:03:50 (11148): Guest Log: [INFO] glidein exited with return value 0. 2024-03-30 09:03:51 (11148): Guest Log: [INFO] Shutting Down. 2024-03-30 09:03:51 (11148): VM Completion File Detected. 2024-03-30 09:03:51 (11148): VM Completion Message: glidein exited with return value 0. . 2024-03-30 09:03:51 (11148): Powering off VM. 2024-03-30 09:03:52 (11148): Successfully stopped VM. 2024-03-30 09:03:52 (11148): Deregistering VM. (boinc_ad927e1cd25435c1, slot#4) 2024-03-30 09:03:53 (11148): Removing network bandwidth throttle group from VM. 2024-03-30 09:03:53 (11148): Removing VM from VirtualBox. 09:03:58 (11148): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN