Name CMS_3597526_1683210021.741800_0
Workunit 2304848
Created 4 May 2023, 14:20:22 UTC
Sent 5 May 2023, 0:54:33 UTC
Report deadline 12 May 2023, 0:54:33 UTC
Received 5 May 2023, 11:40:31 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4752
Run time 8 hours 38 min 55 sec
CPU time 9 hours 3 min 26 sec
Validate state Valid
Credit 465.57
Device peak FLOPS 4.99 GFLOPS
Application version CMS Simulation v60.70 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 83.56 MB
Peak swap size 114.81 MB
Peak disk usage 1.09 GB

Stderr output

<core_client_version>7.22.0</core_client_version>
<![CDATA[
<stderr_txt>
2023-05-04 21:00:16 (6180): Detected: vboxwrapper 26206
2023-05-04 21:00:16 (6180): Detected: BOINC client v7.22.0
2023-05-04 21:00:17 (6180): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-04 21:00:17 (6180): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-04 21:00:17 (6180): Successfully copied 'init_data.xml' to the shared directory.
2023-05-04 21:00:18 (6180): Create VM. (boinc_f28dd5b2311e6578, slot#3)
2023-05-04 21:00:18 (6180): Setting Memory Size for VM. (1896MB)
2023-05-04 21:00:19 (6180): Setting CPU Count for VM. (1)
2023-05-04 21:00:19 (6180): Setting Chipset Options for VM.
2023-05-04 21:00:19 (6180): Setting Graphics Controller Options for VM.
2023-05-04 21:00:19 (6180): Setting Boot Options for VM.
2023-05-04 21:00:20 (6180): Setting Network Configuration for NAT.
2023-05-04 21:00:20 (6180): Enabling VM Network Access.
2023-05-04 21:00:20 (6180): Disabling USB Support for VM.
2023-05-04 21:00:20 (6180): Disabling COM Port Support for VM.
2023-05-04 21:00:21 (6180): Disabling LPT Port Support for VM.
2023-05-04 21:00:21 (6180): Disabling Audio Support for VM.
2023-05-04 21:00:21 (6180): Disabling Clipboard Support for VM.
2023-05-04 21:00:21 (6180): Disabling Drag and Drop Support for VM.
2023-05-04 21:00:22 (6180): Adding storage controller(s) to VM.
2023-05-04 21:00:22 (6180): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi)
2023-05-04 21:00:23 (6180): Adding VirtualBox Guest Additions to VM.
2023-05-04 21:00:23 (6180): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-05-04 21:00:24 (6180): forwarding host port 55471 to guest port 80
2023-05-04 21:00:24 (6180): Enabling remote desktop for VM.
2023-05-04 21:00:24 (6180): Required extension pack not installed, remote desktop not enabled.
2023-05-04 21:00:24 (6180): Enabling shared directory for VM.
2023-05-04 21:00:25 (6180): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-04 21:00:29 (6180): Successfully started VM. (PID = '7872')
2023-05-04 21:00:29 (6180): Reporting VM Process ID to BOINC.
2023-05-04 21:00:29 (6180): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-04 21:00:29 (6180): Guest Log: CPUID EDX: 0x178bfbff
2023-05-04 21:00:29 (6180): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-04 21:00:29 (6180): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-04 21:00:29 (6180): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-04 21:00:29 (6180): Detected: Web Application Enabled (http://localhost:55471)
2023-05-04 21:00:30 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 21:00:42 (6180): Preference change detected
2023-05-04 21:00:42 (6180): Setting CPU throttle for VM. (100%)
2023-05-04 21:00:42 (6180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-04 21:00:43 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 21:00:44 (6180): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-04 21:00:44 (6180): Guest Log: BIOS: Booting from Hard Disk...
2023-05-04 21:00:46 (6180): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-04 21:00:46 (6180): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-04 21:00:53 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 21:01:14 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 21:01:29 (6180): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-04 21:01:29 (6180): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-04 21:01:30 (6180): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.000087 main     Log opened 2023-05-05T01:01:29.844325000Z
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.000247 main     OS Product: Linux
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.000290 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.000325 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.000358 main     Executable: /usr/sbin/VBoxService
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.000359 main     Process ID: 2162
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.000359 main     Package type: LINUX_64BITS_GENERIC
2023-05-04 21:01:30 (6180): Guest Log: 00:00:00.002413 main     5.2.6 r120293 started. Verbose level = 0
2023-05-04 21:01:39 (6180): Guest Log: [INFO] Mounting the shared directory
2023-05-04 21:01:39 (6180): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-04 21:01:39 (6180): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-04 21:01:39 (6180): Guest Log: [INFO] Testing connection to cern.ch
2023-05-04 21:01:39 (6180): Guest Log: [INFO] Testing connection to VCCS
2023-05-04 21:01:39 (6180): Guest Log: [INFO] Testing connection to HTCondor
2023-05-04 21:01:40 (6180): Guest Log: [INFO] Testing connection to WMAgent
2023-05-04 21:01:40 (6180): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-04 21:01:40 (6180): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-04 21:01:41 (6180): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-04 21:01:41 (6180): Guest Log: [INFO] Testing connection to Frontier
2023-05-04 21:01:42 (6180): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-04 21:01:42 (6180): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-04 21:01:42 (6180): Guest Log: [INFO] This makes the application less efficient
2023-05-04 21:01:42 (6180): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-04 21:01:42 (6180): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-04 21:01:42 (6180): Guest Log: [INFO] Advice can be found in the project forum
2023-05-04 21:01:42 (6180): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-04 21:01:53 (6180): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-04 21:01:55 (6180): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-04 21:01:56 (6180): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-04 21:01:56 (6180): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-04 21:01:56 (6180): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-04 21:01:56 (6180): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-04 21:01:56 (6180): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2023-05-04 21:01:56 (6180): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-04 21:01:57 (6180): Guest Log: [INFO] Reading volunteer information
2023-05-04 21:02:02 (6180): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-04 21:02:03 (6180): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-04 21:02:04 (6180): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-04 21:02:04 (6180): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-04 21:02:05 (6180): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-04 21:23:19 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 21:23:40 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 21:31:06 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 21:31:32 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 21:54:02 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 21:54:23 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 22:01:56 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 22:02:17 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 22:16:04 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 22:16:24 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 22:24:35 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 22:24:55 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 22:32:39 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 22:32:59 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 22:44:05 (6180): Status Report: Job Duration: '64800.000000'
2023-05-04 22:44:05 (6180): Status Report: Elapsed Time: '6000.000000'
2023-05-04 22:44:05 (6180): Status Report: CPU Time: '6207.500000'
2023-05-04 22:56:11 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 22:56:33 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 22:58:38 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 22:58:59 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:05:32 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:05:53 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:11:10 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:11:30 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:23:15 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:23:35 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:24:05 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:24:25 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:32:37 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:33:02 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:36:06 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:36:26 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:42:09 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:42:29 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-04 23:48:18 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-04 23:48:39 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:00:23 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:00:44 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:09:10 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:09:32 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:13:01 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:13:21 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:14:31 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:14:51 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:19:08 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:19:28 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:25:33 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:25:53 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:31:46 (6180): Status Report: Job Duration: '64800.000000'
2023-05-05 00:31:46 (6180): Status Report: Elapsed Time: '12000.000000'
2023-05-05 00:31:46 (6180): Status Report: CPU Time: '12703.140625'
2023-05-05 00:42:08 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:42:29 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 00:50:10 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 00:50:30 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 01:01:24 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 01:01:44 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 01:12:10 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 01:12:31 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 01:24:51 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 01:25:17 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 01:27:03 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 01:27:23 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 01:49:45 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 01:50:05 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 01:50:26 (6180): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 01:50:46 (6180): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 02:02:30 (6180): Stopping VM.
2023-05-05 02:02:36 (6180): Successfully stopped VM.
2023-05-05 02:04:56 (9244): Detected: vboxwrapper 26206
2023-05-05 02:04:56 (9244): Detected: BOINC client v7.22.0
2023-05-05 02:04:57 (9244): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 02:04:57 (9244): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 02:04:58 (9244): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-05 02:04:58 (9244): Guest Log: CPUID EDX: 0x178bfbff
2023-05-05 02:04:58 (9244): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-05 02:04:58 (9244): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-05 02:04:58 (9244): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-05 02:04:58 (9244): Guest Log: BIOS: Booting from Hard Disk...
2023-05-05 02:04:58 (9244): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-05 02:04:58 (9244): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-05 02:04:58 (9244): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-05 02:04:58 (9244): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-05 02:04:58 (9244): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.000087 main     Log opened 2023-05-05T01:01:29.844325000Z
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.000247 main     OS Product: Linux
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.000290 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.000325 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.000358 main     Executable: /usr/sbin/VBoxService
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.000359 main     Process ID: 2162
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.000359 main     Package type: LINUX_64BITS_GENERIC
2023-05-05 02:04:58 (9244): Guest Log: 00:00:00.002413 main     5.2.6 r120293 started. Verbose level = 0
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Mounting the shared directory
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to cern.ch
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to VCCS
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to HTCondor
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to WMAgent
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Testing connection to Frontier
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-05 02:04:58 (9244): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-05 02:04:58 (9244): Guest Log: [INFO] This makes the application less efficient
2023-05-05 02:04:58 (9244): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Advice can be found in the project forum
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-05 02:04:58 (9244): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Reading volunteer information
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-05 02:04:58 (9244): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-05 02:04:58 (9244): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-05 02:04:58 (9244): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 02:05:11 (9244): Successfully started VM. (PID = '5424')
2023-05-05 02:05:11 (9244): Reporting VM Process ID to BOINC.
2023-05-05 02:05:11 (9244): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 02:05:11 (9244): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 02:05:12 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 02:05:23 (9244): Status Report: Job Duration: '64800.000000'
2023-05-05 02:05:23 (9244): Status Report: Elapsed Time: '17231.000000'
2023-05-05 02:05:23 (9244): Status Report: CPU Time: '18376.609375'
2023-05-05 02:05:23 (9244): Preference change detected
2023-05-05 02:05:23 (9244): Setting CPU throttle for VM. (100%)
2023-05-05 02:05:23 (9244): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 02:05:24 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 02:17:14 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 02:17:34 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 02:26:51 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 02:27:13 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 02:42:56 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 02:43:16 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 03:02:30 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 03:02:51 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 03:09:27 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 03:09:47 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 03:35:35 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 03:35:55 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 03:39:18 (9244): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 03:39:48 (9244): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 03:48:59 (9244): Status Report: Job Duration: '64800.000000'
2023-05-05 03:48:59 (9244): Status Report: Elapsed Time: '23231.275387'
2023-05-05 03:48:59 (9244): Status Report: CPU Time: '24281.859375'
2023-05-05 03:55:15 (9244): Stopping VM.
2023-05-05 03:55:21 (9244): Successfully stopped VM.
2023-05-05 04:00:41 (12968): Detected: vboxwrapper 26206
2023-05-05 04:00:41 (12968): Detected: BOINC client v7.22.0
2023-05-05 04:00:41 (12968): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 04:00:42 (12968): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 04:00:42 (12968): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 04:00:53 (12968): Successfully started VM. (PID = '4348')
2023-05-05 04:00:53 (12968): Reporting VM Process ID to BOINC.
2023-05-05 04:00:53 (12968): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 04:00:53 (12968): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 04:00:53 (12968): Status Report: Job Duration: '64800.000000'
2023-05-05 04:00:53 (12968): Status Report: Elapsed Time: '23603.275387'
2023-05-05 04:00:53 (12968): Status Report: CPU Time: '24677.234375'
2023-05-05 04:00:53 (12968): Preference change detected
2023-05-05 04:00:53 (12968): Setting CPU throttle for VM. (100%)
2023-05-05 04:00:54 (12968): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 04:06:47 (12968): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 04:07:07 (12968): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 04:08:35 (12968): Stopping VM.
2023-05-05 04:08:41 (12968): Successfully stopped VM.
2023-05-05 04:09:35 (2812): Detected: vboxwrapper 26206
2023-05-05 04:09:35 (2812): Detected: BOINC client v7.22.0
2023-05-05 04:09:36 (2812): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 04:09:37 (2812): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 04:09:37 (2812): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 04:09:47 (2812): Successfully started VM. (PID = '6968')
2023-05-05 04:09:47 (2812): Reporting VM Process ID to BOINC.
2023-05-05 04:09:47 (2812): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 04:09:47 (2812): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 04:09:47 (2812): Status Report: Job Duration: '64800.000000'
2023-05-05 04:09:47 (2812): Status Report: Elapsed Time: '24019.275387'
2023-05-05 04:09:47 (2812): Status Report: CPU Time: '25185.562500'
2023-05-05 04:09:47 (2812): Preference change detected
2023-05-05 04:09:47 (2812): Setting CPU throttle for VM. (100%)
2023-05-05 04:09:48 (2812): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 04:15:34 (2812): Stopping VM.
2023-05-05 04:15:41 (2812): Successfully stopped VM.
2023-05-05 04:19:01 (12036): Detected: vboxwrapper 26206
2023-05-05 04:19:01 (12036): Detected: BOINC client v7.22.0
2023-05-05 04:19:02 (12036): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 04:19:02 (12036): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 04:19:03 (12036): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 04:19:19 (12036): Successfully started VM. (PID = '10576')
2023-05-05 04:19:19 (12036): Reporting VM Process ID to BOINC.
2023-05-05 04:19:19 (12036): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 04:19:19 (12036): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 04:19:19 (12036): Stopping VM.
2023-05-05 04:19:25 (12036): Successfully stopped VM.
2023-05-05 04:23:22 (8300): Detected: vboxwrapper 26206
2023-05-05 04:23:22 (8300): Detected: BOINC client v7.22.0
2023-05-05 04:23:23 (8300): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 04:23:23 (8300): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 04:23:24 (8300): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 04:23:33 (8300): Successfully started VM. (PID = '1068')
2023-05-05 04:23:33 (8300): Reporting VM Process ID to BOINC.
2023-05-05 04:23:33 (8300): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 04:23:33 (8300): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 04:23:33 (8300): Status Report: Job Duration: '64800.000000'
2023-05-05 04:23:33 (8300): Status Report: Elapsed Time: '24353.275387'
2023-05-05 04:23:33 (8300): Status Report: CPU Time: '25580.890625'
2023-05-05 04:23:33 (8300): Preference change detected
2023-05-05 04:23:33 (8300): Setting CPU throttle for VM. (100%)
2023-05-05 04:23:34 (8300): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 04:24:59 (8300): Stopping VM.
2023-05-05 04:25:05 (8300): Successfully stopped VM.
2023-05-05 04:34:05 (7064): Detected: vboxwrapper 26206
2023-05-05 04:34:05 (7064): Detected: BOINC client v7.22.0
2023-05-05 04:34:06 (7064): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 04:34:07 (7064): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 04:34:07 (7064): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 04:34:19 (7064): Successfully started VM. (PID = '13888')
2023-05-05 04:34:19 (7064): Reporting VM Process ID to BOINC.
2023-05-05 04:34:19 (7064): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 04:34:19 (7064): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 04:34:19 (7064): Stopping VM.
2023-05-05 04:34:24 (7064): Successfully stopped VM.
2023-05-05 04:46:31 (5596): Detected: vboxwrapper 26206
2023-05-05 04:46:31 (5596): Detected: BOINC client v7.22.0
2023-05-05 04:46:31 (5596): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 04:46:32 (5596): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 04:46:32 (5596): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 04:46:42 (5596): Successfully started VM. (PID = '10236')
2023-05-05 04:46:42 (5596): Reporting VM Process ID to BOINC.
2023-05-05 04:46:42 (5596): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 04:46:42 (5596): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 04:46:42 (5596): Status Report: Job Duration: '64800.000000'
2023-05-05 04:46:42 (5596): Status Report: Elapsed Time: '24425.275387'
2023-05-05 04:46:42 (5596): Status Report: CPU Time: '25681.250000'
2023-05-05 04:46:42 (5596): Preference change detected
2023-05-05 04:46:42 (5596): Setting CPU throttle for VM. (100%)
2023-05-05 04:46:42 (5596): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 04:48:40 (5596): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 04:49:00 (5596): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 04:55:01 (5596): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 04:55:21 (5596): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 04:56:37 (5596): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 04:56:58 (5596): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 04:59:36 (5596): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 04:59:57 (5596): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 05:05:31 (5596): Stopping VM.
2023-05-05 05:05:38 (5596): Successfully stopped VM.
2023-05-05 05:06:31 (6608): Detected: vboxwrapper 26206
2023-05-05 05:06:31 (6608): Detected: BOINC client v7.22.0
2023-05-05 05:06:32 (6608): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 05:06:32 (6608): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 05:06:33 (6608): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 05:06:43 (6608): Successfully started VM. (PID = '6256')
2023-05-05 05:06:43 (6608): Reporting VM Process ID to BOINC.
2023-05-05 05:06:43 (6608): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 05:06:43 (6608): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 05:06:43 (6608): Status Report: Job Duration: '64800.000000'
2023-05-05 05:06:43 (6608): Status Report: Elapsed Time: '25447.275387'
2023-05-05 05:06:43 (6608): Status Report: CPU Time: '26766.281250'
2023-05-05 05:06:43 (6608): Preference change detected
2023-05-05 05:06:43 (6608): Setting CPU throttle for VM. (100%)
2023-05-05 05:06:44 (6608): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 05:14:54 (6608): Stopping VM.
2023-05-05 05:15:00 (6608): Successfully stopped VM.
2023-05-05 05:16:32 (6972): Detected: vboxwrapper 26206
2023-05-05 05:16:32 (6972): Detected: BOINC client v7.22.0
2023-05-05 05:16:32 (6972): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 05:16:32 (6972): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 05:16:33 (6972): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 05:16:43 (6972): Successfully started VM. (PID = '8320')
2023-05-05 05:16:43 (6972): Reporting VM Process ID to BOINC.
2023-05-05 05:16:43 (6972): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 05:16:43 (6972): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 05:16:43 (6972): Status Report: Job Duration: '64800.000000'
2023-05-05 05:16:43 (6972): Status Report: Elapsed Time: '25935.275387'
2023-05-05 05:16:43 (6972): Status Report: CPU Time: '26873.468750'
2023-05-05 05:16:43 (6972): Preference change detected
2023-05-05 05:16:43 (6972): Setting CPU throttle for VM. (100%)
2023-05-05 05:16:44 (6972): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 05:21:20 (6972): Stopping VM.
2023-05-05 05:21:27 (6972): Successfully stopped VM.
2023-05-05 05:27:43 (6712): Detected: vboxwrapper 26206
2023-05-05 05:27:43 (6712): Detected: BOINC client v7.22.0
2023-05-05 05:27:44 (6712): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 05:27:44 (6712): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 05:27:45 (6712): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 05:27:54 (6712): Successfully started VM. (PID = '10036')
2023-05-05 05:27:54 (6712): Reporting VM Process ID to BOINC.
2023-05-05 05:27:54 (6712): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 05:27:54 (6712): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 05:27:54 (6712): Status Report: Job Duration: '64800.000000'
2023-05-05 05:27:54 (6712): Status Report: Elapsed Time: '26210.275387'
2023-05-05 05:27:54 (6712): Status Report: CPU Time: '26964.453125'
2023-05-05 05:27:54 (6712): Preference change detected
2023-05-05 05:27:54 (6712): Setting CPU throttle for VM. (100%)
2023-05-05 05:27:55 (6712): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 05:29:16 (6712): Stopping VM.
2023-05-05 05:29:23 (6712): Successfully stopped VM.
2023-05-05 05:30:31 (2052): Detected: vboxwrapper 26206
2023-05-05 05:30:31 (2052): Detected: BOINC client v7.22.0
2023-05-05 05:30:32 (2052): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 05:30:32 (2052): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 05:30:33 (2052): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 05:30:42 (2052): Successfully started VM. (PID = '8616')
2023-05-05 05:30:42 (2052): Reporting VM Process ID to BOINC.
2023-05-05 05:30:42 (2052): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 05:30:42 (2052): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 05:30:42 (2052): Status Report: Job Duration: '64800.000000'
2023-05-05 05:30:42 (2052): Status Report: Elapsed Time: '26286.275387'
2023-05-05 05:30:42 (2052): Status Report: CPU Time: '27057.781250'
2023-05-05 05:30:42 (2052): Preference change detected
2023-05-05 05:30:42 (2052): Setting CPU throttle for VM. (100%)
2023-05-05 05:30:43 (2052): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 05:31:13 (2052): Stopping VM.
2023-05-05 05:31:20 (2052): Successfully stopped VM.
2023-05-05 05:49:26 (3804): Detected: vboxwrapper 26206
2023-05-05 05:49:26 (3804): Detected: BOINC client v7.22.0
2023-05-05 05:49:26 (3804): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 05:49:27 (3804): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 05:49:27 (3804): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 05:49:37 (3804): Successfully started VM. (PID = '7116')
2023-05-05 05:49:37 (3804): Reporting VM Process ID to BOINC.
2023-05-05 05:49:37 (3804): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 05:49:37 (3804): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 05:49:37 (3804): Stopping VM.
2023-05-05 05:49:43 (3804): Successfully stopped VM.
2023-05-05 05:52:20 (1536): Detected: vboxwrapper 26206
2023-05-05 05:52:20 (1536): Detected: BOINC client v7.22.0
2023-05-05 05:52:21 (1536): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 05:52:21 (1536): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 05:52:22 (1536): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 05:52:31 (1536): Successfully started VM. (PID = '14760')
2023-05-05 05:52:31 (1536): Reporting VM Process ID to BOINC.
2023-05-05 05:52:31 (1536): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 05:52:31 (1536): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 05:52:31 (1536): Status Report: Job Duration: '64800.000000'
2023-05-05 05:52:31 (1536): Status Report: Elapsed Time: '26315.275387'
2023-05-05 05:52:31 (1536): Status Report: CPU Time: '27089.734375'
2023-05-05 05:52:31 (1536): Preference change detected
2023-05-05 05:52:31 (1536): Setting CPU throttle for VM. (100%)
2023-05-05 05:52:32 (1536): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 05:55:06 (1536): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 05:55:26 (1536): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 06:00:55 (1536): Stopping VM.
2023-05-05 06:01:03 (1536): Successfully stopped VM.
2023-05-05 06:02:42 (10648): Detected: vboxwrapper 26206
2023-05-05 06:02:42 (10648): Detected: BOINC client v7.22.0
2023-05-05 06:02:43 (10648): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-05 06:02:43 (10648): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-05 06:02:44 (10648): Starting VM using VBoxManage interface. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 06:02:53 (10648): Successfully started VM. (PID = '4916')
2023-05-05 06:02:53 (10648): Reporting VM Process ID to BOINC.
2023-05-05 06:02:53 (10648): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-05 06:02:53 (10648): Detected: Web Application Enabled (http://localhost:55471)
2023-05-05 06:02:53 (10648): Status Report: Job Duration: '64800.000000'
2023-05-05 06:02:53 (10648): Status Report: Elapsed Time: '26754.835823'
2023-05-05 06:02:53 (10648): Status Report: CPU Time: '27638.656250'
2023-05-05 06:02:53 (10648): Preference change detected
2023-05-05 06:02:53 (10648): Setting CPU throttle for VM. (100%)
2023-05-05 06:02:54 (10648): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-05 06:12:15 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 06:12:37 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 06:15:36 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 06:16:01 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 06:20:20 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 06:20:40 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 06:50:35 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 06:51:02 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 06:53:44 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 06:54:04 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 07:08:33 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 07:08:53 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 07:25:56 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 07:26:22 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 07:27:34 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 07:27:54 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 07:29:20 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 07:29:41 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 07:36:10 (10648): VM state change detected. (old = 'running', new = 'paused')
2023-05-05 07:36:35 (10648): VM state change detected. (old = 'paused', new = 'running')
2023-05-05 07:40:06 (10648): Guest Log: [INFO] glidein exited with return value 0.
2023-05-05 07:40:06 (10648): Guest Log: [INFO] Shutting Down.
2023-05-05 07:40:06 (10648): VM Completion File Detected.
2023-05-05 07:40:06 (10648): VM Completion Message: glidein exited with return value 0.
.
2023-05-05 07:40:06 (10648): Powering off VM.
2023-05-05 07:40:07 (10648): Successfully stopped VM.
2023-05-05 07:40:07 (10648): Deregistering VM. (boinc_f28dd5b2311e6578, slot#3)
2023-05-05 07:40:08 (10648): Removing network bandwidth throttle group from VM.
2023-05-05 07:40:08 (10648): Removing VM from VirtualBox.
07:40:13 (10648): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN