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