Name CMS_331201_1676532769.240266_0
Workunit 2280142
Created 16 Feb 2023, 7:32:51 UTC
Sent 18 Feb 2023, 8:42:02 UTC
Report deadline 25 Feb 2023, 8:42:02 UTC
Received 19 Feb 2023, 12:02:58 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4318
Run time 13 hours 36 min 44 sec
CPU time 15 hours 37 min 43 sec
Validate state Valid
Credit 1,336.23
Device peak FLOPS 33.00 GFLOPS
Application version CMS Simulation v60.70 (vbox64_mt_mcore_cms)
x86_64-pc-linux-gnu
Peak working set size 5.22 GB
Peak swap size 8.09 GB
Peak disk usage 3.12 GB

Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2023-02-18 09:42:05 (4108318): Detected: vboxwrapper 26206
2023-02-18 09:42:05 (4108318): Detected: BOINC client v7.16.11
2023-02-18 09:42:05 (4108318): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-18 09:42:05 (4108318): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-18 09:42:05 (4108318): Successfully copied 'init_data.xml' to the shared directory.
2023-02-18 09:42:05 (4108318): Create VM. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-18 09:42:06 (4108318): Setting Memory Size for VM. (15336MB)
2023-02-18 09:42:06 (4108318): Setting CPU Count for VM. (16)
2023-02-18 09:42:06 (4108318): Setting Chipset Options for VM.
2023-02-18 09:42:06 (4108318): Setting Graphics Controller Options for VM.
2023-02-18 09:42:06 (4108318): Setting Boot Options for VM.
2023-02-18 09:42:06 (4108318): Setting Network Configuration for NAT.
2023-02-18 09:42:06 (4108318): Enabling VM Network Access.
2023-02-18 09:42:06 (4108318): Disabling USB Support for VM.
2023-02-18 09:42:06 (4108318): Disabling COM Port Support for VM.
2023-02-18 09:42:06 (4108318): Disabling LPT Port Support for VM.
2023-02-18 09:42:06 (4108318): Disabling Audio Support for VM.
2023-02-18 09:42:06 (4108318): Disabling Clipboard Support for VM.
2023-02-18 09:42:06 (4108318): Disabling Drag and Drop Support for VM.
2023-02-18 09:42:07 (4108318): Adding storage controller(s) to VM.
2023-02-18 09:42:07 (4108318): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi)
2023-02-18 09:42:07 (4108318): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-02-18 09:42:07 (4108318): forwarding host port 52933 to guest port 80
2023-02-18 09:42:07 (4108318): Enabling remote desktop for VM.
2023-02-18 09:42:07 (4108318): Required extension pack not installed, remote desktop not enabled.
2023-02-18 09:42:07 (4108318): Enabling shared directory for VM.
2023-02-18 09:42:07 (4108318): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-18 09:42:09 (4108318): Successfully started VM. (PID = '4108844')
2023-02-18 09:42:09 (4108318): Reporting VM Process ID to BOINC.
2023-02-18 09:42:09 (4108318): Guest Log: BIOS: VirtualBox 6.1.25
2023-02-18 09:42:09 (4108318): Guest Log: CPUID EDX: 0x178bfbff
2023-02-18 09:42:09 (4108318): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-02-18 09:42:09 (4108318): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-02-18 09:42:09 (4108318): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-18 09:42:09 (4108318): Detected: Web Application Enabled (http://localhost:52933)
2023-02-18 09:42:09 (4108318): Preference change detected
2023-02-18 09:42:09 (4108318): Setting CPU throttle for VM. (100%)
2023-02-18 09:42:09 (4108318): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-18 09:42:11 (4108318): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-02-18 09:42:11 (4108318): Guest Log: BIOS: Booting from Hard Disk...
2023-02-18 09:42:15 (4108318): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-02-18 09:42:15 (4108318): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-02-18 09:42:57 (4108318): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-02-18 09:42:57 (4108318): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-02-18 09:43:01 (4108318): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.000129 main     Log opened 2023-02-18T08:43:01.024080000Z
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.000534 main     OS Product: Linux
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.000577 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.000612 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.000645 main     Executable: /usr/sbin/VBoxService
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.000646 main     Process ID: 2739
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.000647 main     Package type: LINUX_64BITS_GENERIC
2023-02-18 09:43:01 (4108318): Guest Log: 00:00:00.002745 main     5.2.6 r120293 started. Verbose level = 0
2023-02-18 09:43:26 (4108318): Guest Log: [INFO] Mounting the shared directory
2023-02-18 09:43:26 (4108318): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-02-18 09:43:27 (4108318): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-02-18 09:43:27 (4108318): Guest Log: [INFO] Testing connection to cern.ch
2023-02-18 09:43:28 (4108318): Guest Log: [INFO] Testing connection to VCCS
2023-02-18 09:43:28 (4108318): Guest Log: [INFO] Testing connection to HTCondor
2023-02-18 09:43:29 (4108318): Guest Log: [INFO] Testing connection to WMAgent
2023-02-18 09:43:29 (4108318): Guest Log: [INFO] Testing connection to EOSCMS
2023-02-18 09:43:29 (4108318): Guest Log: [INFO] Testing connection to CMS-Factory
2023-02-18 09:43:30 (4108318): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-02-18 09:43:30 (4108318): Guest Log: [INFO] Testing connection to Frontier
2023-02-18 09:43:31 (4108318): Guest Log: [INFO] Could not find a local HTTP proxy
2023-02-18 09:43:31 (4108318): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-02-18 09:43:32 (4108318): Guest Log: [INFO] This makes the application less efficient
2023-02-18 09:43:32 (4108318): Guest Log: [INFO] It also puts higher load on the project servers
2023-02-18 09:43:32 (4108318): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-02-18 09:43:32 (4108318): Guest Log: [INFO] Advice can be found in the project forum
2023-02-18 09:43:33 (4108318): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-02-18 09:43:44 (4108318): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-02-18 09:43:48 (4108318): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-02-18 09:43:48 (4108318): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-02-18 09:43:49 (4108318): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-02-18 09:43:49 (4108318): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-02-18 09:43:52 (4108318): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-02-18 09:43:52 (4108318): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2023-02-18 09:43:52 (4108318): Guest Log: [INFO] Environment HTTP proxy: not set
2023-02-18 09:43:52 (4108318): Guest Log: [INFO] Reading volunteer information
2023-02-18 09:43:59 (4108318): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-02-18 09:44:00 (4108318): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-02-18 09:44:01 (4108318): Guest Log: [INFO] CMS application starting. Check log files.
2023-02-18 09:44:02 (4108318): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-02-18 09:44:03 (4108318): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-02-18 10:42:36 (4108318): Stopping VM.
2023-02-18 10:43:28 (4108318): Successfully stopped VM.
2023-02-18 11:55:47 (4169030): Detected: vboxwrapper 26206
2023-02-18 11:55:47 (4169030): Detected: BOINC client v7.16.11
2023-02-18 11:55:47 (4169030): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-18 11:55:47 (4169030): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-18 11:55:47 (4169030): Guest Log: BIOS: VirtualBox 6.1.25
2023-02-18 11:55:47 (4169030): Guest Log: CPUID EDX: 0x178bfbff
2023-02-18 11:55:47 (4169030): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-02-18 11:55:47 (4169030): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-02-18 11:55:47 (4169030): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-02-18 11:55:47 (4169030): Guest Log: BIOS: Booting from Hard Disk...
2023-02-18 11:55:47 (4169030): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-02-18 11:55:47 (4169030): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-02-18 11:55:47 (4169030): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-02-18 11:55:47 (4169030): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-02-18 11:55:47 (4169030): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.000129 main     Log opened 2023-02-18T08:43:01.024080000Z
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.000534 main     OS Product: Linux
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.000577 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.000612 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.000645 main     Executable: /usr/sbin/VBoxService
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.000646 main     Process ID: 2739
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.000647 main     Package type: LINUX_64BITS_GENERIC
2023-02-18 11:55:47 (4169030): Guest Log: 00:00:00.002745 main     5.2.6 r120293 started. Verbose level = 0
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Mounting the shared directory
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to cern.ch
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to VCCS
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to HTCondor
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to WMAgent
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to EOSCMS
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to CMS-Factory
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Testing connection to Frontier
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Could not find a local HTTP proxy
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] This makes the application less efficient
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] It also puts higher load on the project servers
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Advice can be found in the project forum
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Environment HTTP proxy: not set
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Reading volunteer information
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] CMS application starting. Check log files.
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-02-18 11:55:47 (4169030): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-02-18 11:55:47 (4169030): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-18 11:56:15 (4169030): Successfully started VM. (PID = '4169149')
2023-02-18 11:56:15 (4169030): Reporting VM Process ID to BOINC.
2023-02-18 11:56:15 (4169030): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-18 11:56:15 (4169030): Detected: Web Application Enabled (http://localhost:52933)
2023-02-18 11:56:15 (4169030): Preference change detected
2023-02-18 11:56:15 (4169030): Setting CPU throttle for VM. (100%)
2023-02-18 11:56:15 (4169030): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-18 11:56:17 (4169030): Guest Log: 00:59:42.055016 timesync vgsvcTimeSyncWorker: Radical host time change: 4 427 272 000 000ns (HostNow=1 676 717 776 499 000 000 ns HostLast=1 676 713 349 227 000 000 ns)
2023-02-18 11:56:27 (4169030): Guest Log: 00:59:52.055388 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 423 422 371 000ns (GuestNow=1 676 717 786 500 320 000 ns GuestLast=1 676 713 363 077 949 000 ns fSetTimeLastLoop=true )
2023-02-18 12:34:48 (4169030): Status Report: Job Duration: '64800.000000'
2023-02-18 12:34:48 (4169030): Status Report: Elapsed Time: '6000.000000'
2023-02-18 12:34:48 (4169030): Status Report: CPU Time: '7476.040000'
2023-02-18 12:56:35 (4169030): Stopping VM.
2023-02-18 12:57:19 (4169030): Successfully stopped VM.
2023-02-18 14:13:54 (39052): Detected: vboxwrapper 26206
2023-02-18 14:13:54 (39052): Detected: BOINC client v7.16.11
2023-02-18 14:13:55 (39052): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-18 14:13:55 (39052): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-18 14:13:55 (39052): Guest Log: 00:59:42.055016 timesync vgsvcTimeSyncWorker: Radical host time change: 4 427 272 000 000ns (HostNow=1 676 717 776 499 000 000 ns HostLast=1 676 713 349 227 000 000 ns)
2023-02-18 14:13:55 (39052): Guest Log: 00:59:52.055388 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 423 422 371 000ns (GuestNow=1 676 717 786 500 320 000 ns GuestLast=1 676 713 363 077 949 000 ns fSetTimeLastLoop=true )
2023-02-18 14:13:55 (39052): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-18 14:14:21 (39052): Successfully started VM. (PID = '39189')
2023-02-18 14:14:21 (39052): Reporting VM Process ID to BOINC.
2023-02-18 14:14:21 (39052): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-18 14:14:21 (39052): Detected: Web Application Enabled (http://localhost:52933)
2023-02-18 14:14:21 (39052): Status Report: Job Duration: '64800.000000'
2023-02-18 14:14:21 (39052): Status Report: Elapsed Time: '7321.000000'
2023-02-18 14:14:21 (39052): Status Report: CPU Time: '9000.330000'
2023-02-18 14:14:21 (39052): Preference change detected
2023-02-18 14:14:21 (39052): Setting CPU throttle for VM. (100%)
2023-02-18 14:14:22 (39052): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-18 14:14:29 (39052): Guest Log: 02:00:13.899062 timesync vgsvcTimeSyncWorker: Radical host time change: 4 674 531 000 000ns (HostNow=1 676 726 068 978 000 000 ns HostLast=1 676 721 394 447 000 000 ns)
2023-02-18 14:14:39 (39052): Guest Log: 02:00:23.906641 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 670 643 425 000ns (GuestNow=1 676 726 078 986 466 000 ns GuestLast=1 676 721 408 343 041 000 ns fSetTimeLastLoop=true )
2023-02-18 15:14:55 (39052): Stopping VM.
2023-02-18 15:15:51 (39052): Successfully stopped VM.
2023-02-18 16:15:54 (96167): Detected: vboxwrapper 26206
2023-02-18 16:15:54 (96167): Detected: BOINC client v7.16.11
2023-02-18 16:15:55 (96167): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-18 16:15:55 (96167): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-18 16:15:55 (96167): Guest Log: 02:00:13.899062 timesync vgsvcTimeSyncWorker: Radical host time change: 4 674 531 000 000ns (HostNow=1 676 726 068 978 000 000 ns HostLast=1 676 721 394 447 000 000 ns)
2023-02-18 16:15:55 (96167): Guest Log: 02:00:23.906641 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 670 643 425 000ns (GuestNow=1 676 726 078 986 466 000 ns GuestLast=1 676 721 408 343 041 000 ns fSetTimeLastLoop=true )
2023-02-18 16:15:55 (96167): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-18 16:16:10 (96167): Successfully started VM. (PID = '96368')
2023-02-18 16:16:10 (96167): Reporting VM Process ID to BOINC.
2023-02-18 16:16:10 (96167): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-18 16:16:10 (96167): Detected: Web Application Enabled (http://localhost:52933)
2023-02-18 16:16:10 (96167): Status Report: Job Duration: '64800.000000'
2023-02-18 16:16:10 (96167): Status Report: Elapsed Time: '10991.313577'
2023-02-18 16:16:10 (96167): Status Report: CPU Time: '12624.320000'
2023-02-18 16:16:10 (96167): Preference change detected
2023-02-18 16:16:10 (96167): Setting CPU throttle for VM. (100%)
2023-02-18 16:16:10 (96167): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-18 16:16:11 (96167): Guest Log: 03:00:45.566097 timesync vgsvcTimeSyncWorker: Radical host time change: 3 683 277 000 000ns (HostNow=1 676 733 370 027 000 000 ns HostLast=1 676 729 686 750 000 000 ns)
2023-02-18 16:16:20 (96167): Guest Log: 03:00:55.571684 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 679 402 049 000ns (GuestNow=1 676 733 380 040 295 000 ns GuestLast=1 676 729 700 638 246 000 ns fSetTimeLastLoop=true )
2023-02-18 17:16:45 (96167): Stopping VM.
2023-02-18 17:17:34 (96167): Successfully stopped VM.
2023-02-18 17:22:11 (129217): Detected: vboxwrapper 26206
2023-02-18 17:22:11 (129217): Detected: BOINC client v7.16.11
2023-02-18 17:22:11 (129217): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-18 17:22:11 (129217): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-18 17:22:11 (129217): Guest Log: 03:00:45.566097 timesync vgsvcTimeSyncWorker: Radical host time change: 3 683 277 000 000ns (HostNow=1 676 733 370 027 000 000 ns HostLast=1 676 729 686 750 000 000 ns)
2023-02-18 17:22:11 (129217): Guest Log: 03:00:55.571684 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 679 402 049 000ns (GuestNow=1 676 733 380 040 295 000 ns GuestLast=1 676 729 700 638 246 000 ns fSetTimeLastLoop=true )
2023-02-18 17:22:11 (129217): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-18 17:22:25 (129217): Successfully started VM. (PID = '129297')
2023-02-18 17:22:25 (129217): Reporting VM Process ID to BOINC.
2023-02-18 17:22:26 (129217): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-18 17:22:26 (129217): Detected: Web Application Enabled (http://localhost:52933)
2023-02-18 17:22:26 (129217): Status Report: Job Duration: '64800.000000'
2023-02-18 17:22:26 (129217): Status Report: Elapsed Time: '14663.313577'
2023-02-18 17:22:26 (129217): Status Report: CPU Time: '16834.560000'
2023-02-18 17:22:26 (129217): Preference change detected
2023-02-18 17:22:26 (129217): Setting CPU throttle for VM. (100%)
2023-02-18 17:22:26 (129217): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-18 18:23:09 (129217): Stopping VM.
2023-02-18 18:23:51 (129217): Successfully stopped VM.
2023-02-18 18:33:26 (161703): Detected: vboxwrapper 26206
2023-02-18 18:33:26 (161703): Detected: BOINC client v7.16.11
2023-02-18 18:33:26 (161703): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-18 18:33:26 (161703): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-18 18:33:27 (161703): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-18 18:33:40 (161703): Successfully started VM. (PID = '161801')
2023-02-18 18:33:40 (161703): Reporting VM Process ID to BOINC.
2023-02-18 18:33:40 (161703): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-18 18:33:40 (161703): Detected: Web Application Enabled (http://localhost:52933)
2023-02-18 18:33:40 (161703): Status Report: Job Duration: '64800.000000'
2023-02-18 18:33:40 (161703): Status Report: Elapsed Time: '18343.313577'
2023-02-18 18:33:40 (161703): Status Report: CPU Time: '21158.010000'
2023-02-18 18:33:40 (161703): Preference change detected
2023-02-18 18:33:40 (161703): Setting CPU throttle for VM. (100%)
2023-02-18 18:33:40 (161703): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-18 20:12:41 (161703): Status Report: Job Duration: '64800.000000'
2023-02-18 20:12:41 (161703): Status Report: Elapsed Time: '24343.313577'
2023-02-18 20:12:41 (161703): Status Report: CPU Time: '28034.190000'
2023-02-18 20:44:12 (161703): Stopping VM.
2023-02-19 01:08:42 (325251): Detected: vboxwrapper 26206
2023-02-19 01:08:42 (325251): Detected: BOINC client v7.16.11
2023-02-19 01:08:42 (325251): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-19 01:08:42 (325251): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-19 01:08:42 (325251): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 01:08:44 (325251): Successfully started VM. (PID = '325349')
2023-02-19 01:08:44 (325251): Reporting VM Process ID to BOINC.
2023-02-19 01:08:44 (325251): Guest Log: BIOS: VirtualBox 6.1.25
2023-02-19 01:08:44 (325251): Guest Log: CPUID EDX: 0x178bfbff
2023-02-19 01:08:44 (325251): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-02-19 01:08:44 (325251): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-02-19 01:08:44 (325251): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-19 01:08:44 (325251): Detected: Web Application Enabled (http://localhost:52933)
2023-02-19 01:08:44 (325251): Status Report: Job Duration: '64800.000000'
2023-02-19 01:08:44 (325251): Status Report: Elapsed Time: '26253.313577'
2023-02-19 01:08:44 (325251): Status Report: CPU Time: '30227.970000'
2023-02-19 01:08:44 (325251): Preference change detected
2023-02-19 01:08:44 (325251): Setting CPU throttle for VM. (100%)
2023-02-19 01:08:44 (325251): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-19 01:08:46 (325251): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-02-19 01:08:46 (325251): Guest Log: BIOS: Booting from Hard Disk...
2023-02-19 01:08:49 (325251): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-02-19 01:08:49 (325251): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-02-19 01:09:38 (325251): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-02-19 01:09:38 (325251): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-02-19 01:09:41 (325251): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.000167 main     Log opened 2023-02-19T00:09:41.743834000Z
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.000318 main     OS Product: Linux
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.000371 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.000410 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.000446 main     Executable: /usr/sbin/VBoxService
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.000447 main     Process ID: 2719
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.000448 main     Package type: LINUX_64BITS_GENERIC
2023-02-19 01:09:41 (325251): Guest Log: 00:00:00.004420 main     5.2.6 r120293 started. Verbose level = 0
2023-02-19 01:10:12 (325251): Guest Log: [INFO] Mounting the shared directory
2023-02-19 01:10:12 (325251): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-02-19 01:10:13 (325251): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-02-19 01:10:13 (325251): Guest Log: [INFO] Testing connection to cern.ch
2023-02-19 01:10:13 (325251): Guest Log: [INFO] Testing connection to VCCS
2023-02-19 01:10:14 (325251): Guest Log: [INFO] Testing connection to HTCondor
2023-02-19 01:10:14 (325251): Guest Log: [INFO] Testing connection to WMAgent
2023-02-19 01:10:15 (325251): Guest Log: [INFO] Testing connection to EOSCMS
2023-02-19 01:10:15 (325251): Guest Log: [INFO] Testing connection to CMS-Factory
2023-02-19 01:10:16 (325251): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-02-19 01:10:16 (325251): Guest Log: [INFO] Testing connection to Frontier
2023-02-19 01:10:17 (325251): Guest Log: [INFO] Could not find a local HTTP proxy
2023-02-19 01:10:18 (325251): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-02-19 01:10:18 (325251): Guest Log: [INFO] This makes the application less efficient
2023-02-19 01:10:18 (325251): Guest Log: [INFO] It also puts higher load on the project servers
2023-02-19 01:10:18 (325251): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-02-19 01:10:18 (325251): Guest Log: [INFO] Advice can be found in the project forum
2023-02-19 01:10:19 (325251): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-02-19 01:10:30 (325251): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-02-19 01:10:36 (325251): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-02-19 01:10:36 (325251): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-02-19 01:10:37 (325251): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-02-19 01:10:39 (325251): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-02-19 01:10:41 (325251): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-02-19 01:10:42 (325251): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2023-02-19 01:10:42 (325251): Guest Log: [INFO] Environment HTTP proxy: not set
2023-02-19 01:10:42 (325251): Guest Log: [INFO] Reading volunteer information
2023-02-19 01:10:45 (325251): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-02-19 01:10:46 (325251): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-02-19 01:10:48 (325251): Guest Log: [INFO] CMS application starting. Check log files.
2023-02-19 01:10:48 (325251): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-02-19 01:10:49 (325251): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-02-19 02:09:12 (325251): Stopping VM.
2023-02-19 02:09:58 (325251): Successfully stopped VM.
2023-02-19 03:31:23 (384416): Detected: vboxwrapper 26206
2023-02-19 03:31:23 (384416): Detected: BOINC client v7.16.11
2023-02-19 03:31:23 (384416): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-19 03:31:23 (384416): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-19 03:31:23 (384416): Guest Log: BIOS: VirtualBox 6.1.25
2023-02-19 03:31:23 (384416): Guest Log: CPUID EDX: 0x178bfbff
2023-02-19 03:31:23 (384416): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-02-19 03:31:23 (384416): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-02-19 03:31:23 (384416): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-02-19 03:31:23 (384416): Guest Log: BIOS: Booting from Hard Disk...
2023-02-19 03:31:23 (384416): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-02-19 03:31:23 (384416): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-02-19 03:31:23 (384416): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-02-19 03:31:23 (384416): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-02-19 03:31:23 (384416): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-02-19 03:31:23 (384416): Guest Log: 00:00:00.004420 main     5.2.6 r120293 started. Verbose level = 0
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Mounting the shared directory
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to cern.ch
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to VCCS
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to HTCondor
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to WMAgent
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to EOSCMS
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to CMS-Factory
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Testing connection to Frontier
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Could not find a local HTTP proxy
2023-02-19 03:31:23 (384416): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-02-19 03:31:23 (384416): Guest Log: [INFO] This makes the application less efficient
2023-02-19 03:31:23 (384416): Guest Log: [INFO] It also puts higher load on the project servers
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Advice can be found in the project forum
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-02-19 03:31:23 (384416): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Environment HTTP proxy: not set
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Reading volunteer information
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-02-19 03:31:23 (384416): Guest Log: [INFO] CMS application starting. Check log files.
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-02-19 03:31:23 (384416): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-02-19 03:31:23 (384416): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 03:31:36 (384416): Successfully started VM. (PID = '384514')
2023-02-19 03:31:36 (384416): Reporting VM Process ID to BOINC.
2023-02-19 03:31:36 (384416): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-19 03:31:36 (384416): Detected: Web Application Enabled (http://localhost:52933)
2023-02-19 03:31:36 (384416): Status Report: Job Duration: '64800.000000'
2023-02-19 03:31:36 (384416): Status Report: Elapsed Time: '29918.313577'
2023-02-19 03:31:36 (384416): Status Report: CPU Time: '34922.310000'
2023-02-19 03:31:36 (384416): Preference change detected
2023-02-19 03:31:36 (384416): Setting CPU throttle for VM. (100%)
2023-02-19 03:31:36 (384416): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-19 03:31:43 (384416): Guest Log: 00:59:42.604924 timesync vgsvcTimeSyncWorker: Radical host time change: 4 952 243 000 000ns (HostNow=1 676 773 902 739 000 000 ns HostLast=1 676 768 950 496 000 000 ns)
2023-02-19 03:31:53 (384416): Guest Log: 00:59:52.610136 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 948 397 617 000ns (GuestNow=1 676 773 912 745 185 000 ns GuestLast=1 676 768 964 347 568 000 ns fSetTimeLastLoop=true )
2023-02-19 04:32:04 (384416): Stopping VM.
2023-02-19 04:32:53 (384416): Status Report: virtualbox/vboxheadless is no longer running.
2023-02-19 04:32:53 (384416): Successfully stopped VM.
2023-02-19 05:54:59 (452985): Detected: vboxwrapper 26206
2023-02-19 05:54:59 (452985): Detected: BOINC client v7.16.11
2023-02-19 05:54:59 (452985): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-19 05:54:59 (452985): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-19 05:55:00 (452985): Guest Log: 00:59:42.604924 timesync vgsvcTimeSyncWorker: Radical host time change: 4 952 243 000 000ns (HostNow=1 676 773 902 739 000 000 ns HostLast=1 676 768 950 496 000 000 ns)
2023-02-19 05:55:00 (452985): Guest Log: 00:59:52.610136 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 948 397 617 000ns (GuestNow=1 676 773 912 745 185 000 ns GuestLast=1 676 768 964 347 568 000 ns fSetTimeLastLoop=true )
2023-02-19 05:55:00 (452985): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 05:55:12 (452985): Successfully started VM. (PID = '453084')
2023-02-19 05:55:12 (452985): Reporting VM Process ID to BOINC.
2023-02-19 05:55:12 (452985): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-19 05:55:12 (452985): Detected: Web Application Enabled (http://localhost:52933)
2023-02-19 05:55:12 (452985): Status Report: Job Duration: '64800.000000'
2023-02-19 05:55:12 (452985): Status Report: Elapsed Time: '33583.313577'
2023-02-19 05:55:12 (452985): Status Report: CPU Time: '39132.280000'
2023-02-19 05:55:12 (452985): Preference change detected
2023-02-19 05:55:12 (452985): Setting CPU throttle for VM. (100%)
2023-02-19 05:55:12 (452985): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-19 05:55:20 (452985): Guest Log: 02:00:17.595048 timesync vgsvcTimeSyncWorker: Radical host time change: 4 996 818 000 000ns (HostNow=1 676 782 520 642 000 000 ns HostLast=1 676 777 523 824 000 000 ns)
2023-02-19 05:55:30 (452985): Guest Log: 02:00:27.610046 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 992 928 201 000ns (GuestNow=1 676 782 530 657 629 000 ns GuestLast=1 676 777 537 729 428 000 ns fSetTimeLastLoop=true )
2023-02-19 06:55:10 (452985): Stopping VM.
2023-02-19 06:55:59 (452985): Successfully stopped VM.
2023-02-19 07:49:34 (508515): Detected: vboxwrapper 26206
2023-02-19 07:49:34 (508515): Detected: BOINC client v7.16.11
2023-02-19 07:49:34 (508515): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-19 07:49:34 (508515): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-19 07:49:34 (508515): Guest Log: 02:00:17.595048 timesync vgsvcTimeSyncWorker: Radical host time change: 4 996 818 000 000ns (HostNow=1 676 782 520 642 000 000 ns HostLast=1 676 777 523 824 000 000 ns)
2023-02-19 07:49:34 (508515): Guest Log: 02:00:27.610046 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 992 928 201 000ns (GuestNow=1 676 782 530 657 629 000 ns GuestLast=1 676 777 537 729 428 000 ns fSetTimeLastLoop=true )
2023-02-19 07:49:34 (508515): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 07:49:53 (508515): Successfully started VM. (PID = '508619')
2023-02-19 07:49:53 (508515): Reporting VM Process ID to BOINC.
2023-02-19 07:49:53 (508515): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-19 07:49:53 (508515): Detected: Web Application Enabled (http://localhost:52933)
2023-02-19 07:49:53 (508515): Status Report: Job Duration: '64800.000000'
2023-02-19 07:49:53 (508515): Status Report: Elapsed Time: '37217.313577'
2023-02-19 07:49:53 (508515): Status Report: CPU Time: '42731.050000'
2023-02-19 07:49:53 (508515): Preference change detected
2023-02-19 07:49:53 (508515): Setting CPU throttle for VM. (100%)
2023-02-19 07:49:54 (508515): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-19 07:50:01 (508515): Guest Log: 03:00:20.794266 timesync vgsvcTimeSyncWorker: Radical host time change: 3 291 769 000 000ns (HostNow=1 676 789 401 720 000 000 ns HostLast=1 676 786 109 951 000 000 ns)
2023-02-19 07:50:11 (508515): Guest Log: 03:00:30.800643 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 287 943 938 000ns (GuestNow=1 676 789 411 756 028 000 ns GuestLast=1 676 786 123 812 090 000 ns fSetTimeLastLoop=true )
2023-02-19 08:49:55 (508515): Stopping VM.
2023-02-19 08:50:43 (508515): Successfully stopped VM.
2023-02-19 09:10:55 (549195): Detected: vboxwrapper 26206
2023-02-19 09:10:55 (549195): Detected: BOINC client v7.16.11
2023-02-19 09:10:55 (549195): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-19 09:10:55 (549195): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-19 09:10:56 (549195): Guest Log: 03:00:20.794266 timesync vgsvcTimeSyncWorker: Radical host time change: 3 291 769 000 000ns (HostNow=1 676 789 401 720 000 000 ns HostLast=1 676 786 109 951 000 000 ns)
2023-02-19 09:10:56 (549195): Guest Log: 03:00:30.800643 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 287 943 938 000ns (GuestNow=1 676 789 411 756 028 000 ns GuestLast=1 676 786 123 812 090 000 ns fSetTimeLastLoop=true )
2023-02-19 09:10:56 (549195): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 09:11:15 (549195): Successfully started VM. (PID = '549294')
2023-02-19 09:11:15 (549195): Reporting VM Process ID to BOINC.
2023-02-19 09:11:15 (549195): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-19 09:11:15 (549195): Detected: Web Application Enabled (http://localhost:52933)
2023-02-19 09:11:15 (549195): Status Report: Job Duration: '64800.000000'
2023-02-19 09:11:15 (549195): Status Report: Elapsed Time: '40854.313577'
2023-02-19 09:11:15 (549195): Status Report: CPU Time: '46883.370000'
2023-02-19 09:11:15 (549195): Preference change detected
2023-02-19 09:11:15 (549195): Setting CPU throttle for VM. (100%)
2023-02-19 09:11:15 (549195): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-19 10:11:56 (549195): Stopping VM.
2023-02-19 10:12:47 (549195): Successfully stopped VM.
2023-02-19 10:46:13 (595660): Detected: vboxwrapper 26206
2023-02-19 10:46:13 (595660): Detected: BOINC client v7.16.11
2023-02-19 10:46:13 (595660): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-19 10:46:13 (595660): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-19 10:46:13 (595660): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 10:46:33 (595660): Successfully started VM. (PID = '595759')
2023-02-19 10:46:33 (595660): Reporting VM Process ID to BOINC.
2023-02-19 10:46:33 (595660): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-19 10:46:33 (595660): Detected: Web Application Enabled (http://localhost:52933)
2023-02-19 10:46:33 (595660): Status Report: Job Duration: '64800.000000'
2023-02-19 10:46:33 (595660): Status Report: Elapsed Time: '44531.313577'
2023-02-19 10:46:33 (595660): Status Report: CPU Time: '51109.050000'
2023-02-19 10:46:33 (595660): Preference change detected
2023-02-19 10:46:33 (595660): Setting CPU throttle for VM. (100%)
2023-02-19 10:46:34 (595660): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-19 10:46:39 (595660): Guest Log: 05:01:10.850380 timesync vgsvcTimeSyncWorker: Radical host time change: 2 086 155 000 000ns (HostNow=1 676 799 998 813 000 000 ns HostLast=1 676 797 912 658 000 000 ns)
2023-02-19 10:46:49 (595660): Guest Log: 05:01:20.860514 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 082 453 538 000ns (GuestNow=1 676 800 009 041 119 000 ns GuestLast=1 676 797 926 587 581 000 ns fSetTimeLastLoop=true )
2023-02-19 11:46:29 (595660): Stopping VM.
2023-02-19 12:37:20 (647354): Detected: vboxwrapper 26206
2023-02-19 12:37:20 (647354): Detected: BOINC client v7.16.11
2023-02-19 12:37:21 (647354): Detected: VirtualBox VboxManage Interface (Version: 6.1.26)
2023-02-19 12:37:21 (647354): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-02-19 12:37:21 (647354): Guest Log: 05:01:10.850380 timesync vgsvcTimeSyncWorker: Radical host time change: 2 086 155 000 000ns (HostNow=1 676 799 998 813 000 000 ns HostLast=1 676 797 912 658 000 000 ns)
2023-02-19 12:37:21 (647354): Guest Log: 05:01:20.860514 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 082 453 538 000ns (GuestNow=1 676 800 009 041 119 000 ns GuestLast=1 676 797 926 587 581 000 ns fSetTimeLastLoop=true )
2023-02-19 12:37:21 (647354): Starting VM using VBoxManage interface. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 12:37:41 (647354): Successfully started VM. (PID = '647453')
2023-02-19 12:37:41 (647354): Reporting VM Process ID to BOINC.
2023-02-19 12:37:41 (647354): Guest Log: 06:01:05.635768 timesync vgsvcTimeSyncWorker: Radical host time change: 3 080 795 000 000ns (HostNow=1 676 806 660 731 000 000 ns HostLast=1 676 803 579 936 000 000 ns)
2023-02-19 12:37:41 (647354): VM state change detected. (old = 'poweredoff', new = 'running')
2023-02-19 12:37:41 (647354): Detected: Web Application Enabled (http://localhost:52933)
2023-02-19 12:37:41 (647354): Status Report: Job Duration: '64800.000000'
2023-02-19 12:37:41 (647354): Status Report: Elapsed Time: '48162.313577'
2023-02-19 12:37:41 (647354): Status Report: CPU Time: '55335.090000'
2023-02-19 12:37:41 (647354): Preference change detected
2023-02-19 12:37:41 (647354): Setting CPU throttle for VM. (100%)
2023-02-19 12:37:41 (647354): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-02-19 12:37:51 (647354): Guest Log: 06:01:15.644362 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 076 949 817 000ns (GuestNow=1 676 806 670 752 890 000 ns GuestLast=1 676 803 593 803 073 000 ns fSetTimeLastLoop=true )
2023-02-19 13:02:48 (647354): Guest Log: [INFO] glidein exited with return value 0.
2023-02-19 13:02:48 (647354): Guest Log: [INFO] Shutting Down.
2023-02-19 13:02:48 (647354): VM Completion File Detected.
2023-02-19 13:02:48 (647354): VM Completion Message: glidein exited with return value 0.
.
2023-02-19 13:02:48 (647354): Powering off VM.
2023-02-19 13:02:49 (647354): Successfully stopped VM.
2023-02-19 13:02:49 (647354): Deregistering VM. (boinc_3ba1dbeaa2c1f2b6, slot#2)
2023-02-19 13:02:49 (647354): Removing network bandwidth throttle group from VM.
2023-02-19 13:02:49 (647354): Removing VM from VirtualBox.
13:02:54 (647354): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN