Name Theory_2773-2925198-299_2
Workunit 229833128
Created 19 Jan 2025, 1:04:43 UTC
Sent 19 Jan 2025, 5:48:21 UTC
Report deadline 30 Jan 2025, 5:48:21 UTC
Received 4 Feb 2025, 3:58:40 UTC
Server state Over
Outcome Computation error
Client state Aborted by user
Exit status 203 (0x000000CB) EXIT_ABORTED_VIA_GUI
Computer ID 10651600
Run time 1 days 12 hours 44 min 45 sec
CPU time 16 hours 53 min 14 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 5.28 GFLOPS
Application version Theory Simulation v300.60 (vbox64_theory)
windows_x86_64
Peak working set size 86.61 MB
Peak swap size 79.73 MB
Peak disk usage 2.78 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
aborted by user</message>
<stderr_txt>
5-01-31 12:15:22 (11016): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-31 12:15:22 (11016): 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
2025-01-31 12:15:22 (11016): Guest Log: 2.5.2.0 4074 94 26096 31592 3 1 2110107 4096001 0 65024 0 0 n/a 5 2 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-31 12:15:22 (11016): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-31 12:15:22 (11016): 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
2025-01-31 12:15:22 (11016): Guest Log: 2.5.2.0 4096 94 25612 26349 3 2 2110107 4096001 0 65024 0 2 0 7947 1368 http://s1ihep-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-31 12:15:22 (11016): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-31 12:15:22 (11016): 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
2025-01-31 12:15:22 (11016): Guest Log: 2.5.2.0 4137 94 25148 272 3 1 2110107 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-31 12:15:22 (11016): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-31 12:15:22 (11016): 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
2025-01-31 12:15:22 (11016): Guest Log: 2.5.2.0 4116 94 39632 21014 3 1 2110107 4096001 0 65024 0 0 n/a 6615 1272 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-31 12:15:22 (11016): Guest Log: 10:32:19 CST +08:00 2025-01-30: cranky: [INFO] Checking runc.
2025-01-31 12:15:22 (11016): Guest Log: 10:32:19 CST +08:00 2025-01-30: cranky: [INFO] Creating the filesystem.
2025-01-31 12:15:22 (11016): Guest Log: 10:32:20 CST +08:00 2025-01-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-31 12:15:22 (11016): Guest Log: 10:32:20 CST +08:00 2025-01-30: cranky: [INFO] Updating config.json.
2025-01-31 12:15:22 (11016): Guest Log: 10:32:20 CST +08:00 2025-01-30: cranky: [INFO] Running Container 'runc'.
2025-01-31 12:15:22 (11016): Guest Log: job: htmld=/shared/html/job
2025-01-31 12:15:22 (11016): Guest Log: job: unpack exitcode=0
2025-01-31 12:15:22 (11016): Guest Log: INFO: activated the work-around for ld:
2025-01-31 12:15:22 (11016): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 30 02:32 /tmp/tmp.Gq0sk2yEyl/ld -> /usr/bin/ld.bfd
2025-01-31 12:15:22 (11016): Guest Log: 10:32:24 CST +08:00 2025-01-30: cranky: [INFO] ===> [runRivet] Thu Jan 30 02:32:23 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-01-31 12:15:22 (11016): Guest Log: 00:10:54.752161 timesync vgsvcTimeSyncWorker: Radical host time change: 3 992 795 000 000ns (HostNow=1 738 209 112 939 000 000 ns HostLast=1 738 205 120 144 000 000 ns)
2025-01-31 12:15:22 (11016): Guest Log: 00:11:05.424508 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 172 553 168 000ns (GuestNow=1 738 209 124 060 426 000 ns GuestLast=1 738 204 951 507 258 000 ns fSetTimeLastLoop=true )
2025-01-31 12:15:22 (11016): Guest Log: 00:46:13.992180 timesync vgsvcTimeSyncWorker: Radical host time change: 11 132 474 000 000ns (HostNow=1 738 222 554 823 000 000 ns HostLast=1 738 211 422 349 000 000 ns)
2025-01-31 12:15:22 (11016): Guest Log: 00:46:24.133726 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 332 774 680 000ns (GuestNow=1 738 222 565 197 844 000 ns GuestLast=1 738 211 232 423 164 000 ns fSetTimeLastLoop=true )
2025-01-31 12:15:22 (11016): Guest Log: 00:53:24.713878 timesync vgsvcTimeSyncWorker: Radical host time change: 2 225 568 000 000ns (HostNow=1 738 225 201 346 000 000 ns HostLast=1 738 222 975 778 000 000 ns)
2025-01-31 12:15:22 (11016): Guest Log: 00:53:34.762707 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 225 616 911 000ns (GuestNow=1 738 225 211 394 862 000 ns GuestLast=1 738 222 985 777 951 000 ns fSetTimeLastLoop=true )
2025-01-31 12:15:22 (11016): Guest Log: 00:57:55.184611 timesync vgsvcTimeSyncWorker: Radical host time change: 5 067 291 000 000ns (HostNow=1 738 231 684 065 000 000 ns HostLast=1 738 226 616 774 000 000 ns)
2025-01-31 12:15:22 (11016): Guest Log: 00:58:05.185651 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 222 249 292 000ns (GuestNow=1 738 231 694 066 047 000 ns GuestLast=1 738 225 471 816 755 000 ns fSetTimeLastLoop=true )
2025-01-31 12:15:22 (11016): Guest Log: 01:28:58.064090 timesync vgsvcTimeSyncWorker: Radical host time change: 9 704 819 000 000ns (HostNow=1 738 243 432 753 000 000 ns HostLast=1 738 233 727 934 000 000 ns)
2025-01-31 12:15:22 (11016): Guest Log: 01:29:08.064614 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 895 809 087 000ns (GuestNow=1 738 243 442 753 544 000 ns GuestLast=1 738 233 546 944 457 000 ns fSetTimeLastLoop=true )
2025-01-31 12:15:22 (11016): Starting VM using VBoxManage interface. (boinc_9085589062217eb8, slot#5)
2025-01-31 12:15:27 (11016): Successfully started VM. (PID = '7416')
2025-01-31 12:15:27 (11016): Reporting VM Process ID to BOINC.
2025-01-31 12:15:27 (11016): Guest Log: BIOS: VirtualBox 6.1.34
2025-01-31 12:15:27 (11016): Guest Log: CPUID EDX: 0x178bfbff
2025-01-31 12:15:27 (11016): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-31 12:15:27 (11016): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-31 12:15:27 (11016): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-31 12:15:27 (11016): Detected: Web Application Enabled (http://localhost:8781)
2025-01-31 12:15:27 (11016): Status Report: Job Duration: '864000.000000'
2025-01-31 12:15:27 (11016): Status Report: Elapsed Time: '92008.972475'
2025-01-31 12:15:27 (11016): Status Report: CPU Time: '41136.984375'
2025-01-31 12:15:27 (11016): Preference change detected
2025-01-31 12:15:27 (11016): Setting CPU throttle for VM. (60%)
2025-01-31 12:15:28 (11016): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-31 12:15:29 (11016): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-31 12:15:29 (11016): Guest Log: BIOS: Booting from Hard Disk...
2025-01-31 12:15:35 (11016): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-31 12:15:35 (11016): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-31 12:16:34 (11016): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-31 12:16:34 (11016): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-31 12:16:41 (11016): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.000083 main     Log opened 2025-01-31T04:16:39.823851000Z
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.000295 main     OS Product: Linux
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.000405 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.000506 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.000604 main     Executable: /usr/sbin/VBoxService
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.000604 main     Process ID: 3229
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.000605 main     Package type: LINUX_64BITS_GENERIC
2025-01-31 12:16:41 (11016): Guest Log: 00:00:00.004795 main     5.2.6 r120293 started. Verbose level = 0
2025-01-31 12:17:21 (11016): Guest Log: 12:17:19 CST +08:00 2025-01-31: cranky: [INFO] Detected Theory App
2025-01-31 12:17:21 (11016): Guest Log: 12:17:19 CST +08:00 2025-01-31: cranky: [INFO] Checking CVMFS.
2025-01-31 12:17:23 (11016): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-31 12:17:24 (11016): 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
2025-01-31 12:17:24 (11016): Guest Log: 2.5.2.0 4130 0 25148 31600 3 1 2143304 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-31 12:17:26 (11016): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-31 12:17:27 (11016): 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
2025-01-31 12:17:27 (11016): Guest Log: 2.5.2.0 4103 0 25528 26357 3 2 2143304 4096001 0 65024 0 2 0 7947 1404 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-31 12:17:28 (11016): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-31 12:17:30 (11016): 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
2025-01-31 12:17:30 (11016): Guest Log: 2.5.2.0 4078 0 25176 272 3 1 2143304 4096001 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-31 12:17:31 (11016): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-31 12:17:33 (11016): 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
2025-01-31 12:17:33 (11016): Guest Log: 2.5.2.0 4128 0 39624 21029 3 1 2143304 4096001 0 65024 0 0 n/a 6621 1446 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-31 12:17:33 (11016): Guest Log: 12:17:31 CST +08:00 2025-01-31: cranky: [INFO] Checking runc.
2025-01-31 12:17:33 (11016): Guest Log: 12:17:31 CST +08:00 2025-01-31: cranky: [INFO] Creating the filesystem.
2025-01-31 12:17:33 (11016): Guest Log: 12:17:32 CST +08:00 2025-01-31: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-31 12:17:34 (11016): Guest Log: 12:17:32 CST +08:00 2025-01-31: cranky: [INFO] Updating config.json.
2025-01-31 12:17:34 (11016): Guest Log: 12:17:32 CST +08:00 2025-01-31: cranky: [INFO] Running Container 'runc'.
2025-01-31 12:17:37 (11016): Guest Log: job: htmld=/shared/html/job
2025-01-31 12:17:37 (11016): Guest Log: job: unpack exitcode=0
2025-01-31 12:17:38 (11016): Guest Log: INFO: activated the work-around for ld:
2025-01-31 12:17:38 (11016): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 31 04:17 /tmp/tmp.Wr7094LSGt/ld -> /usr/bin/ld.bfd
2025-01-31 12:17:38 (11016): Guest Log: 12:17:36 CST +08:00 2025-01-31: cranky: [INFO] ===> [runRivet] Fri Jan 31 04:17:36 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-01-31 12:22:16 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 12:25:16 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 12:35:58 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 14:12:35 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 14:12:42 (11016): Guest Log: 00:16:24.988305 timesync vgsvcTimeSyncWorker: Radical host time change: 5 807 162 000 000ns (HostNow=1 738 303 961 872 000 000 ns HostLast=1 738 298 154 710 000 000 ns)
2025-01-31 14:12:53 (11016): Guest Log: 00:16:35.131851 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 988 002 739 000ns (GuestNow=1 738 303 972 133 515 000 ns GuestLast=1 738 297 984 130 776 000 ns fSetTimeLastLoop=true )
2025-01-31 14:19:42 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 14:22:42 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 14:29:32 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 14:29:52 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 14:31:36 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 14:31:56 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 14:50:38 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 14:50:59 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 15:27:54 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 15:28:14 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 15:43:06 (11016): Status Report: Job Duration: '864000.000000'
2025-01-31 15:43:06 (11016): Status Report: Elapsed Time: '98008.972475'
2025-01-31 15:43:06 (11016): Status Report: CPU Time: '43824.812500'
2025-01-31 15:50:42 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 19:04:31 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 19:04:34 (11016): Guest Log: 01:50:09.173853 timesync vgsvcTimeSyncWorker: Radical host time change: 11 638 450 000 000ns (HostNow=1 738 321 473 259 000 000 ns HostLast=1 738 309 834 809 000 000 ns)
2025-01-31 19:04:44 (11016): Guest Log: 01:50:19.179539 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 897 501 408 000ns (GuestNow=1 738 321 483 470 809 000 ns GuestLast=1 738 309 585 969 401 000 ns fSetTimeLastLoop=true )
2025-01-31 19:11:37 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 19:14:37 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 19:33:11 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 21:19:35 (11016): VM state change detected. (old = 'paused', new = 'running')
2025-01-31 21:19:39 (11016): Guest Log: 02:15:51.374085 timesync vgsvcTimeSyncWorker: Radical host time change: 6 394 310 000 000ns (HostNow=1 738 329 579 854 000 000 ns HostLast=1 738 323 185 544 000 000 ns)
2025-01-31 21:19:50 (11016): Guest Log: 02:16:01.378841 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 574 193 444 000ns (GuestNow=1 738 329 589 858 776 000 ns GuestLast=1 738 323 015 665 332 000 ns fSetTimeLastLoop=true )
2025-01-31 21:24:38 (11016): VM state change detected. (old = 'running', new = 'paused')
2025-01-31 22:21:14 (11016): VM state change detected. (old = 'paused', new = 'stopping')
2025-01-31 22:21:14 (11016): Stopping VM.
2025-01-31 22:21:14 (11016): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_9085589062217eb8" savestate
Output:

2025-01-31 22:21:14 (11016): VM did not stop when requested.
2025-01-31 22:21:14 (11016): VM was NOT successfully terminated.
2025-02-01 11:40:07 (13068): vboxwrapper version 26208
2025-02-01 11:40:07 (13068): BOINC client version: 8.0.2
2025-02-01 11:40:10 (13068): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-02-01 11:40:10 (13068): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-01 11:40:11 (13068): Guest Log: BIOS: VirtualBox 6.1.34
2025-02-01 11:40:11 (13068): Guest Log: CPUID EDX: 0x178bfbff
2025-02-01 11:40:11 (13068): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-01 11:40:11 (13068): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-01 11:40:11 (13068): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-01 11:40:11 (13068): Guest Log: BIOS: Booting from Hard Disk...
2025-02-01 11:40:11 (13068): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-01 11:40:11 (13068): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-01 11:40:11 (13068): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-01 11:40:11 (13068): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-01 11:40:11 (13068): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.000083 main     Log opened 2025-01-31T04:16:39.823851000Z
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.000295 main     OS Product: Linux
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.000405 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.000506 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.000604 main     Executable: /usr/sbin/VBoxService
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.000604 main     Process ID: 3229
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.000605 main     Package type: LINUX_64BITS_GENERIC
2025-02-01 11:40:11 (13068): Guest Log: 00:00:00.004795 main     5.2.6 r120293 started. Verbose level = 0
2025-02-01 11:40:11 (13068): Guest Log: 12:17:19 CST +08:00 2025-01-31: cranky: [INFO] Detected Theory App
2025-02-01 11:40:11 (13068): Guest Log: 12:17:19 CST +08:00 2025-01-31: cranky: [INFO] Checking CVMFS.
2025-02-01 11:40:11 (13068): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-01 11:40:11 (13068): 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
2025-02-01 11:40:11 (13068): Guest Log: 2.5.2.0 4130 0 25148 31600 3 1 2143304 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-01 11:40:11 (13068): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-01 11:40:11 (13068): 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
2025-02-01 11:40:11 (13068): Guest Log: 2.5.2.0 4103 0 25528 26357 3 2 2143304 4096001 0 65024 0 2 0 7947 1404 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-01 11:40:11 (13068): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-01 11:40:11 (13068): 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
2025-02-01 11:40:11 (13068): Guest Log: 2.5.2.0 4078 0 25176 272 3 1 2143304 4096001 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-01 11:40:11 (13068): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-01 11:40:11 (13068): 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
2025-02-01 11:40:11 (13068): Guest Log: 2.5.2.0 4128 0 39624 21029 3 1 2143304 4096001 0 65024 0 0 n/a 6621 1446 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-01 11:40:11 (13068): Guest Log: 12:17:31 CST +08:00 2025-01-31: cranky: [INFO] Checking runc.
2025-02-01 11:40:11 (13068): Guest Log: 12:17:31 CST +08:00 2025-01-31: cranky: [INFO] Creating the filesystem.
2025-02-01 11:40:11 (13068): Guest Log: 12:17:32 CST +08:00 2025-01-31: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-01 11:40:11 (13068): Guest Log: 12:17:32 CST +08:00 2025-01-31: cranky: [INFO] Updating config.json.
2025-02-01 11:40:11 (13068): Guest Log: 12:17:32 CST +08:00 2025-01-31: cranky: [INFO] Running Container 'runc'.
2025-02-01 11:40:11 (13068): Guest Log: job: htmld=/shared/html/job
2025-02-01 11:40:11 (13068): Guest Log: job: unpack exitcode=0
2025-02-01 11:40:11 (13068): Guest Log: INFO: activated the work-around for ld:
2025-02-01 11:40:11 (13068): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 31 04:17 /tmp/tmp.Wr7094LSGt/ld -> /usr/bin/ld.bfd
2025-02-01 11:40:11 (13068): Guest Log: 12:17:36 CST +08:00 2025-01-31: cranky: [INFO] ===> [runRivet] Fri Jan 31 04:17:36 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-02-01 11:40:11 (13068): Guest Log: 00:16:24.988305 timesync vgsvcTimeSyncWorker: Radical host time change: 5 807 162 000 000ns (HostNow=1 738 303 961 872 000 000 ns HostLast=1 738 298 154 710 000 000 ns)
2025-02-01 11:40:11 (13068): Guest Log: 00:16:35.131851 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 988 002 739 000ns (GuestNow=1 738 303 972 133 515 000 ns GuestLast=1 738 297 984 130 776 000 ns fSetTimeLastLoop=true )
2025-02-01 11:40:11 (13068): Guest Log: 01:50:09.173853 timesync vgsvcTimeSyncWorker: Radical host time change: 11 638 450 000 000ns (HostNow=1 738 321 473 259 000 000 ns HostLast=1 738 309 834 809 000 000 ns)
2025-02-01 11:40:11 (13068): Guest Log: 01:50:19.179539 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 897 501 408 000ns (GuestNow=1 738 321 483 470 809 000 ns GuestLast=1 738 309 585 969 401 000 ns fSetTimeLastLoop=true )
2025-02-01 11:40:11 (13068): Guest Log: 02:15:51.374085 timesync vgsvcTimeSyncWorker: Radical host time change: 6 394 310 000 000ns (HostNow=1 738 329 579 854 000 000 ns HostLast=1 738 323 185 544 000 000 ns)
2025-02-01 11:40:11 (13068): Guest Log: 02:16:01.378841 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 574 193 444 000ns (GuestNow=1 738 329 589 858 776 000 ns GuestLast=1 738 323 015 665 332 000 ns fSetTimeLastLoop=true )
2025-02-01 11:40:11 (13068): Starting VM using VBoxManage interface. (boinc_9085589062217eb8, slot#5)
2025-02-01 11:40:27 (13068): Successfully started VM. (PID = '17820')
2025-02-01 11:40:27 (13068): Reporting VM Process ID to BOINC.
2025-02-01 11:40:27 (13068): Guest Log: BIOS: VirtualBox 6.1.34
2025-02-01 11:40:27 (13068): Guest Log: CPUID EDX: 0x178bfbff
2025-02-01 11:40:27 (13068): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-01 11:40:27 (13068): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-01 11:40:27 (13068): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-01 11:40:27 (13068): Detected: Web Application Enabled (http://localhost:8781)
2025-02-01 11:40:27 (13068): Status Report: Job Duration: '864000.000000'
2025-02-01 11:40:27 (13068): Status Report: Elapsed Time: '100198.972475'
2025-02-01 11:40:27 (13068): Status Report: CPU Time: '45205.484375'
2025-02-01 11:40:27 (13068): Preference change detected
2025-02-01 11:40:27 (13068): Setting CPU throttle for VM. (60%)
2025-02-01 11:40:27 (13068): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-01 11:40:29 (13068): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-01 11:40:29 (13068): Guest Log: BIOS: Booting from Hard Disk...
2025-02-01 11:40:35 (13068): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-01 11:40:35 (13068): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-01 11:41:37 (13068): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-01 11:41:37 (13068): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-01 11:41:42 (13068): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.000088 main     Log opened 2025-02-01T03:41:41.436751000Z
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.000314 main     OS Product: Linux
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.000421 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.000521 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.000617 main     Executable: /usr/sbin/VBoxService
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.000618 main     Process ID: 3194
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.000619 main     Package type: LINUX_64BITS_GENERIC
2025-02-01 11:41:42 (13068): Guest Log: 00:00:00.010392 main     5.2.6 r120293 started. Verbose level = 0
2025-02-01 11:42:28 (13068): Guest Log: 11:42:27 CST +08:00 2025-02-01: cranky: [INFO] Detected Theory App
2025-02-01 11:42:28 (13068): Guest Log: 11:42:27 CST +08:00 2025-02-01: cranky: [INFO] Checking CVMFS.
2025-02-01 11:42:30 (13068): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-01 11:42:31 (13068): 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
2025-02-01 11:42:31 (13068): Guest Log: 2.5.2.0 4085 0 27180 31608 3 1 2176556 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-01 11:42:33 (13068): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-01 11:42:34 (13068): 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
2025-02-01 11:42:34 (13068): Guest Log: 2.5.2.0 4153 0 27464 26365 3 2 2176556 4096001 0 65024 0 2 0 7948 1188 http://s1ihep-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-01 11:42:35 (13068): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-01 11:42:37 (13068): 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
2025-02-01 11:42:37 (13068): Guest Log: 2.5.2.0 4131 0 27740 272 3 1 2176556 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-01 11:42:38 (13068): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-01 11:42:40 (13068): 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
2025-02-01 11:42:40 (13068): Guest Log: 2.5.2.0 4111 0 41700 21046 3 1 2176556 4096001 0 65024 0 0 n/a 6634 1163 http://s1ihep-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-01 11:42:40 (13068): Guest Log: 11:42:39 CST +08:00 2025-02-01: cranky: [INFO] Checking runc.
2025-02-01 11:42:40 (13068): Guest Log: 11:42:40 CST +08:00 2025-02-01: cranky: [INFO] Creating the filesystem.
2025-02-01 11:42:41 (13068): Guest Log: 11:42:40 CST +08:00 2025-02-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-01 11:42:41 (13068): Guest Log: 11:42:41 CST +08:00 2025-02-01: cranky: [INFO] Updating config.json.
2025-02-01 11:42:41 (13068): Guest Log: 11:42:41 CST +08:00 2025-02-01: cranky: [INFO] Running Container 'runc'.
2025-02-01 11:42:47 (13068): Guest Log: job: htmld=/shared/html/job
2025-02-01 11:42:47 (13068): Guest Log: job: unpack exitcode=0
2025-02-01 11:42:47 (13068): Guest Log: INFO: activated the work-around for ld:
2025-02-01 11:42:47 (13068): Guest Log: lrwxrwxrwx 1 0 0 15 Feb  1 03:42 /tmp/tmp.8AjbfxeL3f/ld -> /usr/bin/ld.bfd
2025-02-01 11:42:47 (13068): Guest Log: 11:42:47 CST +08:00 2025-02-01: cranky: [INFO] ===> [runRivet] Sat Feb  1 03:42:47 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-02-01 11:47:14 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 11:50:15 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 12:22:38 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 12:22:59 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 12:41:02 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 12:41:22 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 12:48:46 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 12:51:48 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 12:52:33 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 14:02:35 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 14:02:42 (13068): Guest Log: 01:04:17.319102 timesync vgsvcTimeSyncWorker: Radical host time change: 4 211 937 000 000ns (HostNow=1 738 389 761 645 000 000 ns HostLast=1 738 385 549 708 000 000 ns)
2025-02-01 14:02:52 (13068): Guest Log: 01:04:27.363327 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 613 305 204 000ns (GuestNow=1 738 389 771 774 127 000 ns GuestLast=1 738 385 158 468 923 000 ns fSetTimeLastLoop=true )
2025-02-01 14:03:39 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 14:27:28 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 14:34:55 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 14:37:56 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 14:43:12 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 14:43:32 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 14:48:42 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 16:57:25 (13068): Guest Log: 01:23:08.874155 timesync vgsvcTimeSyncWorker: Radical host time change: 7 732 457 000 000ns (HostNow=1 738 400 244 764 000 000 ns HostLast=1 738 392 512 307 000 000 ns)
2025-02-01 16:57:25 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 16:57:35 (13068): Guest Log: 01:23:18.876130 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 932 241 235 000ns (GuestNow=1 738 400 254 765 998 000 ns GuestLast=1 738 392 322 524 763 000 ns fSetTimeLastLoop=true )
2025-02-01 16:59:32 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 17:00:07 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 17:00:17 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 17:32:12 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 17:32:14 (13068): Guest Log: 01:25:29.021902 timesync vgsvcTimeSyncWorker: Radical host time change: 1 925 481 000 000ns (HostNow=1 738 402 334 882 000 000 ns HostLast=1 738 400 409 401 000 000 ns)
2025-02-01 17:32:25 (13068): Guest Log: 01:25:39.022930 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 959 971 291 000ns (GuestNow=1 738 402 344 883 044 000 ns GuestLast=1 738 400 384 911 753 000 ns fSetTimeLastLoop=true )
2025-02-01 17:39:19 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 17:42:19 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 17:48:30 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 21:00:34 (13068): VM state change detected. (old = 'paused', new = 'running')
2025-02-01 21:00:41 (13068): Guest Log: 01:38:50.320492 timesync vgsvcTimeSyncWorker: Radical host time change: 11 534 807 000 000ns (HostNow=1 738 414 840 921 000 000 ns HostLast=1 738 403 306 114 000 000 ns)
2025-02-01 21:00:51 (13068): Guest Log: 01:39:00.359681 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 714 779 606 000ns (GuestNow=1 738 414 850 960 199 000 ns GuestLast=1 738 403 136 180 593 000 ns fSetTimeLastLoop=true )
2025-02-01 21:03:03 (13068): Status Report: Job Duration: '864000.000000'
2025-02-01 21:03:03 (13068): Status Report: Elapsed Time: '106199.459888'
2025-02-01 21:03:03 (13068): Status Report: CPU Time: '47561.812500'
2025-02-01 21:05:09 (13068): VM state change detected. (old = 'running', new = 'paused')
2025-02-01 21:46:21 (13068): Stopping VM.
2025-02-01 21:46:21 (13068): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_9085589062217eb8" savestate
Output:

2025-02-01 21:46:21 (13068): VM did not stop when requested.
2025-02-01 21:46:21 (13068): VM was NOT successfully terminated.
2025-02-02 11:26:25 (16588): vboxwrapper version 26208
2025-02-02 11:26:25 (16588): BOINC client version: 8.0.2
2025-02-02 11:26:33 (16588): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-02-02 11:26:33 (16588): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-02 11:26:34 (16588): Guest Log: BIOS: VirtualBox 6.1.34
2025-02-02 11:26:34 (16588): Guest Log: CPUID EDX: 0x178bfbff
2025-02-02 11:26:34 (16588): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-02 11:26:34 (16588): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-02 11:26:34 (16588): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-02 11:26:34 (16588): Guest Log: BIOS: Booting from Hard Disk...
2025-02-02 11:26:34 (16588): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-02 11:26:34 (16588): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-02 11:26:34 (16588): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-02 11:26:34 (16588): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-02 11:26:34 (16588): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.000088 main     Log opened 2025-02-01T03:41:41.436751000Z
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.000314 main     OS Product: Linux
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.000421 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.000521 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.000617 main     Executable: /usr/sbin/VBoxService
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.000618 main     Process ID: 3194
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.000619 main     Package type: LINUX_64BITS_GENERIC
2025-02-02 11:26:34 (16588): Guest Log: 00:00:00.010392 main     5.2.6 r120293 started. Verbose level = 0
2025-02-02 11:26:34 (16588): Guest Log: 11:42:27 CST +08:00 2025-02-01: cranky: [INFO] Detected Theory App
2025-02-02 11:26:34 (16588): Guest Log: 11:42:27 CST +08:00 2025-02-01: cranky: [INFO] Checking CVMFS.
2025-02-02 11:26:34 (16588): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-02 11:26:34 (16588): 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
2025-02-02 11:26:34 (16588): Guest Log: 2.5.2.0 4085 0 27180 31608 3 1 2176556 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-02 11:26:34 (16588): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-02 11:26:34 (16588): 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
2025-02-02 11:26:34 (16588): Guest Log: 2.5.2.0 4153 0 27464 26365 3 2 2176556 4096001 0 65024 0 2 0 7948 1188 http://s1ihep-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-02 11:26:34 (16588): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-02 11:26:34 (16588): 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
2025-02-02 11:26:34 (16588): Guest Log: 2.5.2.0 4131 0 27740 272 3 1 2176556 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-02 11:26:34 (16588): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-02 11:26:34 (16588): 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
2025-02-02 11:26:34 (16588): Guest Log: 2.5.2.0 4111 0 41700 21046 3 1 2176556 4096001 0 65024 0 0 n/a 6634 1163 http://s1ihep-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-02 11:26:34 (16588): Guest Log: 11:42:39 CST +08:00 2025-02-01: cranky: [INFO] Checking runc.
2025-02-02 11:26:34 (16588): Guest Log: 11:42:40 CST +08:00 2025-02-01: cranky: [INFO] Creating the filesystem.
2025-02-02 11:26:34 (16588): Guest Log: 11:42:40 CST +08:00 2025-02-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-02 11:26:34 (16588): Guest Log: 11:42:41 CST +08:00 2025-02-01: cranky: [INFO] Updating config.json.
2025-02-02 11:26:34 (16588): Guest Log: 11:42:41 CST +08:00 2025-02-01: cranky: [INFO] Running Container 'runc'.
2025-02-02 11:26:34 (16588): Guest Log: job: htmld=/shared/html/job
2025-02-02 11:26:34 (16588): Guest Log: job: unpack exitcode=0
2025-02-02 11:26:34 (16588): Guest Log: INFO: activated the work-around for ld:
2025-02-02 11:26:34 (16588): Guest Log: lrwxrwxrwx 1 0 0 15 Feb  1 03:42 /tmp/tmp.8AjbfxeL3f/ld -> /usr/bin/ld.bfd
2025-02-02 11:26:34 (16588): Guest Log: 11:42:47 CST +08:00 2025-02-01: cranky: [INFO] ===> [runRivet] Sat Feb  1 03:42:47 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-02-02 11:26:34 (16588): Guest Log: 01:04:17.319102 timesync vgsvcTimeSyncWorker: Radical host time change: 4 211 937 000 000ns (HostNow=1 738 389 761 645 000 000 ns HostLast=1 738 385 549 708 000 000 ns)
2025-02-02 11:26:34 (16588): Guest Log: 01:04:27.363327 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 613 305 204 000ns (GuestNow=1 738 389 771 774 127 000 ns GuestLast=1 738 385 158 468 923 000 ns fSetTimeLastLoop=true )
2025-02-02 11:26:34 (16588): Guest Log: 01:23:08.874155 timesync vgsvcTimeSyncWorker: Radical host time change: 7 732 457 000 000ns (HostNow=1 738 400 244 764 000 000 ns HostLast=1 738 392 512 307 000 000 ns)
2025-02-02 11:26:34 (16588): Guest Log: 01:23:18.876130 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 932 241 235 000ns (GuestNow=1 738 400 254 765 998 000 ns GuestLast=1 738 392 322 524 763 000 ns fSetTimeLastLoop=true )
2025-02-02 11:26:34 (16588): Guest Log: 01:25:29.021902 timesync vgsvcTimeSyncWorker: Radical host time change: 1 925 481 000 000ns (HostNow=1 738 402 334 882 000 000 ns HostLast=1 738 400 409 401 000 000 ns)
2025-02-02 11:26:34 (16588): Guest Log: 01:25:39.022930 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 959 971 291 000ns (GuestNow=1 738 402 344 883 044 000 ns GuestLast=1 738 400 384 911 753 000 ns fSetTimeLastLoop=true )
2025-02-02 11:26:34 (16588): Guest Log: 01:38:50.320492 timesync vgsvcTimeSyncWorker: Radical host time change: 11 534 807 000 000ns (HostNow=1 738 414 840 921 000 000 ns HostLast=1 738 403 306 114 000 000 ns)
2025-02-02 11:26:34 (16588): Guest Log: 01:39:00.359681 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 714 779 606 000ns (GuestNow=1 738 414 850 960 199 000 ns GuestLast=1 738 403 136 180 593 000 ns fSetTimeLastLoop=true )
2025-02-02 11:26:34 (16588): Starting VM using VBoxManage interface. (boinc_9085589062217eb8, slot#5)
2025-02-02 11:26:39 (16588): Successfully started VM. (PID = '2060')
2025-02-02 11:26:39 (16588): Reporting VM Process ID to BOINC.
2025-02-02 11:26:39 (16588): Guest Log: BIOS: VirtualBox 6.1.34
2025-02-02 11:26:39 (16588): Guest Log: CPUID EDX: 0x178bfbff
2025-02-02 11:26:39 (16588): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-02 11:26:39 (16588): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-02 11:26:39 (16588): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-02 11:26:39 (16588): Detected: Web Application Enabled (http://localhost:8781)
2025-02-02 11:26:39 (16588): Status Report: Job Duration: '864000.000000'
2025-02-02 11:26:39 (16588): Status Report: Elapsed Time: '106318.459888'
2025-02-02 11:26:39 (16588): Status Report: CPU Time: '47637.359375'
2025-02-02 11:26:39 (16588): Preference change detected
2025-02-02 11:26:39 (16588): Setting CPU throttle for VM. (60%)
2025-02-02 11:26:39 (16588): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-02 11:26:41 (16588): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-02 11:26:41 (16588): Guest Log: BIOS: Booting from Hard Disk...
2025-02-02 11:26:47 (16588): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-02 11:26:47 (16588): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-02 11:27:45 (16588): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-02 11:27:45 (16588): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-02 11:27:50 (16588): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.000330 main     Log opened 2025-02-02T03:27:49.213502000Z
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.001481 main     OS Product: Linux
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.001621 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.001732 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.001836 main     Executable: /usr/sbin/VBoxService
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.001837 main     Process ID: 3218
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.001838 main     Package type: LINUX_64BITS_GENERIC
2025-02-02 11:27:50 (16588): Guest Log: 00:00:00.008131 main     5.2.6 r120293 started. Verbose level = 0
2025-02-02 11:28:33 (16588): Guest Log: 11:28:32 CST +08:00 2025-02-02: cranky: [INFO] Detected Theory App
2025-02-02 11:28:33 (16588): Guest Log: 11:28:32 CST +08:00 2025-02-02: cranky: [INFO] Checking CVMFS.
2025-02-02 11:28:35 (16588): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-02 11:28:37 (16588): 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
2025-02-02 11:28:37 (16588): Guest Log: 2.5.2.0 4149 0 27204 31615 3 1 2374761 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-02 11:28:38 (16588): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-02 11:28:40 (16588): 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
2025-02-02 11:28:40 (16588): Guest Log: 2.5.2.0 4109 0 27648 26373 3 2 2374761 4096001 0 65024 0 2 0 7947 936 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-02 11:28:42 (16588): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-02 11:28:44 (16588): 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
2025-02-02 11:28:44 (16588): Guest Log: 2.5.2.0 4081 0 27224 272 3 1 2374761 4096001 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-02 11:28:46 (16588): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-02 11:28:47 (16588): 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
2025-02-02 11:28:48 (16588): Guest Log: 2.5.2.0 4107 0 40680 21053 3 1 2374761 4096001 0 65024 0 0 n/a 6637 1888 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-02 11:28:48 (16588): Guest Log: 11:28:46 CST +08:00 2025-02-02: cranky: [INFO] Checking runc.
2025-02-02 11:28:49 (16588): Guest Log: 11:28:48 CST +08:00 2025-02-02: cranky: [INFO] Creating the filesystem.
2025-02-02 11:28:50 (16588): Guest Log: 11:28:49 CST +08:00 2025-02-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-02 11:28:50 (16588): Guest Log: 11:28:49 CST +08:00 2025-02-02: cranky: [INFO] Updating config.json.
2025-02-02 11:28:50 (16588): Guest Log: 11:28:49 CST +08:00 2025-02-02: cranky: [INFO] Running Container 'runc'.
2025-02-02 11:28:54 (16588): Guest Log: job: htmld=/shared/html/job
2025-02-02 11:28:56 (16588): Guest Log: job: unpack exitcode=0
2025-02-02 11:28:56 (16588): Guest Log: INFO: activated the work-around for ld:
2025-02-02 11:28:56 (16588): Guest Log: lrwxrwxrwx 1 0 0 15 Feb  2 03:28 /tmp/tmp.wqLang1Jll/ld -> /usr/bin/ld.bfd
2025-02-02 11:28:57 (16588): Guest Log: 11:28:56 CST +08:00 2025-02-02: cranky: [INFO] ===> [runRivet] Sun Feb  2 03:28:55 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-02-02 11:32:27 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 11:32:48 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 11:33:33 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 11:36:32 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 11:39:30 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 11:42:36 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 11:45:50 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 11:46:10 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 11:47:31 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 11:47:51 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 11:49:42 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 11:52:43 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 12:06:04 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 12:06:24 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 12:21:17 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 12:21:37 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 13:18:56 (16588): Status Report: Job Duration: '864000.000000'
2025-02-02 13:18:56 (16588): Status Report: Elapsed Time: '112318.459888'
2025-02-02 13:18:56 (16588): Status Report: CPU Time: '50616.687500'
2025-02-02 13:59:33 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 14:00:08 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 14:14:05 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 14:14:25 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 14:34:58 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 14:35:18 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 14:37:08 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 14:37:29 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 14:53:25 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 19:21:34 (16588): Guest Log: 03:13:19.725358 timesync vgsvcTimeSyncWorker: Radical host time change: 16 098 499 000 000ns (HostNow=1 738 495 293 448 000 000 ns HostLast=1 738 479 194 949 000 000 ns)
2025-02-02 19:21:34 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 19:21:44 (16588): Guest Log: 03:13:29.799874 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 835 225 780 000ns (GuestNow=1 738 495 303 741 905 000 ns GuestLast=1 738 478 468 516 125 000 ns fSetTimeLastLoop=true )
2025-02-02 19:22:47 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 19:23:07 (16588): VM state change detected. (old = 'paused', new = 'running')
2025-02-02 19:23:18 (16588): VM state change detected. (old = 'running', new = 'paused')
2025-02-02 21:21:03 (16588): VM state change detected. (old = 'paused', new = 'stopping')
2025-02-03 10:16:08 (15520): vboxwrapper version 26208
2025-02-03 10:16:08 (15520): BOINC client version: 8.0.2
2025-02-03 10:16:15 (15520): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-02-03 10:16:16 (15520): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-03 10:16:17 (15520): Guest Log: BIOS: VirtualBox 6.1.34
2025-02-03 10:16:17 (15520): Guest Log: CPUID EDX: 0x178bfbff
2025-02-03 10:16:17 (15520): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-03 10:16:17 (15520): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-03 10:16:17 (15520): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-03 10:16:17 (15520): Guest Log: BIOS: Booting from Hard Disk...
2025-02-03 10:16:17 (15520): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-03 10:16:17 (15520): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-03 10:16:17 (15520): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-03 10:16:17 (15520): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-03 10:16:17 (15520): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.000330 main     Log opened 2025-02-02T03:27:49.213502000Z
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.001481 main     OS Product: Linux
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.001621 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.001732 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.001836 main     Executable: /usr/sbin/VBoxService
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.001837 main     Process ID: 3218
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.001838 main     Package type: LINUX_64BITS_GENERIC
2025-02-03 10:16:17 (15520): Guest Log: 00:00:00.008131 main     5.2.6 r120293 started. Verbose level = 0
2025-02-03 10:16:17 (15520): Guest Log: 11:28:32 CST +08:00 2025-02-02: cranky: [INFO] Detected Theory App
2025-02-03 10:16:17 (15520): Guest Log: 11:28:32 CST +08:00 2025-02-02: cranky: [INFO] Checking CVMFS.
2025-02-03 10:16:17 (15520): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-03 10:16:17 (15520): 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
2025-02-03 10:16:17 (15520): Guest Log: 2.5.2.0 4149 0 27204 31615 3 1 2374761 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-03 10:16:17 (15520): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-03 10:16:17 (15520): 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
2025-02-03 10:16:17 (15520): Guest Log: 2.5.2.0 4109 0 27648 26373 3 2 2374761 4096001 0 65024 0 2 0 7947 936 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-03 10:16:17 (15520): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-03 10:16:17 (15520): 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
2025-02-03 10:16:17 (15520): Guest Log: 2.5.2.0 4081 0 27224 272 3 1 2374761 4096001 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-03 10:16:17 (15520): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-03 10:16:17 (15520): 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
2025-02-03 10:16:17 (15520): Guest Log: 2.5.2.0 4107 0 40680 21053 3 1 2374761 4096001 0 65024 0 0 n/a 6637 1888 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-03 10:16:17 (15520): Guest Log: 11:28:46 CST +08:00 2025-02-02: cranky: [INFO] Checking runc.
2025-02-03 10:16:17 (15520): Guest Log: 11:28:48 CST +08:00 2025-02-02: cranky: [INFO] Creating the filesystem.
2025-02-03 10:16:17 (15520): Guest Log: 11:28:49 CST +08:00 2025-02-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-03 10:16:17 (15520): Guest Log: 11:28:49 CST +08:00 2025-02-02: cranky: [INFO] Updating config.json.
2025-02-03 10:16:17 (15520): Guest Log: 11:28:49 CST +08:00 2025-02-02: cranky: [INFO] Running Container 'runc'.
2025-02-03 10:16:17 (15520): Guest Log: job: htmld=/shared/html/job
2025-02-03 10:16:17 (15520): Guest Log: job: unpack exitcode=0
2025-02-03 10:16:17 (15520): Guest Log: INFO: activated the work-around for ld:
2025-02-03 10:16:17 (15520): Guest Log: lrwxrwxrwx 1 0 0 15 Feb  2 03:28 /tmp/tmp.wqLang1Jll/ld -> /usr/bin/ld.bfd
2025-02-03 10:16:17 (15520): Guest Log: 11:28:56 CST +08:00 2025-02-02: cranky: [INFO] ===> [runRivet] Sun Feb  2 03:28:55 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-02-03 10:16:17 (15520): Guest Log: 03:13:19.725358 timesync vgsvcTimeSyncWorker: Radical host time change: 16 098 499 000 000ns (HostNow=1 738 495 293 448 000 000 ns HostLast=1 738 479 194 949 000 000 ns)
2025-02-03 10:16:17 (15520): Guest Log: 03:13:29.799874 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 835 225 780 000ns (GuestNow=1 738 495 303 741 905 000 ns GuestLast=1 738 478 468 516 125 000 ns fSetTimeLastLoop=true )
2025-02-03 10:16:17 (15520): Starting VM using VBoxManage interface. (boinc_9085589062217eb8, slot#5)
2025-02-03 10:16:22 (15520): Successfully started VM. (PID = '7828')
2025-02-03 10:16:22 (15520): Reporting VM Process ID to BOINC.
2025-02-03 10:16:22 (15520): Guest Log: BIOS: VirtualBox 6.1.34
2025-02-03 10:16:22 (15520): Guest Log: CPUID EDX: 0x178bfbff
2025-02-03 10:16:22 (15520): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-03 10:16:22 (15520): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-03 10:16:22 (15520): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-03 10:16:22 (15520): Detected: Web Application Enabled (http://localhost:8781)
2025-02-03 10:16:22 (15520): Status Report: Job Duration: '864000.000000'
2025-02-03 10:16:22 (15520): Status Report: Elapsed Time: '117812.459888'
2025-02-03 10:16:22 (15520): Status Report: CPU Time: '54005.453125'
2025-02-03 10:16:22 (15520): Preference change detected
2025-02-03 10:16:22 (15520): Setting CPU throttle for VM. (60%)
2025-02-03 10:16:22 (15520): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-03 10:16:24 (15520): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-03 10:16:24 (15520): Guest Log: BIOS: Booting from Hard Disk...
2025-02-03 10:16:29 (15520): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-03 10:16:29 (15520): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-03 10:17:27 (15520): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-03 10:17:27 (15520): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-03 10:17:33 (15520): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.000084 main     Log opened 2025-02-03T02:17:32.758583000Z
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.000312 main     OS Product: Linux
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.000418 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.000514 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.000608 main     Executable: /usr/sbin/VBoxService
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.000609 main     Process ID: 3224
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.000610 main     Package type: LINUX_64BITS_GENERIC
2025-02-03 10:17:33 (15520): Guest Log: 00:00:00.015496 main     5.2.6 r120293 started. Verbose level = 0
2025-02-03 10:18:11 (15520): Guest Log: 10:18:09 CST +08:00 2025-02-03: cranky: [INFO] Detected Theory App
2025-02-03 10:18:11 (15520): Guest Log: 10:18:10 CST +08:00 2025-02-03: cranky: [INFO] Checking CVMFS.
2025-02-03 10:18:12 (15520): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-03 10:18:14 (15520): 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
2025-02-03 10:18:14 (15520): Guest Log: 2.5.2.0 4078 0 27212 31621 3 1 2434750 4096001 0 65024 0 0 n/a 5 0 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-03 10:18:15 (15520): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-03 10:18:16 (15520): 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
2025-02-03 10:18:16 (15520): Guest Log: 2.5.2.0 4147 0 27472 26381 3 2 2434750 4096001 0 65024 0 2 0 7947 1869 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-03 10:18:17 (15520): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-03 10:18:19 (15520): 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
2025-02-03 10:18:19 (15520): Guest Log: 2.5.2.0 4103 0 27196 272 3 1 2434750 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-03 10:18:20 (15520): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-03 10:18:21 (15520): 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
2025-02-03 10:18:21 (15520): Guest Log: 2.5.2.0 4124 0 39964 21067 3 1 2434750 4096001 0 65024 0 0 n/a 6643 1554 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-03 10:18:21 (15520): Guest Log: 10:18:20 CST +08:00 2025-02-03: cranky: [INFO] Checking runc.
2025-02-03 10:18:22 (15520): Guest Log: 10:18:21 CST +08:00 2025-02-03: cranky: [INFO] Creating the filesystem.
2025-02-03 10:18:23 (15520): Guest Log: 10:18:21 CST +08:00 2025-02-03: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-03 10:18:23 (15520): Guest Log: 10:18:22 CST +08:00 2025-02-03: cranky: [INFO] Updating config.json.
2025-02-03 10:18:23 (15520): Guest Log: 10:18:22 CST +08:00 2025-02-03: cranky: [INFO] Running Container 'runc'.
2025-02-03 10:18:30 (15520): Guest Log: job: htmld=/shared/html/job
2025-02-03 10:18:30 (15520): Guest Log: job: unpack exitcode=0
2025-02-03 10:18:30 (15520): Guest Log: INFO: activated the work-around for ld:
2025-02-03 10:18:30 (15520): Guest Log: lrwxrwxrwx 1 0 0 15 Feb  3 02:18 /tmp/tmp.sIAgCHkrYI/ld -> /usr/bin/ld.bfd
2025-02-03 10:18:31 (15520): Guest Log: 10:18:30 CST +08:00 2025-02-03: cranky: [INFO] ===> [runRivet] Mon Feb  3 02:18:29 UTC 2025 [boinc pp jets 13000 170,-,2960 - powheg-box r3744 pthard2 100000 299]
2025-02-03 10:23:16 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 10:26:15 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 10:54:54 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 10:55:15 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 11:12:56 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 11:13:16 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 11:19:28 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 11:19:48 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 11:30:41 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 11:44:36 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 11:51:01 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 11:51:22 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 11:51:43 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 11:54:43 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 12:20:37 (15520): Status Report: Job Duration: '864000.000000'
2025-02-03 12:20:37 (15520): Status Report: Elapsed Time: '123812.459888'
2025-02-03 12:20:37 (15520): Status Report: CPU Time: '57028.906250'
2025-02-03 12:38:35 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 14:38:48 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 14:38:54 (15520): Guest Log: 01:59:57.376401 timesync vgsvcTimeSyncWorker: Radical host time change: 7 222 406 000 000ns (HostNow=1 738 564 734 119 000 000 ns HostLast=1 738 557 511 713 000 000 ns)
2025-02-03 14:39:04 (15520): Guest Log: 02:00:07.634220 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 222 747 433 000ns (GuestNow=1 738 564 744 519 848 000 ns GuestLast=1 738 557 521 772 415 000 ns fSetTimeLastLoop=true )
2025-02-03 14:43:44 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 14:53:38 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 15:00:45 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 16:49:57 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 16:50:02 (15520): Guest Log: 02:11:58.786386 timesync vgsvcTimeSyncWorker: Radical host time change: 6 561 978 000 000ns (HostNow=1 738 572 602 047 000 000 ns HostLast=1 738 566 040 069 000 000 ns)
2025-02-03 16:50:13 (15520): Guest Log: 02:12:08.788359 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 156 376 997 000ns (GuestNow=1 738 572 612 048 990 000 ns GuestLast=1 738 565 455 671 993 000 ns fSetTimeLastLoop=true )
2025-02-03 16:57:04 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 17:00:04 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 17:22:44 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 17:23:04 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 17:27:56 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 17:28:16 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 17:41:08 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 17:41:28 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 17:52:00 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 17:52:20 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 17:59:30 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 18:00:05 (15520): VM state change detected. (old = 'paused', new = 'running')
2025-02-03 18:09:01 (15520): Status Report: Job Duration: '864000.000000'
2025-02-03 18:09:01 (15520): Status Report: Elapsed Time: '129812.459888'
2025-02-03 18:09:01 (15520): Status Report: CPU Time: '60788.359375'
2025-02-03 18:09:40 (15520): VM state change detected. (old = 'running', new = 'paused')
2025-02-03 21:34:13 (15520): VM state change detected. (old = 'paused', new = 'stopping')
2025-02-03 21:34:13 (15520): Stopping VM.
2025-02-03 21:34:13 (15520): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_9085589062217eb8" savestate
Output:

2025-02-03 21:34:13 (15520): VM did not stop when requested.
2025-02-03 21:34:13 (15520): VM was NOT successfully terminated.

</stderr_txt>
]]>


©2025 CERN