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 |
<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