Name Theory_2914-4755699-9_0
Workunit 232843721
Created 4 Jun 2025, 4:21:16 UTC
Sent 4 Jun 2025, 18:44:16 UTC
Report deadline 15 Jun 2025, 18:44:16 UTC
Received 6 Jun 2025, 1:05:35 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10845147
Run time 16 hours 8 min 6 sec
CPU time 19 min 59 sec
Validate state Valid
Credit 401.56
Device peak FLOPS 2.99 GFLOPS
Application version Theory Simulation v300.95 (vbox64_theory)
windows_x86_64
Peak working set size 92.71 MB
Peak swap size 109.35 MB
Peak disk usage 2.84 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
cted. (old = 'running', new = 'paused')
2025-06-05 07:20:11 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:20:21 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:20:41 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:20:51 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:21:11 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:21:22 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:21:42 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:21:52 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:22:12 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:22:22 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:22:42 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:23:04 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:23:22 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:23:34 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:23:53 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:24:28 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:24:42 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:25:25 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:25:42 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:25:53 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:26:13 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:26:53 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:27:13 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:27:36 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:27:53 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:28:03 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:28:24 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:28:34 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:28:54 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:29:06 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:29:24 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:29:35 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:29:54 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:30:05 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:30:24 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:30:34 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:30:54 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:31:13 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:31:34 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:31:44 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:32:04 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:32:14 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:32:34 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:32:44 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:33:04 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:33:14 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:33:34 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:33:44 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:34:04 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:34:11 (26228): Guest Log: job: run exitcode=1
2025-06-05 07:34:11 (26228): Guest Log: job: diskusage=9076
2025-06-05 07:34:11 (26228): Guest Log: job: logsize=24 k
2025-06-05 07:34:11 (26228): Guest Log: job: times=
2025-06-05 07:34:11 (26228): Guest Log: 0m0.006s 0m0.010s
2025-06-05 07:34:11 (26228): Guest Log: 1m31.582s 0m22.221s
2025-06-05 07:34:11 (26228): Guest Log: job: cpuusage=114
2025-06-05 07:34:14 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:34:34 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:34:37 (26228): Guest Log: Job Finished
2025-06-05 07:34:37 (26228): Guest Log: boinc_shutdown called with exit code 0
2025-06-05 07:34:37 (26228): Guest Log: sd_delay: 812
2025-06-05 07:34:37 (26228): Guest Log: ETA: 2025-06-05 05:36:58 UTC
2025-06-05 07:34:44 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:35:04 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:35:14 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:35:34 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:35:57 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:36:15 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:36:35 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:36:55 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:37:36 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:37:56 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:38:46 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:39:06 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:39:26 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:39:46 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:39:56 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:40:16 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:40:46 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:41:06 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:41:56 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:42:16 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:42:46 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:43:06 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:43:16 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:43:36 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:43:47 (26228): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 07:44:07 (26228): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 07:45:04 (26228): Stopping VM.
2025-06-05 07:45:52 (26228): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_dc498db5cf1776a4" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...
2025-06-05 07:45:52 (26228): VM did not stop when requested.
2025-06-05 07:45:52 (26228): VM was NOT successfully terminated.
2025-06-05 10:07:51 (8900): vboxwrapper version 26210
2025-06-05 10:07:51 (8900): BOINC client version: 8.0.2
2025-06-05 10:07:54 (8900): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2025-06-05 10:07:54 (8900): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-06-05 10:07:59 (8900): Guest Log: job: run exitcode=1
2025-06-05 10:07:59 (8900): Guest Log: job: diskusage=9076
2025-06-05 10:07:59 (8900): Guest Log: job: logsize=24 k
2025-06-05 10:07:59 (8900): Guest Log: job: times=
2025-06-05 10:07:59 (8900): Guest Log: 0m0.006s 0m0.010s
2025-06-05 10:07:59 (8900): Guest Log: 1m31.582s 0m22.221s
2025-06-05 10:07:59 (8900): Guest Log: job: cpuusage=114
2025-06-05 10:07:59 (8900): Guest Log: Job Finished
2025-06-05 10:07:59 (8900): Guest Log: boinc_shutdown called with exit code 0
2025-06-05 10:07:59 (8900): Guest Log: sd_delay: 812
2025-06-05 10:07:59 (8900): Guest Log: ETA: 2025-06-05 05:36:58 UTC
2025-06-05 10:07:59 (8900): Starting VM using VBoxManage interface. (boinc_dc498db5cf1776a4, slot#21)
2025-06-05 10:08:09 (8900): Successfully started VM. (PID = '24852')
2025-06-05 10:08:09 (8900): Reporting VM Process ID to BOINC.
2025-06-05 10:08:09 (8900): Guest Log: BIOS: VirtualBox 7.0.14
2025-06-05 10:08:09 (8900): Guest Log: CPUID EDX: 0x178bfbff
2025-06-05 10:08:09 (8900): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-05 10:08:09 (8900): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors
2025-06-05 10:08:09 (8900): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-05 10:08:09 (8900): Detected: Web Application Enabled (http://localhost:61656)
2025-06-05 10:08:09 (8900): Detected: Remote Desktop Enabled (localhost:61657)
2025-06-05 10:08:11 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:08:26 (8900): Status Report: Job Duration: '864000.000000'
2025-06-05 10:08:26 (8900): Status Report: Elapsed Time: '28494.672755'
2025-06-05 10:08:26 (8900): Status Report: CPU Time: '558.906250'
2025-06-05 10:08:26 (8900): Preference change detected
2025-06-05 10:08:26 (8900): Setting CPU throttle for VM. (95%)
2025-06-05 10:08:26 (8900): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-05 10:08:27 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:08:28 (8900): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-05 10:08:28 (8900): Guest Log: BIOS: Booting from Hard Disk...
2025-06-05 10:08:46 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:09:06 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:09:08 (8900): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-05 10:09:08 (8900): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-06-05 10:09:08 (8900): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-06-05 10:09:17 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:09:37 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:09:47 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:10:07 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:10:19 (8900): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-05 10:10:19 (8900): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol
2025-06-05 10:10:19 (8900): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084
2025-06-05 10:10:19 (8900): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-05 10:10:19 (8900): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29
2025-06-05 10:10:19 (8900): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00)
2025-06-05 10:10:27 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:10:47 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:10:57 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:11:17 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:11:23 (8900): Guest Log: Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2025-06-05 10:11:23 (8900): Guest Log: Will use proxies from there for CVMFS and Frontier
2025-06-05 10:11:23 (8900): Guest Log: Using custom CVMFS.
2025-06-05 10:11:23 (8900): Guest Log: Probing CVMFS repositories ...
2025-06-05 10:11:27 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:11:47 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:11:56 (8900): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-06-05 10:11:56 (8900): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK
2025-06-05 10:11:56 (8900): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-06-05 10:11:56 (8900): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-06-05 10:11:57 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:12:17 (8900): Guest Log: Excerpt from "cvmfs_config stat":
2025-06-05 10:12:17 (8900): Guest Log: VERSION   HOST                            PROXY
2025-06-05 10:12:17 (8900): Guest Log: 2.12.7.0  http://s1cern-cvmfs.openhtc.io  DIRECT
2025-06-05 10:12:17 (8900): Guest Log: ******************************************************************
2025-06-05 10:12:17 (8900): Guest Log:                         IMPORTANT HINT(S)!
2025-06-05 10:12:17 (8900): Guest Log: ******************************************************************
2025-06-05 10:12:17 (8900): Guest Log: CVMFS server: http://s1cern-cvmfs.openhtc.io
2025-06-05 10:12:17 (8900): Guest Log: CVMFS proxy:  DIRECT
2025-06-05 10:12:17 (8900): Guest Log: No local HTTP proxy found.
2025-06-05 10:12:17 (8900): Guest Log: With this setup concurrently running containers can't share
2025-06-05 10:12:17 (8900): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore
2025-06-05 10:12:17 (8900): Guest Log: highly recommended.
2025-06-05 10:12:17 (8900): Guest Log: More info how to configure a local HTTP proxy:
2025-06-05 10:12:17 (8900): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473
2025-06-05 10:12:17 (8900): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474
2025-06-05 10:12:17 (8900): Guest Log: ******************************************************************
2025-06-05 10:12:17 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:12:18 (8900): Guest Log: Environment HTTP proxy: not set
2025-06-05 10:12:24 (8900): Guest Log: job: htmld=/var/www/lighttpd
2025-06-05 10:12:26 (8900): Guest Log: job: unpack exitcode=0
2025-06-05 10:12:48 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:13:07 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:13:27 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:13:46 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:14:26 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:14:46 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:15:36 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:15:57 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:16:06 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:16:27 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:16:36 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:16:56 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:17:07 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:17:28 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:17:38 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:17:58 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:18:08 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:18:28 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:18:38 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:18:58 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:19:09 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:19:28 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:19:38 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:19:58 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:20:08 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:20:28 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:20:38 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:20:58 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:21:08 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:21:28 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:21:38 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:21:58 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:22:09 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:22:29 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:30:32 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:30:52 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:34:12 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:34:32 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:45:34 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:45:54 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:49:04 (8900): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 10:49:24 (8900): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 10:52:33 (8900): Stopping VM.
2025-06-05 10:52:38 (8900): Successfully stopped VM.
2025-06-05 14:15:47 (880): vboxwrapper version 26210
2025-06-05 14:15:47 (880): BOINC client version: 8.0.2
2025-06-05 14:15:49 (880): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2025-06-05 14:15:49 (880): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-06-05 14:15:52 (880): Guest Log: BIOS: VirtualBox 7.0.14
2025-06-05 14:15:52 (880): Guest Log: CPUID EDX: 0x178bfbff
2025-06-05 14:15:52 (880): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-05 14:15:52 (880): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors
2025-06-05 14:15:52 (880): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-05 14:15:52 (880): Guest Log: BIOS: Booting from Hard Disk...
2025-06-05 14:15:52 (880): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-05 14:15:52 (880): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-06-05 14:15:52 (880): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-06-05 14:15:52 (880): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-05 14:15:52 (880): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol
2025-06-05 14:15:52 (880): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084
2025-06-05 14:15:52 (880): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-05 14:15:52 (880): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29
2025-06-05 14:15:52 (880): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00)
2025-06-05 14:15:52 (880): Guest Log: Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2025-06-05 14:15:52 (880): Guest Log: Will use proxies from there for CVMFS and Frontier
2025-06-05 14:15:52 (880): Guest Log: Using custom CVMFS.
2025-06-05 14:15:52 (880): Guest Log: Probing CVMFS repositories ...
2025-06-05 14:15:52 (880): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-06-05 14:15:52 (880): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK
2025-06-05 14:15:52 (880): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-06-05 14:15:52 (880): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-06-05 14:15:52 (880): Guest Log: Excerpt from "cvmfs_config stat":
2025-06-05 14:15:52 (880): Guest Log: VERSION   HOST                            PROXY
2025-06-05 14:15:52 (880): Guest Log: 2.12.7.0  http://s1cern-cvmfs.openhtc.io  DIRECT
2025-06-05 14:15:52 (880): Guest Log: ******************************************************************
2025-06-05 14:15:52 (880): Guest Log:                         IMPORTANT HINT(S)!
2025-06-05 14:15:52 (880): Guest Log: ******************************************************************
2025-06-05 14:15:52 (880): Guest Log: CVMFS server: http://s1cern-cvmfs.openhtc.io
2025-06-05 14:15:52 (880): Guest Log: CVMFS proxy:  DIRECT
2025-06-05 14:15:52 (880): Guest Log: No local HTTP proxy found.
2025-06-05 14:15:52 (880): Guest Log: With this setup concurrently running containers can't share
2025-06-05 14:15:52 (880): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore
2025-06-05 14:15:52 (880): Guest Log: highly recommended.
2025-06-05 14:15:52 (880): Guest Log: More info how to configure a local HTTP proxy:
2025-06-05 14:15:52 (880): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473
2025-06-05 14:15:52 (880): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474
2025-06-05 14:15:52 (880): Guest Log: ******************************************************************
2025-06-05 14:15:52 (880): Guest Log: Environment HTTP proxy: not set
2025-06-05 14:15:52 (880): Guest Log: job: htmld=/var/www/lighttpd
2025-06-05 14:15:52 (880): Guest Log: job: unpack exitcode=0
2025-06-05 14:15:52 (880): Starting VM using VBoxManage interface. (boinc_dc498db5cf1776a4, slot#21)
2025-06-05 14:16:06 (880): Successfully started VM. (PID = '21700')
2025-06-05 14:16:06 (880): Reporting VM Process ID to BOINC.
2025-06-05 14:16:06 (880): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-05 14:16:06 (880): Detected: Web Application Enabled (http://localhost:61656)
2025-06-05 14:16:06 (880): Detected: Remote Desktop Enabled (localhost:61657)
2025-06-05 14:16:06 (880): Status Report: Job Duration: '864000.000000'
2025-06-05 14:16:06 (880): Status Report: Elapsed Time: '30549.680758'
2025-06-05 14:16:06 (880): Status Report: CPU Time: '713.015625'
2025-06-05 14:16:06 (880): Preference change detected
2025-06-05 14:16:06 (880): Setting CPU throttle for VM. (95%)
2025-06-05 14:16:07 (880): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-05 14:19:02 (880): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 14:19:21 (880): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 14:24:12 (880): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 14:24:32 (880): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 14:28:44 (880): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 14:29:03 (880): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 14:29:24 (880): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 14:29:44 (880): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 14:29:55 (880): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 14:30:13 (880): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 14:33:01 (880): Stopping VM.
2025-06-05 14:33:48 (880): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_dc498db5cf1776a4" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...
2025-06-05 14:33:51 (880): VM did not stop when requested.
2025-06-05 14:33:51 (880): VM was NOT successfully terminated.
2025-06-05 16:31:33 (7232): vboxwrapper version 26210
2025-06-05 16:31:33 (7232): BOINC client version: 8.0.2
2025-06-05 16:31:35 (7232): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2025-06-05 16:31:35 (7232): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-06-05 16:31:41 (7232): Starting VM using VBoxManage interface. (boinc_dc498db5cf1776a4, slot#21)
2025-06-05 16:31:51 (7232): Successfully started VM. (PID = '19232')
2025-06-05 16:31:51 (7232): Reporting VM Process ID to BOINC.
2025-06-05 16:31:51 (7232): Guest Log: BIOS: VirtualBox 7.0.14
2025-06-05 16:31:51 (7232): Guest Log: CPUID EDX: 0x178bfbff
2025-06-05 16:31:51 (7232): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-05 16:31:51 (7232): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors
2025-06-05 16:31:51 (7232): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-05 16:31:51 (7232): Detected: Web Application Enabled (http://localhost:61656)
2025-06-05 16:31:51 (7232): Detected: Remote Desktop Enabled (localhost:61657)
2025-06-05 16:31:52 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 16:32:08 (7232): Status Report: Job Duration: '864000.000000'
2025-06-05 16:32:08 (7232): Status Report: Elapsed Time: '31458.680758'
2025-06-05 16:32:08 (7232): Status Report: CPU Time: '734.343750'
2025-06-05 16:32:08 (7232): Preference change detected
2025-06-05 16:32:08 (7232): Setting CPU throttle for VM. (95%)
2025-06-05 16:32:09 (7232): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-05 16:32:09 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 16:32:10 (7232): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-05 16:32:10 (7232): Guest Log: BIOS: Booting from Hard Disk...
2025-06-05 16:32:19 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 16:32:39 (7232): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-05 16:32:39 (7232): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-06-05 16:32:39 (7232): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-06-05 16:32:39 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 16:32:49 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 16:33:09 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 16:34:03 (7232): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-05 16:34:03 (7232): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol
2025-06-05 16:34:03 (7232): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084
2025-06-05 16:34:03 (7232): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-05 16:34:04 (7232): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29
2025-06-05 16:34:04 (7232): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00)
2025-06-05 16:34:09 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 16:34:29 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 16:35:30 (7232): Guest Log: Got a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2025-06-05 16:35:30 (7232): Guest Log: Will use proxies from there for CVMFS and Frontier
2025-06-05 16:35:30 (7232): Guest Log: Using custom CVMFS.
2025-06-05 16:35:32 (7232): Guest Log: Probing CVMFS repositories ...
2025-06-05 16:37:03 (7232): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-06-05 16:37:03 (7232): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK
2025-06-05 16:37:03 (7232): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-06-05 16:37:03 (7232): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-06-05 16:37:05 (7232): Guest Log: Excerpt from "cvmfs_config stat":
2025-06-05 16:37:05 (7232): Guest Log: VERSION   HOST                            PROXY
2025-06-05 16:37:05 (7232): Guest Log: 2.12.7.0  http://s1cern-cvmfs.openhtc.io  DIRECT
2025-06-05 16:37:05 (7232): Guest Log: ******************************************************************
2025-06-05 16:37:05 (7232): Guest Log:                         IMPORTANT HINT(S)!
2025-06-05 16:37:05 (7232): Guest Log: ******************************************************************
2025-06-05 16:37:05 (7232): Guest Log: CVMFS server: http://s1cern-cvmfs.openhtc.io
2025-06-05 16:37:05 (7232): Guest Log: CVMFS proxy:  DIRECT
2025-06-05 16:37:05 (7232): Guest Log: No local HTTP proxy found.
2025-06-05 16:37:05 (7232): Guest Log: With this setup concurrently running containers can't share
2025-06-05 16:37:05 (7232): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore
2025-06-05 16:37:05 (7232): Guest Log: highly recommended.
2025-06-05 16:37:05 (7232): Guest Log: More info how to configure a local HTTP proxy:
2025-06-05 16:37:05 (7232): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473
2025-06-05 16:37:05 (7232): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474
2025-06-05 16:37:05 (7232): Guest Log: ******************************************************************
2025-06-05 16:37:06 (7232): Guest Log: Environment HTTP proxy: not set
2025-06-05 16:37:12 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 16:37:31 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 16:37:44 (7232): Guest Log: job: htmld=/var/www/lighttpd
2025-06-05 16:37:45 (7232): Guest Log: job: unpack exitcode=0
2025-06-05 16:46:45 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 16:47:04 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 16:47:36 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 16:47:54 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 17:06:11 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 17:06:29 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 17:15:01 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 17:15:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 17:16:31 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 17:16:51 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 17:37:10 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 17:37:28 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 17:38:40 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 17:38:59 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 17:48:15 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 17:48:34 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 18:00:29 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 18:00:49 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 18:00:59 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 18:01:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 18:03:31 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 18:03:32 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 18:17:14 (7232): Status Report: Job Duration: '864000.000000'
2025-06-05 18:17:14 (7232): Status Report: Elapsed Time: '37458.680758'
2025-06-05 18:17:14 (7232): Status Report: CPU Time: '939.437500'
2025-06-05 18:48:14 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 18:48:34 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 18:49:08 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 18:49:25 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 18:51:06 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 18:51:25 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 19:33:14 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 19:33:34 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 19:35:35 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 19:35:54 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 19:36:15 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 19:36:34 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 19:59:25 (7232): Status Report: Job Duration: '864000.000000'
2025-06-05 19:59:25 (7232): Status Report: Elapsed Time: '43458.680758'
2025-06-05 19:59:25 (7232): Status Report: CPU Time: '997.421875'
2025-06-05 20:24:14 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 20:24:34 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 20:24:54 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 20:25:15 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 20:34:36 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 20:34:56 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 21:08:25 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 21:08:45 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 21:08:56 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 21:09:16 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 21:41:17 (7232): Status Report: Job Duration: '864000.000000'
2025-06-05 21:41:17 (7232): Status Report: Elapsed Time: '49459.235203'
2025-06-05 21:41:17 (7232): Status Report: CPU Time: '1035.921875'
2025-06-05 21:50:02 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 21:50:22 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 21:58:35 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 21:58:55 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 22:01:06 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 22:01:24 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 22:26:27 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 22:26:47 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 22:36:19 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 22:36:39 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 22:47:02 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 22:47:21 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 22:59:43 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:00:04 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:02:54 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:03:15 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:12:47 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:13:07 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:24:32 (7232): Status Report: Job Duration: '864000.000000'
2025-06-05 23:24:32 (7232): Status Report: Elapsed Time: '55459.235203'
2025-06-05 23:24:32 (7232): Status Report: CPU Time: '1073.796875'
2025-06-05 23:26:41 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:26:58 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:32:23 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:32:39 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:32:49 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:33:09 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:38:11 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:38:31 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:38:52 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:39:12 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:41:02 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:41:22 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:43:23 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:43:43 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:45:14 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:45:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:45:53 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:46:13 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:46:44 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:47:03 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:47:13 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:47:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:47:44 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:48:04 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:48:44 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:49:04 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:49:17 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:49:35 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:49:57 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:50:15 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:50:26 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:50:45 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:51:00 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:51:16 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:51:46 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:52:05 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:52:15 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:52:35 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:52:47 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:53:06 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:53:27 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:53:46 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:54:08 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:54:26 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:55:00 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:55:17 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:55:27 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:55:47 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-05 23:58:37 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-05 23:58:57 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:00:17 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:00:37 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:00:47 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:01:07 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:01:31 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:01:48 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:02:00 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:02:17 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:03:21 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:03:22 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:05:21 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:05:39 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:05:49 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:06:09 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:06:20 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:06:39 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:06:49 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:07:09 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:07:19 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:07:39 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:07:49 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:08:10 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:08:20 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:08:41 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:09:00 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:09:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:09:30 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:09:50 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:10:00 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:10:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:10:30 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:10:50 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:11:02 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:11:19 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:11:29 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:11:49 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:12:02 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:12:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:12:30 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:12:50 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:13:05 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:13:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:13:31 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:13:51 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:14:00 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:14:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:14:34 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:14:50 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:15:00 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:15:20 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:15:33 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:15:51 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:16:01 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:16:21 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:16:32 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:16:50 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:17:03 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:17:21 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:17:39 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:17:51 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:18:01 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:18:21 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:18:33 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:18:51 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:19:01 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:19:21 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:19:37 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:19:51 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:20:01 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:20:21 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:20:31 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:20:52 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:21:01 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:21:22 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:21:32 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:21:52 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:22:09 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:22:22 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:22:33 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:22:51 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:23:01 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:23:22 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:23:41 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:24:01 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:24:11 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:24:31 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:24:41 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:25:01 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:25:13 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:25:32 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:25:42 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:26:02 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:26:12 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:26:32 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:26:49 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:27:02 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:27:12 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:27:32 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:27:43 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:28:02 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:28:12 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:28:32 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:28:42 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:29:02 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:29:13 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:29:32 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:29:42 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:30:02 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:30:16 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:30:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:30:44 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:31:02 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:31:12 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:31:32 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:31:43 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:32:03 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:32:14 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:32:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:32:50 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:33:03 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:33:13 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:33:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:33:43 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:34:03 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:34:13 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:34:36 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:34:43 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:35:03 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:35:13 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:35:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:35:43 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:36:03 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:36:15 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:36:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:36:50 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:37:03 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:37:15 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:37:33 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:37:44 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:38:04 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:38:14 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:38:38 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 00:38:57 (7232): VM state change detected. (old = 'running', new = 'paused')
2025-06-06 00:38:58 (7232): VM state change detected. (old = 'paused', new = 'running')
2025-06-06 01:38:08 (7232): Status Report: Job Duration: '864000.000000'
2025-06-06 01:38:08 (7232): Status Report: Elapsed Time: '61460.184786'
2025-06-06 01:38:08 (7232): Status Report: CPU Time: '1116.765625'
2025-06-06 02:03:10 (7232): Guest Log: job: run exitcode=1
2025-06-06 02:03:11 (7232): Guest Log: job: diskusage=9076
2025-06-06 02:03:11 (7232): Guest Log: job: logsize=24 k
2025-06-06 02:03:11 (7232): Guest Log: job: times=
2025-06-06 02:03:11 (7232): Guest Log: 0m0.007s 0m0.010s
2025-06-06 02:03:11 (7232):


©2025 CERN