Name Theory_2743-2738086-251_1
Workunit 223776807
Created 28 Jun 2024, 0:17:09 UTC
Sent 28 Jun 2024, 3:46:44 UTC
Report deadline 9 Jul 2024, 3:46:44 UTC
Received 1 Jul 2024, 4:00:09 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10687016
Run time 12 hours 0 min 36 sec
CPU time 11 hours 33 min 37 sec
Validate state Valid
Credit 421.39
Device peak FLOPS 4.21 GFLOPS
Application version Theory Simulation v300.30 (vbox64_theory)
windows_x86_64
Peak working set size 77.71 MB
Peak swap size 80.09 MB
Peak disk usage 1.76 GB

Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 08:56:26 (1168): Successfully started VM. (PID = '14836')
2024-06-30 08:56:26 (1168): Reporting VM Process ID to BOINC.
2024-06-30 08:56:26 (1168): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 08:56:26 (1168): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 08:56:26 (1168): Preference change detected
2024-06-30 08:56:26 (1168): Setting CPU throttle for VM. (100%)
2024-06-30 08:56:27 (1168): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 08:56:33 (1168): Guest Log: 00:21:34.585749 timesync vgsvcTimeSyncWorker: Radical host time change: 4 090 429 000 000ns (HostNow=1 719 755 792 285 000 000 ns HostLast=1 719 751 701 856 000 000 ns)
2024-06-30 08:56:37 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 08:56:47 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 08:56:53 (1168): Guest Log: 00:21:45.181831 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 186 197 307 000ns (GuestNow=1 719 755 802 857 720 000 ns GuestLast=1 719 751 616 660 413 000 ns fSetTimeLastLoop=true )
2024-06-30 09:02:07 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:02:17 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:07:48 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:07:58 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:08:08 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:08:18 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:12:09 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:12:19 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:12:28 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:12:39 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:13:30 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:13:38 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:20:29 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:20:39 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:26:33 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:26:56 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:31:06 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:31:12 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:32:06 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:32:16 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:39:02 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:39:07 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:44:32 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:45:01 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:48:57 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:49:08 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:50:36 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:50:39 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:51:40 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:52:01 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:53:47 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:53:54 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 09:57:20 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 09:57:37 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:02:52 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:02:59 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:07:07 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:07:19 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:08:39 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:08:47 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:15:37 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:15:44 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:16:36 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:16:42 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:20:47 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:20:56 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:21:49 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:21:57 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:22:57 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:23:07 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:28:37 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:28:47 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:28:57 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:29:07 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:29:57 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:30:07 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:31:41 (1168): Status Report: Job Duration: '864000.000000'
2024-06-30 10:31:41 (1168): Status Report: Elapsed Time: '6000.750315'
2024-06-30 10:31:41 (1168): Status Report: CPU Time: '5345.437500'
2024-06-30 10:35:28 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:35:38 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:41:29 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:41:38 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:44:57 (1168): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 10:45:10 (1168): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 10:46:38 (1168): Stopping VM.
2024-06-30 10:47:30 (1168): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_5ff0a93d495d2b0d" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...
2024-06-30 10:47:30 (1168): VM did not stop when requested.
2024-06-30 10:47:30 (1168): VM was NOT successfully terminated.
2024-06-30 10:52:05 (8848): vboxwrapper version 26207
2024-06-30 10:52:05 (8848): BOINC client version: 7.16.11
2024-06-30 10:52:06 (8848): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 10:52:06 (8848): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 10:52:06 (8848): Guest Log: 00:21:34.585749 timesync vgsvcTimeSyncWorker: Radical host time change: 4 090 429 000 000ns (HostNow=1 719 755 792 285 000 000 ns HostLast=1 719 751 701 856 000 000 ns)
2024-06-30 10:52:06 (8848): Guest Log: 00:21:45.181831 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 186 197 307 000ns (GuestNow=1 719 755 802 857 720 000 ns GuestLast=1 719 751 616 660 413 000 ns fSetTimeLastLoop=true )
2024-06-30 10:52:06 (8848): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 10:52:12 (8848): Successfully started VM. (PID = '8112')
2024-06-30 10:52:12 (8848): Reporting VM Process ID to BOINC.
2024-06-30 10:52:12 (8848): Guest Log: BIOS: VirtualBox 6.1.12
2024-06-30 10:52:12 (8848): Guest Log: CPUID EDX: 0x178bfbff
2024-06-30 10:52:12 (8848): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-30 10:52:12 (8848): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-30 10:52:12 (8848): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 10:52:12 (8848): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 10:52:12 (8848): Stopping VM.
2024-06-30 10:52:13 (8848): Successfully stopped VM.
2024-06-30 10:57:03 (12400): vboxwrapper version 26207
2024-06-30 10:57:03 (12400): BOINC client version: 7.16.11
2024-06-30 10:57:04 (12400): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 10:57:04 (12400): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 10:57:05 (12400): Guest Log: BIOS: VirtualBox 6.1.12
2024-06-30 10:57:05 (12400): Guest Log: CPUID EDX: 0x178bfbff
2024-06-30 10:57:05 (12400): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-30 10:57:05 (12400): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-30 10:57:05 (12400): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 10:57:10 (12400): Successfully started VM. (PID = '2848')
2024-06-30 10:57:10 (12400): Reporting VM Process ID to BOINC.
2024-06-30 10:57:11 (12400): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-30 10:57:11 (12400): Guest Log: BIOS: Booting from Hard Disk...
2024-06-30 10:57:11 (12400): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 10:57:11 (12400): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 10:57:11 (12400): Status Report: Job Duration: '864000.000000'
2024-06-30 10:57:11 (12400): Status Report: Elapsed Time: '6781.441927'
2024-06-30 10:57:11 (12400): Status Report: CPU Time: '6214.406250'
2024-06-30 10:57:11 (12400): Preference change detected
2024-06-30 10:57:11 (12400): Setting CPU throttle for VM. (100%)
2024-06-30 10:57:12 (12400): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 10:57:18 (12400): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-30 10:57:18 (12400): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-30 10:57:29 (12400): Stopping VM.
2024-06-30 10:57:32 (12400): Successfully stopped VM.
2024-06-30 11:27:52 (2660): vboxwrapper version 26207
2024-06-30 11:27:52 (2660): BOINC client version: 7.16.11
2024-06-30 11:27:53 (2660): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 11:27:53 (2660): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 11:27:53 (2660): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-30 11:27:53 (2660): Guest Log: BIOS: Booting from Hard Disk...
2024-06-30 11:27:53 (2660): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-30 11:27:53 (2660): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-30 11:27:53 (2660): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 11:28:00 (2660): Successfully started VM. (PID = '13156')
2024-06-30 11:28:00 (2660): Reporting VM Process ID to BOINC.
2024-06-30 11:28:00 (2660): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 11:28:00 (2660): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 11:28:00 (2660): Status Report: Job Duration: '864000.000000'
2024-06-30 11:28:00 (2660): Status Report: Elapsed Time: '6796.730784'
2024-06-30 11:28:00 (2660): Status Report: CPU Time: '6226.281250'
2024-06-30 11:28:00 (2660): Preference change detected
2024-06-30 11:28:00 (2660): Setting CPU throttle for VM. (100%)
2024-06-30 11:28:01 (2660): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 11:28:44 (2660): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-30 11:28:44 (2660): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-30 11:28:53 (2660): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.000178 main     Log opened 2024-06-30T16:28:53.058917000Z
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.000301 main     OS Product: Linux
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.000384 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.000436 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.000488 main     Executable: /usr/sbin/VBoxService
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.000489 main     Process ID: 3212
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.000491 main     Package type: LINUX_64BITS_GENERIC
2024-06-30 11:28:53 (2660): Guest Log: 00:00:00.007192 main     5.2.6 r120293 started. Verbose level = 0
2024-06-30 11:29:18 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:29:23 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:30:22 (2660): Guest Log: 11:30:17 CDT -05:00 2024-06-30: cranky: [INFO] Detected Theory App
2024-06-30 11:30:22 (2660): Guest Log: 11:30:17 CDT -05:00 2024-06-30: cranky: [INFO] Checking CVMFS.
2024-06-30 11:30:23 (2660): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-06-30 11:30:24 (2660): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 11:30:24 (2660): Guest Log: 2.5.2.0 4133 1 27188 29814 3 1 1264727 4096000 0 65024 0 0 n/a 1 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-06-30 11:30:25 (2660): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-06-30 11:30:26 (2660): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 11:30:26 (2660): Guest Log: 2.5.2.0 4109 1 27548 24601 3 2 1264727 4096000 0 65024 0 2 0 5819 1217 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-06-30 11:30:27 (2660): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-06-30 11:30:28 (2660): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 11:30:28 (2660): Guest Log: 2.5.2.0 4086 1 27196 272 3 1 1264727 4096000 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-06-30 11:30:29 (2660): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-06-30 11:30:30 (2660): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 11:30:30 (2660): Guest Log: 2.5.2.0 4176 1 38380 19031 3 1 1264727 4096000 0 65024 0 0 n/a 5545 204 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-06-30 11:30:30 (2660): Guest Log: 11:30:25 CDT -05:00 2024-06-30: cranky: [INFO] Checking runc.
2024-06-30 11:30:40 (2660): Guest Log: 11:30:35 CDT -05:00 2024-06-30: cranky: [INFO] Creating the filesystem.
2024-06-30 11:30:40 (2660): Guest Log: 11:30:36 CDT -05:00 2024-06-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-06-30 11:30:40 (2660): Guest Log: 11:30:36 CDT -05:00 2024-06-30: cranky: [INFO] Updating config.json.
2024-06-30 11:30:41 (2660): Guest Log: 11:30:36 CDT -05:00 2024-06-30: cranky: [INFO] Running Container 'runc'.
2024-06-30 11:30:48 (2660): Guest Log: job: htmld=/shared/html/job
2024-06-30 11:30:48 (2660): Guest Log: job: unpack exitcode=0
2024-06-30 11:30:49 (2660): Guest Log: INFO: activated the work-around for ld:
2024-06-30 11:30:49 (2660): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 30 16:30 /tmp/tmp.5uYAjnDnP0/ld -> /usr/bin/ld.bfd
2024-06-30 11:30:49 (2660): Guest Log: 11:30:44 CDT -05:00 2024-06-30: cranky: [INFO] ===> [runRivet] Sun Jun 30 16:30:44 UTC 2024 [boinc pp jets 13000 40 - pythia8 8.308 default-noRap 100000 251]
2024-06-30 11:34:55 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:35:05 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:40:26 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:40:34 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:40:44 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:40:54 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:44:45 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:44:55 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:45:05 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:45:15 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:46:06 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:46:16 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:50:25 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:50:35 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:53:06 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:53:16 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:55:16 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:55:26 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 11:58:57 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 11:58:58 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:05:39 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:05:54 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:06:53 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:06:56 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:09:26 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:09:33 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:15:12 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:15:13 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:20:52 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:21:05 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:21:16 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:21:36 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:24:59 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:25:20 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:26:14 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:26:20 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:26:36 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:26:46 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:29:57 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:30:10 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:33:42 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:33:49 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:38:53 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:38:58 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:43:22 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:43:33 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:46:11 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:46:18 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:50:02 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:50:08 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:52:58 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:53:15 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:53:50 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:53:56 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:54:58 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:55:06 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 12:57:35 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 12:57:36 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:01:52 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:01:55 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:07:33 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:07:36 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:11:47 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:12:00 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:13:25 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:13:35 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:17:26 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:17:33 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:20:14 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:20:20 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:25:39 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:25:52 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:30:17 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:30:24 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:32:49 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:33:10 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:35:18 (2660): Status Report: Job Duration: '864000.000000'
2024-06-30 13:35:23 (2660): Status Report: Elapsed Time: '12797.140227'
2024-06-30 13:35:23 (2660): Status Report: CPU Time: '13214.843750'
2024-06-30 13:38:12 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:38:19 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:40:39 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:40:45 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:46:22 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:46:28 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:51:59 (2660): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 13:52:00 (2660): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 13:54:01 (2660): Stopping VM.
2024-06-30 13:54:59 (2660): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_5ff0a93d495d2b0d" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...
2024-06-30 13:55:00 (2660): VM did not stop when requested.
2024-06-30 13:55:00 (2660): VM was NOT successfully terminated.
2024-06-30 14:09:04 (3032): vboxwrapper version 26207
2024-06-30 14:09:04 (3032): BOINC client version: 7.16.11
2024-06-30 14:09:06 (3032): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 14:09:06 (3032): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 14:09:06 (3032): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-30 14:09:06 (3032): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-30 14:09:06 (3032): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.000178 main     Log opened 2024-06-30T16:28:53.058917000Z
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.000301 main     OS Product: Linux
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.000384 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.000436 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.000488 main     Executable: /usr/sbin/VBoxService
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.000489 main     Process ID: 3212
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.000491 main     Package type: LINUX_64BITS_GENERIC
2024-06-30 14:09:06 (3032): Guest Log: 00:00:00.007192 main     5.2.6 r120293 started. Verbose level = 0
2024-06-30 14:09:06 (3032): Guest Log: 11:30:17 CDT -05:00 2024-06-30: cranky: [INFO] Detected Theory App
2024-06-30 14:09:06 (3032): Guest Log: 11:30:17 CDT -05:00 2024-06-30: cranky: [INFO] Checking CVMFS.
2024-06-30 14:09:06 (3032): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-06-30 14:09:06 (3032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:09:06 (3032): Guest Log: 2.5.2.0 4133 1 27188 29814 3 1 1264727 4096000 0 65024 0 0 n/a 1 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-06-30 14:09:06 (3032): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-06-30 14:09:06 (3032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:09:06 (3032): Guest Log: 2.5.2.0 4109 1 27548 24601 3 2 1264727 4096000 0 65024 0 2 0 5819 1217 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-06-30 14:09:06 (3032): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-06-30 14:09:06 (3032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:09:06 (3032): Guest Log: 2.5.2.0 4086 1 27196 272 3 1 1264727 4096000 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-06-30 14:09:06 (3032): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-06-30 14:09:06 (3032): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:09:06 (3032): Guest Log: 2.5.2.0 4176 1 38380 19031 3 1 1264727 4096000 0 65024 0 0 n/a 5545 204 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-06-30 14:09:06 (3032): Guest Log: 11:30:25 CDT -05:00 2024-06-30: cranky: [INFO] Checking runc.
2024-06-30 14:09:06 (3032): Guest Log: 11:30:35 CDT -05:00 2024-06-30: cranky: [INFO] Creating the filesystem.
2024-06-30 14:09:06 (3032): Guest Log: 11:30:36 CDT -05:00 2024-06-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-06-30 14:09:06 (3032): Guest Log: 11:30:36 CDT -05:00 2024-06-30: cranky: [INFO] Updating config.json.
2024-06-30 14:09:06 (3032): Guest Log: 11:30:36 CDT -05:00 2024-06-30: cranky: [INFO] Running Container 'runc'.
2024-06-30 14:09:06 (3032): Guest Log: job: htmld=/shared/html/job
2024-06-30 14:09:06 (3032): Guest Log: job: unpack exitcode=0
2024-06-30 14:09:06 (3032): Guest Log: INFO: activated the work-around for ld:
2024-06-30 14:09:06 (3032): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 30 16:30 /tmp/tmp.5uYAjnDnP0/ld -> /usr/bin/ld.bfd
2024-06-30 14:09:06 (3032): Guest Log: 11:30:44 CDT -05:00 2024-06-30: cranky: [INFO] ===> [runRivet] Sun Jun 30 16:30:44 UTC 2024 [boinc pp jets 13000 40 - pythia8 8.308 default-noRap 100000 251]
2024-06-30 14:09:06 (3032): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 14:09:12 (3032): Successfully started VM. (PID = '13828')
2024-06-30 14:09:12 (3032): Reporting VM Process ID to BOINC.
2024-06-30 14:09:12 (3032): Guest Log: BIOS: VirtualBox 6.1.12
2024-06-30 14:09:12 (3032): Guest Log: CPUID EDX: 0x178bfbff
2024-06-30 14:09:12 (3032): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-30 14:09:12 (3032): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-30 14:09:12 (3032): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 14:09:12 (3032): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 14:09:12 (3032): Status Report: Job Duration: '864000.000000'
2024-06-30 14:09:12 (3032): Status Report: Elapsed Time: '13704.097758'
2024-06-30 14:09:12 (3032): Status Report: CPU Time: '14310.109375'
2024-06-30 14:09:12 (3032): Preference change detected
2024-06-30 14:09:12 (3032): Setting CPU throttle for VM. (100%)
2024-06-30 14:09:12 (3032): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 14:09:14 (3032): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-30 14:09:14 (3032): Guest Log: BIOS: Booting from Hard Disk...
2024-06-30 14:09:22 (3032): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-30 14:09:22 (3032): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-30 14:10:28 (3032): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-30 14:10:28 (3032): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-30 14:10:32 (3032): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.000158 main     Log opened 2024-06-30T19:10:32.893098000Z
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.000313 main     OS Product: Linux
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.000384 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.000436 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.000505 main     Executable: /usr/sbin/VBoxService
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.000507 main     Process ID: 3227
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.000508 main     Package type: LINUX_64BITS_GENERIC
2024-06-30 14:10:32 (3032): Guest Log: 00:00:00.009672 main     5.2.6 r120293 started. Verbose level = 0
2024-06-30 14:11:03 (3032): Stopping VM.
2024-06-30 14:11:29 (3032): Successfully stopped VM.
2024-06-30 14:14:04 (13508): vboxwrapper version 26207
2024-06-30 14:14:04 (13508): BOINC client version: 7.16.11
2024-06-30 14:14:04 (13508): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 14:14:05 (13508): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 14:14:05 (13508): Guest Log: BIOS: VirtualBox 6.1.12
2024-06-30 14:14:05 (13508): Guest Log: CPUID EDX: 0x178bfbff
2024-06-30 14:14:05 (13508): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-30 14:14:05 (13508): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-30 14:14:05 (13508): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-30 14:14:05 (13508): Guest Log: BIOS: Booting from Hard Disk...
2024-06-30 14:14:05 (13508): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-30 14:14:05 (13508): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-30 14:14:05 (13508): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-30 14:14:05 (13508): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-30 14:14:05 (13508): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.000158 main     Log opened 2024-06-30T19:10:32.893098000Z
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.000313 main     OS Product: Linux
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.000384 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.000436 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.000505 main     Executable: /usr/sbin/VBoxService
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.000507 main     Process ID: 3227
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.000508 main     Package type: LINUX_64BITS_GENERIC
2024-06-30 14:14:05 (13508): Guest Log: 00:00:00.009672 main     5.2.6 r120293 started. Verbose level = 0
2024-06-30 14:14:05 (13508): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 14:14:13 (13508): Successfully started VM. (PID = '13728')
2024-06-30 14:14:13 (13508): Reporting VM Process ID to BOINC.
2024-06-30 14:14:13 (13508): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 14:14:13 (13508): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 14:14:15 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:14:20 (13508): Status Report: Job Duration: '864000.000000'
2024-06-30 14:14:20 (13508): Status Report: Elapsed Time: '13809.097758'
2024-06-30 14:14:20 (13508): Status Report: CPU Time: '14343.562500'
2024-06-30 14:14:20 (13508): Preference change detected
2024-06-30 14:14:20 (13508): Setting CPU throttle for VM. (100%)
2024-06-30 14:14:21 (13508): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 14:14:21 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:14:51 (13508): Guest Log: 14:14:50 CDT -05:00 2024-06-30: cranky: [INFO] Detected Theory App
2024-06-30 14:14:51 (13508): Guest Log: 14:14:50 CDT -05:00 2024-06-30: cranky: [INFO] Checking CVMFS.
2024-06-30 14:14:52 (13508): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-06-30 14:14:52 (13508): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:14:52 (13508): Guest Log: 2.5.2.0 4114 4 28240 29815 0 1 1264746 4096000 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-06-30 14:14:53 (13508): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-06-30 14:14:54 (13508): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:14:54 (13508): Guest Log: 2.5.2.0 4074 4 27512 24601 0 2 1264746 4096000 0 65024 0 2 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-06-30 14:14:55 (13508): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-06-30 14:14:55 (13508): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:14:55 (13508): Guest Log: 2.5.2.0 4170 4 27180 272 3 1 1264746 4096000 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-06-30 14:14:56 (13508): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-06-30 14:14:57 (13508): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:14:57 (13508): Guest Log: 2.5.2.0 4146 4 39612 19031 3 1 1264746 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-06-30 14:14:57 (13508): Guest Log: 14:14:57 CDT -05:00 2024-06-30: cranky: [INFO] Checking runc.
2024-06-30 14:14:58 (13508): Guest Log: 14:14:58 CDT -05:00 2024-06-30: cranky: [INFO] Creating the filesystem.
2024-06-30 14:15:00 (13508): Guest Log: 14:15:00 CDT -05:00 2024-06-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-06-30 14:15:01 (13508): Guest Log: 14:15:00 CDT -05:00 2024-06-30: cranky: [INFO] Updating config.json.
2024-06-30 14:15:01 (13508): Guest Log: 14:15:00 CDT -05:00 2024-06-30: cranky: [INFO] Running Container 'runc'.
2024-06-30 14:15:22 (13508): Guest Log: job: htmld=/shared/html/job
2024-06-30 14:15:22 (13508): Guest Log: job: unpack exitcode=0
2024-06-30 14:15:22 (13508): Guest Log: INFO: activated the work-around for ld:
2024-06-30 14:15:22 (13508): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 30 19:15 /tmp/tmp.D95enULWmq/ld -> /usr/bin/ld.bfd
2024-06-30 14:15:23 (13508): Guest Log: 14:15:22 CDT -05:00 2024-06-30: cranky: [INFO] ===> [runRivet] Sun Jun 30 19:15:21 UTC 2024 [boinc pp jets 13000 40 - pythia8 8.308 default-noRap 100000 251]
2024-06-30 14:16:31 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:16:41 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:22:11 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:22:22 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:22:32 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:22:42 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:26:32 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:26:42 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:26:52 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:27:02 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:27:52 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:28:02 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:34:52 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:35:02 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:40:23 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:40:33 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:40:43 (13508): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:40:53 (13508): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:45:19 (13508): Stopping VM.
2024-06-30 14:45:50 (13508): Successfully stopped VM.
2024-06-30 14:48:56 (17248): vboxwrapper version 26207
2024-06-30 14:48:56 (17248): BOINC client version: 7.16.11
2024-06-30 14:48:57 (17248): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 14:48:57 (17248): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 14:48:58 (17248): Guest Log: 14:14:50 CDT -05:00 2024-06-30: cranky: [INFO] Detected Theory App
2024-06-30 14:48:58 (17248): Guest Log: 14:14:50 CDT -05:00 2024-06-30: cranky: [INFO] Checking CVMFS.
2024-06-30 14:48:58 (17248): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-06-30 14:48:58 (17248): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:48:58 (17248): Guest Log: 2.5.2.0 4114 4 28240 29815 0 1 1264746 4096000 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-06-30 14:48:58 (17248): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-06-30 14:48:58 (17248): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:48:58 (17248): Guest Log: 2.5.2.0 4074 4 27512 24601 0 2 1264746 4096000 0 65024 0 2 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-06-30 14:48:58 (17248): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-06-30 14:48:58 (17248): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:48:58 (17248): Guest Log: 2.5.2.0 4170 4 27180 272 3 1 1264746 4096000 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-06-30 14:48:58 (17248): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-06-30 14:48:58 (17248): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2024-06-30 14:48:58 (17248): Guest Log: 2.5.2.0 4146 4 39612 19031 3 1 1264746 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-06-30 14:48:58 (17248): Guest Log: 14:14:57 CDT -05:00 2024-06-30: cranky: [INFO] Checking runc.
2024-06-30 14:48:58 (17248): Guest Log: 14:14:58 CDT -05:00 2024-06-30: cranky: [INFO] Creating the filesystem.
2024-06-30 14:48:58 (17248): Guest Log: 14:15:00 CDT -05:00 2024-06-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-06-30 14:48:58 (17248): Guest Log: 14:15:00 CDT -05:00 2024-06-30: cranky: [INFO] Updating config.json.
2024-06-30 14:48:58 (17248): Guest Log: 14:15:00 CDT -05:00 2024-06-30: cranky: [INFO] Running Container 'runc'.
2024-06-30 14:48:58 (17248): Guest Log: job: htmld=/shared/html/job
2024-06-30 14:48:58 (17248): Guest Log: job: unpack exitcode=0
2024-06-30 14:48:58 (17248): Guest Log: INFO: activated the work-around for ld:
2024-06-30 14:48:58 (17248): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 30 19:15 /tmp/tmp.D95enULWmq/ld -> /usr/bin/ld.bfd
2024-06-30 14:48:58 (17248): Guest Log: 14:15:22 CDT -05:00 2024-06-30: cranky: [INFO] ===> [runRivet] Sun Jun 30 19:15:21 UTC 2024 [boinc pp jets 13000 40 - pythia8 8.308 default-noRap 100000 251]
2024-06-30 14:48:58 (17248): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 14:49:12 (17248): Successfully started VM. (PID = '16556')
2024-06-30 14:49:12 (17248): Reporting VM Process ID to BOINC.
2024-06-30 14:49:12 (17248): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 14:49:12 (17248): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 14:49:12 (17248): Status Report: Job Duration: '864000.000000'
2024-06-30 14:49:12 (17248): Status Report: Elapsed Time: '15530.097758'
2024-06-30 14:49:12 (17248): Status Report: CPU Time: '15041.593750'
2024-06-30 14:49:12 (17248): Preference change detected
2024-06-30 14:49:12 (17248): Setting CPU throttle for VM. (100%)
2024-06-30 14:49:55 (17248): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 14:51:07 (17248): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:51:07 (17248): Stopping VM.
2024-06-30 14:51:27 (17248): Successfully stopped VM.
2024-06-30 14:54:05 (16224): vboxwrapper version 26207
2024-06-30 14:54:05 (16224): BOINC client version: 7.16.11
2024-06-30 14:54:05 (16224): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 14:54:06 (16224): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 14:54:06 (16224): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 14:54:17 (16224): Successfully started VM. (PID = '16196')
2024-06-30 14:54:17 (16224): Reporting VM Process ID to BOINC.
2024-06-30 14:54:17 (16224): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 14:54:17 (16224): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 14:56:46 (16224): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:56:46 (16224): Status Report: Job Duration: '864000.000000'
2024-06-30 14:56:46 (16224): Status Report: Elapsed Time: '15623.904496'
2024-06-30 14:56:46 (16224): Status Report: CPU Time: '15137.281250'
2024-06-30 14:56:46 (16224): Preference change detected
2024-06-30 14:56:46 (16224): Setting CPU throttle for VM. (100%)
2024-06-30 14:56:59 (16224): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 14:56:59 (16224): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 14:58:03 (16224): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 14:58:04 (16224): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:03:43 (16224): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:04:02 (16224): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:08:05 (16224): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:08:16 (16224): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:10:49 (16224): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:10:56 (16224): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:16:23 (16224): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:16:41 (16224): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:17:27 (16224): Stopping VM.
2024-06-30 15:18:19 (16224): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_5ff0a93d495d2b0d" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...
2024-06-30 15:18:19 (16224): VM did not stop when requested.
2024-06-30 15:18:19 (16224): VM was NOT successfully terminated.
2024-06-30 15:21:11 (13612): vboxwrapper version 26207
2024-06-30 15:21:11 (13612): BOINC client version: 7.16.11
2024-06-30 15:21:12 (13612): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 15:21:12 (13612): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 15:21:13 (13612): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 15:21:21 (13612): Successfully started VM. (PID = '14300')
2024-06-30 15:21:21 (13612): Reporting VM Process ID to BOINC.
2024-06-30 15:21:21 (13612): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 15:21:21 (13612): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 15:21:21 (13612): Status Report: Job Duration: '864000.000000'
2024-06-30 15:21:21 (13612): Status Report: Elapsed Time: '16607.472586'
2024-06-30 15:21:21 (13612): Status Report: CPU Time: '16507.109375'
2024-06-30 15:21:21 (13612): Preference change detected
2024-06-30 15:21:21 (13612): Setting CPU throttle for VM. (100%)
2024-06-30 15:21:21 (13612): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 15:21:40 (13612): Stopping VM.
2024-06-30 15:21:48 (13612): Successfully stopped VM.
2024-06-30 15:26:09 (6160): vboxwrapper version 26207
2024-06-30 15:26:09 (6160): BOINC client version: 7.16.11
2024-06-30 15:26:10 (6160): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 15:26:10 (6160): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 15:26:11 (6160): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 15:26:19 (6160): Successfully started VM. (PID = '5736')
2024-06-30 15:26:19 (6160): Reporting VM Process ID to BOINC.
2024-06-30 15:26:19 (6160): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 15:26:19 (6160): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 15:26:19 (6160): Status Report: Job Duration: '864000.000000'
2024-06-30 15:26:19 (6160): Status Report: Elapsed Time: '16621.472586'
2024-06-30 15:26:19 (6160): Status Report: CPU Time: '16528.359375'
2024-06-30 15:26:19 (6160): Preference change detected
2024-06-30 15:26:19 (6160): Setting CPU throttle for VM. (100%)
2024-06-30 15:26:21 (6160): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 15:26:22 (6160): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:26:31 (6160): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:27:18 (6160): Stopping VM.
2024-06-30 15:27:32 (6160): Successfully stopped VM.
2024-06-30 15:30:18 (2528): vboxwrapper version 26207
2024-06-30 15:30:18 (2528): BOINC client version: 7.16.11
2024-06-30 15:30:18 (2528): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 15:30:19 (2528): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 15:30:19 (2528): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 15:30:29 (2528): Successfully started VM. (PID = '9220')
2024-06-30 15:30:29 (2528): Reporting VM Process ID to BOINC.
2024-06-30 15:30:29 (2528): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 15:30:29 (2528): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 15:30:30 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:30:34 (2528): Status Report: Job Duration: '864000.000000'
2024-06-30 15:30:34 (2528): Status Report: Elapsed Time: '16668.472586'
2024-06-30 15:30:34 (2528): Status Report: CPU Time: '16576.312500'
2024-06-30 15:30:34 (2528): Preference change detected
2024-06-30 15:30:34 (2528): Setting CPU throttle for VM. (100%)
2024-06-30 15:30:36 (2528): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 15:30:36 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:35:15 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:35:25 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:40:44 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:40:54 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:45:31 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:45:37 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:47:09 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:47:21 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:48:10 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:48:21 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:50:27 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:50:37 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:53:44 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:53:47 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 15:55:58 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 15:56:05 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:01:55 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:01:58 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:07:18 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:07:27 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:09:52 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:09:57 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:12:14 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:12:26 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:15:23 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:15:36 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:21:04 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:21:09 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:25:26 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:25:32 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:28:51 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:29:21 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:33:26 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:33:31 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:34:43 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:34:54 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:39:15 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:39:20 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:41:30 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:41:36 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:44:00 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:44:02 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:46:24 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:46:30 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:47:20 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:47:32 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:51:48 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:51:52 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:54:22 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:54:28 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:56:35 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:56:48 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 16:59:53 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 16:59:59 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:04:02 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:04:15 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:06:43 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:06:50 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:09:48 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:09:54 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:15:13 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:15:18 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:17:07 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:17:15 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:18:37 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:18:50 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:24:17 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:24:28 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:29:34 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:29:40 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:29:57 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:30:02 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:34:01 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:34:13 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:36:50 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:37:03 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:38:52 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:38:57 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:42:20 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:42:26 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:46:06 (2528): Status Report: Job Duration: '864000.000000'
2024-06-30 17:46:06 (2528): Status Report: Elapsed Time: '22668.902882'
2024-06-30 17:46:06 (2528): Status Report: CPU Time: '24505.609375'
2024-06-30 17:48:11 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:48:17 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:53:27 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:53:54 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 17:57:52 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 17:57:59 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:00:35 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 18:00:51 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:05:46 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 18:05:51 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:06:05 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 18:06:13 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:10:25 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 18:10:43 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:11:48 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 18:12:02 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:16:01 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 18:16:11 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:24:33 (2528): VM state change detected. (old = 'running', new = 'paused')
2024-06-30 18:24:44 (2528): VM state change detected. (old = 'paused', new = 'running')
2024-06-30 18:27:11 (2528): Stopping VM.
2024-06-30 18:28:10 (2528): Successfully stopped VM.
2024-06-30 18:36:00 (13176): vboxwrapper version 26207
2024-06-30 18:36:00 (13176): BOINC client version: 7.16.11
2024-06-30 18:36:01 (13176): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 18:36:01 (13176): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 18:36:02 (13176): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 18:36:10 (13176): Successfully started VM. (PID = '12828')
2024-06-30 18:36:10 (13176): Reporting VM Process ID to BOINC.
2024-06-30 18:36:10 (13176): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 18:36:10 (13176): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 18:36:10 (13176): Stopping VM.
2024-06-30 18:36:15 (13176): Successfully stopped VM.
2024-06-30 18:39:09 (720): vboxwrapper version 26207
2024-06-30 18:39:09 (720): BOINC client version: 7.16.11
2024-06-30 18:39:10 (720): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-06-30 18:39:10 (720): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-30 18:39:11 (720): Starting VM using VBoxManage interface. (boinc_5ff0a93d495d2b0d, slot#6)
2024-06-30 18:39:20 (720): Successfully started VM. (PID = '5408')
2024-06-30 18:39:20 (720): Reporting VM Process ID to BOINC.
2024-06-30 18:39:20 (720): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-30 18:39:20 (720): Detected: Web Application Enabled (http://localhost:58739)
2024-06-30 18:39:20 (720): Status Report: Job Duration: '864000.000000'
2024-06-30 18:39:20 (720): Status Report: Elapsed Time: '24616.573834'
2024-06-30 18:39:20 (720): Status Report: CPU Time: '26902.437500'
2024-06-30 18:39:20 (720): Preference change detected
2024-06-30 18:39:20 (720): Setting CPU throttle for VM. (100%)
2024-06-30 18:39:30 (720): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-30 20:22:39 (720): Status Report: Job Duration: '864000.000000'
2024-06-30 20:22:39 (720): Status Report: Elapsed Time: '30616.671563'
2024-06-30 20:22:39 (720): Status Report: CPU Time: '33055.937500'
2024-06-30 22:17:11 (720): Status Report: Job Duration: '864000.000000'
2024-06-30 22:17:11 (720): Status Report: Elapsed Time: '36617.347027'
2024-06-30 22:17:11 (720): Status Report: CPU Time: '39875.109375'
2024-06-30 22:47:31 (720): Guest Log: job: run exitcode=0
2024-06-30 22:47:31 (720): Guest Log: job: diskusage=17328
2024-06-30 22:47:31 (720): Guest Log: job: logsize=96 k
2024-06-30 22:47:31 (720): Guest Log: job: times=
2024-06-30 22:47:31 (720): Guest Log: 0m0.034s 0m0.037s
2024-06-30 22:47:31 (720): Guest Log: 448m52.530s 5m31.967s
2024-06-30 22:47:31 (720): Guest Log: job: cpuusage=27265
2024-06-30 22:47:34 (720): Guest Log: 22:47:33 CDT -05:00 2024-06-30: cranky: [INFO] Container 'runc' finished with status code 0.
2024-06-30 22:47:34 (720): Guest Log: 22:47:33 CDT -05:00 2024-06-30: cranky: [INFO] Preparing output.
2024-06-30 22:47:43 (720): Guest Log: [INFO] Job Finished
2024-06-30 22:47:43 (720): Guest Log: [INFO] Shutting Down.
2024-06-30 22:47:43 (720): VM Completion File Detected.
2024-06-30 22:47:43 (720): 


©2024 CERN