Name | Theory_2390-1113319-1016_1 |
Workunit | 217622760 |
Created | 4 Dec 2023, 13:24:51 UTC |
Sent | 4 Dec 2023, 16:03:56 UTC |
Report deadline | 15 Dec 2023, 16:03:56 UTC |
Received | 16 Dec 2023, 17:08:28 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10677116 |
Run time | 15 hours 0 min 27 sec |
CPU time | 14 hours 55 min 42 sec |
Validate state | Valid |
Credit | 658.90 |
Device peak FLOPS | 5.27 GFLOPS |
Application version | Theory Simulation v300.07 (vbox64_theory) windows_x86_64 |
Peak working set size | 81.18 MB |
Peak swap size | 89.80 MB |
Peak disk usage | 2.16 GB |
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> 3 13:09:41 (3964): Guest Log: 00:00:00.000091 main Log opened 2023-12-13T12:09:47.429234000Z 2023-12-13 13:09:41 (3964): Guest Log: 00:00:00.000189 main OS Product: Linux 2023-12-13 13:09:41 (3964): Guest Log: 00:00:00.000216 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-13 13:09:41 (3964): Guest Log: 00:00:00.000237 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-13 13:09:41 (3964): Guest Log: 00:00:00.000255 main Executable: /usr/sbin/VBoxService 2023-12-13 13:09:41 (3964): Guest Log: 00:00:00.000256 main Process ID: 3209 2023-12-13 13:09:41 (3964): Guest Log: 00:00:00.000256 main Package type: LINUX_64BITS_GENERIC 2023-12-13 13:09:41 (3964): Guest Log: 00:00:00.002116 main 5.2.6 r120293 started. Verbose level = 0 2023-12-13 13:10:03 (3964): Guest Log: 13:10:09 CET +01:00 2023-12-13: cranky: [INFO] Detected Theory App 2023-12-13 13:10:03 (3964): Guest Log: 13:10:09 CET +01:00 2023-12-13: cranky: [INFO] Checking CVMFS. 2023-12-13 13:10:03 (3964): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-13 13:10:05 (3964): 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 2023-12-13 13:10:05 (3964): Guest Log: 2.5.2.0 4102 0 27184 27896 3 1 1263315 4096001 0 65024 0 0 n/a 5 6 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-13 13:10:05 (3964): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-13 13:10:06 (3964): 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 2023-12-13 13:10:06 (3964): Guest Log: 2.5.2.0 4081 0 27684 22953 3 2 1263315 4096001 0 65024 0 2 0 5700 1715 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-13 13:10:06 (3964): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-13 13:10:07 (3964): 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 2023-12-13 13:10:07 (3964): Guest Log: 2.5.2.0 4038 0 27200 268 3 1 1263315 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-13 13:10:07 (3964): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-13 13:10:07 (3964): 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 2023-12-13 13:10:07 (3964): Guest Log: 2.5.2.0 4060 0 35544 17376 3 1 1263315 4096001 0 65024 0 0 n/a 4817 5430 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2023-12-13 13:10:07 (3964): Guest Log: 13:10:13 CET +01:00 2023-12-13: cranky: [INFO] Checking runc. 2023-12-13 13:10:07 (3964): Guest Log: 13:10:13 CET +01:00 2023-12-13: cranky: [INFO] Creating the filesystem. 2023-12-13 13:10:07 (3964): Guest Log: 13:10:14 CET +01:00 2023-12-13: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-13 13:10:08 (3964): Guest Log: 13:10:14 CET +01:00 2023-12-13: cranky: [INFO] Updating config.json. 2023-12-13 13:10:08 (3964): Guest Log: 13:10:14 CET +01:00 2023-12-13: cranky: [INFO] Running Container 'runc'. 2023-12-13 13:10:08 (3964): Guest Log: job: htmld=/shared/html/job 2023-12-13 13:10:08 (3964): Guest Log: job: unpack exitcode=0 2023-12-13 13:10:10 (3964): Guest Log: 13:10:16 CET +01:00 2023-12-13: cranky: [INFO] ===> [runRivet] Wed Dec 13 12:10:15 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-13 13:12:31 (3964): Stopping VM. 2023-12-13 13:12:42 (3964): Successfully stopped VM. 2023-12-13 18:38:56 (15124): Detected: vboxwrapper 26206 2023-12-13 18:38:56 (15124): Detected: BOINC client v7.16.11 2023-12-13 18:38:57 (15124): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-13 18:38:58 (15124): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-13 18:38:58 (15124): Guest Log: BIOS: VirtualBox 6.1.12 2023-12-13 18:38:58 (15124): Guest Log: CPUID EDX: 0x178bfbff 2023-12-13 18:38:58 (15124): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-12-13 18:38:58 (15124): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-12-13 18:38:58 (15124): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-12-13 18:38:58 (15124): Guest Log: BIOS: Booting from Hard Disk... 2023-12-13 18:38:58 (15124): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-12-13 18:38:58 (15124): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-12-13 18:38:58 (15124): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-12-13 18:38:58 (15124): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-12-13 18:38:58 (15124): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.000091 main Log opened 2023-12-13T12:09:47.429234000Z 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.000189 main OS Product: Linux 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.000216 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.000237 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.000255 main Executable: /usr/sbin/VBoxService 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.000256 main Process ID: 3209 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.000256 main Package type: LINUX_64BITS_GENERIC 2023-12-13 18:38:58 (15124): Guest Log: 00:00:00.002116 main 5.2.6 r120293 started. Verbose level = 0 2023-12-13 18:38:58 (15124): Guest Log: 13:10:09 CET +01:00 2023-12-13: cranky: [INFO] Detected Theory App 2023-12-13 18:38:58 (15124): Guest Log: 13:10:09 CET +01:00 2023-12-13: cranky: [INFO] Checking CVMFS. 2023-12-13 18:38:58 (15124): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-13 18:38:58 (15124): 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 2023-12-13 18:38:58 (15124): Guest Log: 2.5.2.0 4102 0 27184 27896 3 1 1263315 4096001 0 65024 0 0 n/a 5 6 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-13 18:38:58 (15124): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-13 18:38:58 (15124): 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 2023-12-13 18:38:58 (15124): Guest Log: 2.5.2.0 4081 0 27684 22953 3 2 1263315 4096001 0 65024 0 2 0 5700 1715 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-13 18:38:58 (15124): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-13 18:38:58 (15124): 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 2023-12-13 18:38:58 (15124): Guest Log: 2.5.2.0 4038 0 27200 268 3 1 1263315 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-13 18:38:58 (15124): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-13 18:38:58 (15124): 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 2023-12-13 18:38:58 (15124): Guest Log: 2.5.2.0 4060 0 35544 17376 3 1 1263315 4096001 0 65024 0 0 n/a 4817 5430 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2023-12-13 18:38:58 (15124): Guest Log: 13:10:13 CET +01:00 2023-12-13: cranky: [INFO] Checking runc. 2023-12-13 18:38:58 (15124): Guest Log: 13:10:13 CET +01:00 2023-12-13: cranky: [INFO] Creating the filesystem. 2023-12-13 18:38:58 (15124): Guest Log: 13:10:14 CET +01:00 2023-12-13: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-13 18:38:58 (15124): Guest Log: 13:10:14 CET +01:00 2023-12-13: cranky: [INFO] Updating config.json. 2023-12-13 18:38:58 (15124): Guest Log: 13:10:14 CET +01:00 2023-12-13: cranky: [INFO] Running Container 'runc'. 2023-12-13 18:38:58 (15124): Guest Log: job: htmld=/shared/html/job 2023-12-13 18:38:58 (15124): Guest Log: job: unpack exitcode=0 2023-12-13 18:38:58 (15124): Guest Log: 13:10:16 CET +01:00 2023-12-13: cranky: [INFO] ===> [runRivet] Wed Dec 13 12:10:15 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-13 18:38:58 (15124): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-13 18:39:13 (15124): Successfully started VM. (PID = '17900') 2023-12-13 18:39:13 (15124): Reporting VM Process ID to BOINC. 2023-12-13 18:39:13 (15124): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-13 18:39:13 (15124): Detected: Web Application Enabled (http://localhost:55722) 2023-12-13 18:39:14 (15124): VM state change detected. (old = 'running', new = 'paused') 2023-12-13 18:39:16 (15124): Status Report: Job Duration: '864000.000000' 2023-12-13 18:39:16 (15124): Status Report: Elapsed Time: '32423.221402' 2023-12-13 18:39:16 (15124): Status Report: CPU Time: '35173.906250' 2023-12-13 18:39:16 (15124): Preference change detected 2023-12-13 18:39:16 (15124): Setting CPU throttle for VM. (100%) 2023-12-13 18:39:17 (15124): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-13 18:39:17 (15124): VM state change detected. (old = 'paused', new = 'running') 2023-12-13 18:39:20 (15124): Guest Log: 00:03:00.157917 timesync vgsvcTimeSyncWorker: Radical host time change: 19 608 606 000 000ns (HostNow=1 702 489 159 849 000 000 ns HostLast=1 702 469 551 243 000 000 ns) 2023-12-13 18:39:30 (15124): Guest Log: 00:03:10.191566 timesync vgsvcTimeSyncWorker: Radical guest time change: 19 602 424 173 000ns (GuestNow=1 702 489 169 922 812 000 ns GuestLast=1 702 469 567 498 639 000 ns fSetTimeLastLoop=true ) 2023-12-13 18:49:20 (15124): Stopping VM. 2023-12-13 18:49:23 (15124): Successfully stopped VM. 2023-12-13 22:05:20 (14932): Detected: vboxwrapper 26206 2023-12-13 22:05:20 (14932): Detected: BOINC client v7.16.11 2023-12-13 22:05:21 (14932): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-13 22:05:21 (14932): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-13 22:05:22 (14932): Guest Log: 00:03:00.157917 timesync vgsvcTimeSyncWorker: Radical host time change: 19 608 606 000 000ns (HostNow=1 702 489 159 849 000 000 ns HostLast=1 702 469 551 243 000 000 ns) 2023-12-13 22:05:22 (14932): Guest Log: 00:03:10.191566 timesync vgsvcTimeSyncWorker: Radical guest time change: 19 602 424 173 000ns (GuestNow=1 702 489 169 922 812 000 ns GuestLast=1 702 469 567 498 639 000 ns fSetTimeLastLoop=true ) 2023-12-13 22:05:22 (14932): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-13 22:05:32 (14932): Successfully started VM. (PID = '13432') 2023-12-13 22:05:32 (14932): Reporting VM Process ID to BOINC. 2023-12-13 22:05:32 (14932): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-13 22:05:32 (14932): Detected: Web Application Enabled (http://localhost:55722) 2023-12-13 22:05:33 (14932): VM state change detected. (old = 'running', new = 'paused') 2023-12-13 22:05:41 (14932): Status Report: Job Duration: '864000.000000' 2023-12-13 22:05:41 (14932): Status Report: Elapsed Time: '33026.221402' 2023-12-13 22:05:41 (14932): Status Report: CPU Time: '35783.062500' 2023-12-13 22:05:41 (14932): Preference change detected 2023-12-13 22:05:41 (14932): Setting CPU throttle for VM. (100%) 2023-12-13 22:05:41 (14932): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-13 22:05:42 (14932): VM state change detected. (old = 'paused', new = 'running') 2023-12-13 22:05:50 (14932): Guest Log: 00:13:10.409581 timesync vgsvcTimeSyncWorker: Radical host time change: 11 789 093 000 000ns (HostNow=1 702 501 549 276 000 000 ns HostLast=1 702 489 760 183 000 000 ns) 2023-12-13 22:06:00 (14932): Guest Log: 00:13:20.410158 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 789 135 794 000ns (GuestNow=1 702 501 559 276 595 000 ns GuestLast=1 702 489 770 140 801 000 ns fSetTimeLastLoop=true ) 2023-12-13 22:28:54 (14932): Stopping VM. 2023-12-13 22:28:56 (14932): Successfully stopped VM. 2023-12-13 23:59:59 (12140): Detected: vboxwrapper 26206 2023-12-13 23:59:59 (12140): Detected: BOINC client v7.16.11 2023-12-14 00:00:00 (12140): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-14 00:00:00 (12140): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-14 00:00:01 (12140): Guest Log: 00:13:10.409581 timesync vgsvcTimeSyncWorker: Radical host time change: 11 789 093 000 000ns (HostNow=1 702 501 549 276 000 000 ns HostLast=1 702 489 760 183 000 000 ns) 2023-12-14 00:00:01 (12140): Guest Log: 00:13:20.410158 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 789 135 794 000ns (GuestNow=1 702 501 559 276 595 000 ns GuestLast=1 702 489 770 140 801 000 ns fSetTimeLastLoop=true ) 2023-12-14 00:00:01 (12140): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-14 00:00:09 (12140): Successfully started VM. (PID = '4788') 2023-12-14 00:00:09 (12140): Reporting VM Process ID to BOINC. 2023-12-14 00:00:09 (12140): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-14 00:00:09 (12140): Detected: Web Application Enabled (http://localhost:55722) 2023-12-14 00:00:09 (12140): Status Report: Job Duration: '864000.000000' 2023-12-14 00:00:09 (12140): Status Report: Elapsed Time: '34418.221402' 2023-12-14 00:00:09 (12140): Status Report: CPU Time: '37172.640625' 2023-12-14 00:00:09 (12140): Preference change detected 2023-12-14 00:00:09 (12140): Setting CPU throttle for VM. (100%) 2023-12-14 00:00:09 (12140): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-14 00:00:11 (12140): VM state change detected. (old = 'running', new = 'paused') 2023-12-14 00:00:21 (12140): VM state change detected. (old = 'paused', new = 'running') 2023-12-14 00:00:24 (12140): Guest Log: 00:36:20.917322 timesync vgsvcTimeSyncWorker: Radical host time change: 5 493 715 000 000ns (HostNow=1 702 508 423 501 000 000 ns HostLast=1 702 502 929 786 000 000 ns) 2023-12-14 00:00:34 (12140): Guest Log: 00:36:30.922313 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 493 722 271 000ns (GuestNow=1 702 508 433 506 004 000 ns GuestLast=1 702 502 939 783 733 000 ns fSetTimeLastLoop=true ) 2023-12-14 17:02:18 (15556): Detected: vboxwrapper 26206 2023-12-14 17:02:18 (15556): Detected: BOINC client v7.16.11 2023-12-14 17:02:20 (15556): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-14 17:02:20 (15556): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-14 17:02:21 (15556): Guest Log: 00:36:20.917322 timesync vgsvcTimeSyncWorker: Radical host time change: 5 493 715 000 000ns (HostNow=1 702 508 423 501 000 000 ns HostLast=1 702 502 929 786 000 000 ns) 2023-12-14 17:02:21 (15556): Guest Log: 00:36:30.922313 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 493 722 271 000ns (GuestNow=1 702 508 433 506 004 000 ns GuestLast=1 702 502 939 783 733 000 ns fSetTimeLastLoop=true ) 2023-12-14 17:02:21 (15556): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-14 17:02:27 (15556): Successfully started VM. (PID = '1584') 2023-12-14 17:02:27 (15556): Reporting VM Process ID to BOINC. 2023-12-14 17:02:27 (15556): Guest Log: BIOS: VirtualBox 6.1.12 2023-12-14 17:02:27 (15556): Guest Log: CPUID EDX: 0x178bfbff 2023-12-14 17:02:27 (15556): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-12-14 17:02:27 (15556): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-12-14 17:02:27 (15556): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-14 17:02:27 (15556): Detected: Web Application Enabled (http://localhost:55722) 2023-12-14 17:02:27 (15556): Status Report: Job Duration: '864000.000000' 2023-12-14 17:02:27 (15556): Status Report: Elapsed Time: '35122.221402' 2023-12-14 17:02:27 (15556): Status Report: CPU Time: '37876.453125' 2023-12-14 17:02:27 (15556): Preference change detected 2023-12-14 17:02:27 (15556): Setting CPU throttle for VM. (100%) 2023-12-14 17:02:27 (15556): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-14 17:02:29 (15556): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-12-14 17:02:29 (15556): Guest Log: BIOS: Booting from Hard Disk... 2023-12-14 17:02:30 (15556): VM state change detected. (old = 'running', new = 'paused') 2023-12-14 17:02:40 (15556): VM state change detected. (old = 'paused', new = 'running') 2023-12-14 17:02:42 (15556): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-12-14 17:02:42 (15556): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-12-14 17:03:01 (15556): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-12-14 17:03:01 (15556): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-12-14 17:03:05 (15556): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.000071 main Log opened 2023-12-14T16:03:05.286447000Z 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.000142 main OS Product: Linux 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.000176 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.000197 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.000216 main Executable: /usr/sbin/VBoxService 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.000216 main Process ID: 3212 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.000217 main Package type: LINUX_64BITS_GENERIC 2023-12-14 17:03:05 (15556): Guest Log: 00:00:00.001744 main 5.2.6 r120293 started. Verbose level = 0 2023-12-14 17:03:27 (15556): Guest Log: 17:03:27 CET +01:00 2023-12-14: cranky: [INFO] Detected Theory App 2023-12-14 17:03:27 (15556): Guest Log: 17:03:27 CET +01:00 2023-12-14: cranky: [INFO] Checking CVMFS. 2023-12-14 17:03:27 (15556): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-14 17:03:28 (15556): 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 2023-12-14 17:03:28 (15556): Guest Log: 2.5.2.0 4038 0 28488 27903 3 1 1287421 4096001 0 65024 0 0 n/a 5 3 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-14 17:03:28 (15556): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-14 17:03:28 (15556): 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 2023-12-14 17:03:28 (15556): Guest Log: 2.5.2.0 4078 0 27656 22963 3 2 1287421 4096001 0 65024 0 2 0 5703 6003 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-14 17:03:28 (15556): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-14 17:03:29 (15556): 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 2023-12-14 17:03:29 (15556): Guest Log: 2.5.2.0 4067 0 25164 268 3 1 1287421 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-14 17:03:29 (15556): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-14 17:03:30 (15556): 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 2023-12-14 17:03:30 (15556): Guest Log: 2.5.2.0 4111 0 37604 17392 3 1 1287421 4096001 0 65024 0 0 n/a 4823 976 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2023-12-14 17:03:30 (15556): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Checking runc. 2023-12-14 17:03:30 (15556): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Creating the filesystem. 2023-12-14 17:03:30 (15556): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-14 17:03:30 (15556): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Updating config.json. 2023-12-14 17:03:30 (15556): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Running Container 'runc'. 2023-12-14 17:03:31 (15556): Guest Log: job: htmld=/shared/html/job 2023-12-14 17:03:31 (15556): Guest Log: job: unpack exitcode=0 2023-12-14 17:03:32 (15556): Guest Log: 17:03:32 CET +01:00 2023-12-14: cranky: [INFO] ===> [runRivet] Thu Dec 14 16:03:31 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-14 17:20:02 (15556): VM state change detected. (old = 'running', new = 'paused') 2023-12-14 17:20:14 (15556): Stopping VM. 2023-12-14 17:20:17 (15556): Successfully stopped VM. 2023-12-14 22:14:31 (13012): Detected: vboxwrapper 26206 2023-12-14 22:14:31 (13012): Detected: BOINC client v7.16.11 2023-12-14 22:14:32 (13012): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-14 22:14:32 (13012): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-14 22:14:33 (13012): Guest Log: BIOS: VirtualBox 6.1.12 2023-12-14 22:14:33 (13012): Guest Log: CPUID EDX: 0x178bfbff 2023-12-14 22:14:33 (13012): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-12-14 22:14:33 (13012): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-12-14 22:14:33 (13012): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-12-14 22:14:33 (13012): Guest Log: BIOS: Booting from Hard Disk... 2023-12-14 22:14:33 (13012): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-12-14 22:14:33 (13012): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-12-14 22:14:33 (13012): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-12-14 22:14:33 (13012): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-12-14 22:14:33 (13012): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.000071 main Log opened 2023-12-14T16:03:05.286447000Z 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.000142 main OS Product: Linux 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.000176 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.000197 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.000216 main Executable: /usr/sbin/VBoxService 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.000216 main Process ID: 3212 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.000217 main Package type: LINUX_64BITS_GENERIC 2023-12-14 22:14:33 (13012): Guest Log: 00:00:00.001744 main 5.2.6 r120293 started. Verbose level = 0 2023-12-14 22:14:33 (13012): Guest Log: 17:03:27 CET +01:00 2023-12-14: cranky: [INFO] Detected Theory App 2023-12-14 22:14:33 (13012): Guest Log: 17:03:27 CET +01:00 2023-12-14: cranky: [INFO] Checking CVMFS. 2023-12-14 22:14:33 (13012): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-14 22:14:33 (13012): 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 2023-12-14 22:14:33 (13012): Guest Log: 2.5.2.0 4038 0 28488 27903 3 1 1287421 4096001 0 65024 0 0 n/a 5 3 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-14 22:14:33 (13012): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-14 22:14:33 (13012): 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 2023-12-14 22:14:33 (13012): Guest Log: 2.5.2.0 4078 0 27656 22963 3 2 1287421 4096001 0 65024 0 2 0 5703 6003 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-14 22:14:33 (13012): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-14 22:14:33 (13012): 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 2023-12-14 22:14:33 (13012): Guest Log: 2.5.2.0 4067 0 25164 268 3 1 1287421 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-14 22:14:33 (13012): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-14 22:14:33 (13012): 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 2023-12-14 22:14:33 (13012): Guest Log: 2.5.2.0 4111 0 37604 17392 3 1 1287421 4096001 0 65024 0 0 n/a 4823 976 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2023-12-14 22:14:33 (13012): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Checking runc. 2023-12-14 22:14:33 (13012): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Creating the filesystem. 2023-12-14 22:14:33 (13012): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-14 22:14:33 (13012): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Updating config.json. 2023-12-14 22:14:33 (13012): Guest Log: 17:03:30 CET +01:00 2023-12-14: cranky: [INFO] Running Container 'runc'. 2023-12-14 22:14:33 (13012): Guest Log: job: htmld=/shared/html/job 2023-12-14 22:14:33 (13012): Guest Log: job: unpack exitcode=0 2023-12-14 22:14:33 (13012): Guest Log: 17:03:32 CET +01:00 2023-12-14: cranky: [INFO] ===> [runRivet] Thu Dec 14 16:03:31 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-14 22:14:33 (13012): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-14 22:14:44 (13012): Successfully started VM. (PID = '17640') 2023-12-14 22:14:44 (13012): Reporting VM Process ID to BOINC. 2023-12-14 22:14:44 (13012): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-14 22:14:44 (13012): Detected: Web Application Enabled (http://localhost:55722) 2023-12-14 22:14:45 (13012): VM state change detected. (old = 'running', new = 'paused') 2023-12-14 22:14:52 (13012): Status Report: Job Duration: '864000.000000' 2023-12-14 22:14:52 (13012): Status Report: Elapsed Time: '36160.221402' 2023-12-14 22:14:52 (13012): Status Report: CPU Time: '38870.578125' 2023-12-14 22:14:52 (13012): Preference change detected 2023-12-14 22:14:52 (13012): Setting CPU throttle for VM. (100%) 2023-12-14 22:14:52 (13012): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-14 22:14:53 (13012): VM state change detected. (old = 'paused', new = 'running') 2023-12-14 22:14:55 (13012): Guest Log: 00:17:00.583700 timesync vgsvcTimeSyncWorker: Radical host time change: 17 699 183 000 000ns (HostNow=1 702 588 494 938 000 000 ns HostLast=1 702 570 795 755 000 000 ns) 2023-12-14 22:15:05 (13012): Guest Log: 00:17:10.588546 timesync vgsvcTimeSyncWorker: Radical guest time change: 17 699 174 474 000ns (GuestNow=1 702 588 504 958 459 000 ns GuestLast=1 702 570 805 783 985 000 ns fSetTimeLastLoop=true ) 2023-12-14 22:39:17 (13012): Stopping VM. 2023-12-14 22:39:20 (13012): Successfully stopped VM. 2023-12-14 23:58:58 (4540): Detected: vboxwrapper 26206 2023-12-14 23:58:58 (4540): Detected: BOINC client v7.16.11 2023-12-14 23:58:59 (4540): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-14 23:58:59 (4540): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-14 23:59:00 (4540): Guest Log: 00:17:00.583700 timesync vgsvcTimeSyncWorker: Radical host time change: 17 699 183 000 000ns (HostNow=1 702 588 494 938 000 000 ns HostLast=1 702 570 795 755 000 000 ns) 2023-12-14 23:59:00 (4540): Guest Log: 00:17:10.588546 timesync vgsvcTimeSyncWorker: Radical guest time change: 17 699 174 474 000ns (GuestNow=1 702 588 504 958 459 000 ns GuestLast=1 702 570 805 783 985 000 ns fSetTimeLastLoop=true ) 2023-12-14 23:59:00 (4540): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-14 23:59:07 (4540): Successfully started VM. (PID = '6820') 2023-12-14 23:59:07 (4540): Reporting VM Process ID to BOINC. 2023-12-14 23:59:07 (4540): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-14 23:59:07 (4540): Detected: Web Application Enabled (http://localhost:55722) 2023-12-14 23:59:07 (4540): Status Report: Job Duration: '864000.000000' 2023-12-14 23:59:07 (4540): Status Report: Elapsed Time: '37624.221402' 2023-12-14 23:59:07 (4540): Status Report: CPU Time: '40336.156250' 2023-12-14 23:59:07 (4540): Preference change detected 2023-12-14 23:59:07 (4540): Setting CPU throttle for VM. (100%) 2023-12-14 23:59:07 (4540): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-14 23:59:14 (4540): Guest Log: 00:41:31.076869 timesync vgsvcTimeSyncWorker: Radical host time change: 4 798 985 000 000ns (HostNow=1 702 594 754 499 000 000 ns HostLast=1 702 589 955 514 000 000 ns) 2023-12-14 23:59:24 (4540): Guest Log: 00:41:41.078419 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 799 053 796 000ns (GuestNow=1 702 594 764 500 560 000 ns GuestLast=1 702 589 965 446 764 000 ns fSetTimeLastLoop=true ) 2023-12-15 13:43:35 (15816): Detected: vboxwrapper 26206 2023-12-15 13:43:35 (15816): Detected: BOINC client v7.16.11 2023-12-15 13:43:36 (15816): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-15 13:43:36 (15816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-15 13:43:37 (15816): Guest Log: 00:41:31.076869 timesync vgsvcTimeSyncWorker: Radical host time change: 4 798 985 000 000ns (HostNow=1 702 594 754 499 000 000 ns HostLast=1 702 589 955 514 000 000 ns) 2023-12-15 13:43:37 (15816): Guest Log: 00:41:41.078419 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 799 053 796 000ns (GuestNow=1 702 594 764 500 560 000 ns GuestLast=1 702 589 965 446 764 000 ns fSetTimeLastLoop=true ) 2023-12-15 13:43:37 (15816): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-15 13:43:41 (15816): Successfully started VM. (PID = '17556') 2023-12-15 13:43:41 (15816): Reporting VM Process ID to BOINC. 2023-12-15 13:43:41 (15816): Guest Log: BIOS: VirtualBox 6.1.12 2023-12-15 13:43:41 (15816): Guest Log: CPUID EDX: 0x178bfbff 2023-12-15 13:43:41 (15816): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-12-15 13:43:41 (15816): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-12-15 13:43:41 (15816): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-15 13:43:41 (15816): Detected: Web Application Enabled (http://localhost:55722) 2023-12-15 13:43:41 (15816): Status Report: Job Duration: '864000.000000' 2023-12-15 13:43:41 (15816): Status Report: Elapsed Time: '38521.221402' 2023-12-15 13:43:41 (15816): Status Report: CPU Time: '41229.781250' 2023-12-15 13:43:41 (15816): Preference change detected 2023-12-15 13:43:41 (15816): Setting CPU throttle for VM. (100%) 2023-12-15 13:43:41 (15816): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-15 13:43:43 (15816): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-12-15 13:43:43 (15816): Guest Log: BIOS: Booting from Hard Disk... 2023-12-15 13:43:46 (15816): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-12-15 13:43:46 (15816): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-12-15 13:44:03 (15816): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-12-15 13:44:03 (15816): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-12-15 13:44:05 (15816): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.000057 main Log opened 2023-12-15T12:44:05.440636000Z 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.000131 main OS Product: Linux 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.000156 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.000173 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.000189 main Executable: /usr/sbin/VBoxService 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.000190 main Process ID: 3206 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.000190 main Package type: LINUX_64BITS_GENERIC 2023-12-15 13:44:05 (15816): Guest Log: 00:00:00.005170 main 5.2.6 r120293 started. Verbose level = 0 2023-12-15 13:44:26 (15816): Guest Log: 13:44:26 CET +01:00 2023-12-15: cranky: [INFO] Detected Theory App 2023-12-15 13:44:26 (15816): Guest Log: 13:44:26 CET +01:00 2023-12-15: cranky: [INFO] Checking CVMFS. 2023-12-15 13:44:27 (15816): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-15 13:44:27 (15816): 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 2023-12-15 13:44:27 (15816): Guest Log: 2.5.2.0 4029 0 26132 27910 3 1 1311528 4096001 0 65024 0 0 n/a 5 11 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-15 13:44:27 (15816): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-15 13:44:27 (15816): 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 2023-12-15 13:44:27 (15816): Guest Log: 2.5.2.0 4101 0 27448 22969 3 2 1311528 4096001 0 65024 0 2 0 5702 5782 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-15 13:44:28 (15816): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-15 13:44:28 (15816): 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 2023-12-15 13:44:28 (15816): Guest Log: 2.5.2.0 4054 0 25164 268 3 1 1311528 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-15 13:44:29 (15816): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-15 13:44:29 (15816): 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 2023-12-15 13:44:29 (15816): Guest Log: 2.5.2.0 4079 0 37608 17398 3 1 1311528 4096001 0 65024 0 0 n/a 4825 3426 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2023-12-15 13:44:29 (15816): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Checking runc. 2023-12-15 13:44:29 (15816): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Creating the filesystem. 2023-12-15 13:44:29 (15816): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-15 13:44:29 (15816): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Updating config.json. 2023-12-15 13:44:29 (15816): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Running Container 'runc'. 2023-12-15 13:44:29 (15816): Guest Log: job: htmld=/shared/html/job 2023-12-15 13:44:29 (15816): Guest Log: job: unpack exitcode=0 2023-12-15 13:44:31 (15816): Guest Log: 13:44:31 CET +01:00 2023-12-15: cranky: [INFO] ===> [runRivet] Fri Dec 15 12:44:29 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-15 13:56:52 (15816): Stopping VM. 2023-12-15 13:56:55 (15816): Successfully stopped VM. 2023-12-15 22:08:09 (708): Detected: vboxwrapper 26206 2023-12-15 22:08:09 (708): Detected: BOINC client v7.16.11 2023-12-15 22:08:10 (708): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-15 22:08:11 (708): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-15 22:08:11 (708): Guest Log: BIOS: VirtualBox 6.1.12 2023-12-15 22:08:11 (708): Guest Log: CPUID EDX: 0x178bfbff 2023-12-15 22:08:11 (708): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-12-15 22:08:11 (708): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-12-15 22:08:11 (708): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-12-15 22:08:11 (708): Guest Log: BIOS: Booting from Hard Disk... 2023-12-15 22:08:11 (708): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-12-15 22:08:11 (708): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-12-15 22:08:11 (708): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-12-15 22:08:11 (708): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-12-15 22:08:11 (708): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.000057 main Log opened 2023-12-15T12:44:05.440636000Z 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.000131 main OS Product: Linux 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.000156 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.000173 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.000189 main Executable: /usr/sbin/VBoxService 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.000190 main Process ID: 3206 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.000190 main Package type: LINUX_64BITS_GENERIC 2023-12-15 22:08:11 (708): Guest Log: 00:00:00.005170 main 5.2.6 r120293 started. Verbose level = 0 2023-12-15 22:08:11 (708): Guest Log: 13:44:26 CET +01:00 2023-12-15: cranky: [INFO] Detected Theory App 2023-12-15 22:08:11 (708): Guest Log: 13:44:26 CET +01:00 2023-12-15: cranky: [INFO] Checking CVMFS. 2023-12-15 22:08:11 (708): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-15 22:08:11 (708): 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 2023-12-15 22:08:11 (708): Guest Log: 2.5.2.0 4029 0 26132 27910 3 1 1311528 4096001 0 65024 0 0 n/a 5 11 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-15 22:08:11 (708): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-15 22:08:11 (708): 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 2023-12-15 22:08:11 (708): Guest Log: 2.5.2.0 4101 0 27448 22969 3 2 1311528 4096001 0 65024 0 2 0 5702 5782 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-15 22:08:11 (708): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-15 22:08:11 (708): 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 2023-12-15 22:08:11 (708): Guest Log: 2.5.2.0 4054 0 25164 268 3 1 1311528 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-15 22:08:11 (708): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-15 22:08:11 (708): 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 2023-12-15 22:08:11 (708): Guest Log: 2.5.2.0 4079 0 37608 17398 3 1 1311528 4096001 0 65024 0 0 n/a 4825 3426 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2023-12-15 22:08:11 (708): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Checking runc. 2023-12-15 22:08:11 (708): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Creating the filesystem. 2023-12-15 22:08:11 (708): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-15 22:08:11 (708): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Updating config.json. 2023-12-15 22:08:11 (708): Guest Log: 13:44:29 CET +01:00 2023-12-15: cranky: [INFO] Running Container 'runc'. 2023-12-15 22:08:11 (708): Guest Log: job: htmld=/shared/html/job 2023-12-15 22:08:11 (708): Guest Log: job: unpack exitcode=0 2023-12-15 22:08:11 (708): Guest Log: 13:44:31 CET +01:00 2023-12-15: cranky: [INFO] ===> [runRivet] Fri Dec 15 12:44:29 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-15 22:08:11 (708): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-15 22:08:22 (708): Successfully started VM. (PID = '16900') 2023-12-15 22:08:22 (708): Reporting VM Process ID to BOINC. 2023-12-15 22:08:22 (708): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-15 22:08:22 (708): Detected: Web Application Enabled (http://localhost:55722) 2023-12-15 22:08:23 (708): VM state change detected. (old = 'running', new = 'paused') 2023-12-15 22:08:30 (708): Status Report: Job Duration: '864000.000000' 2023-12-15 22:08:30 (708): Status Report: Elapsed Time: '39309.221402' 2023-12-15 22:08:30 (708): Status Report: CPU Time: '41967.671875' 2023-12-15 22:08:30 (708): Preference change detected 2023-12-15 22:08:30 (708): Setting CPU throttle for VM. (100%) 2023-12-15 22:08:30 (708): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-15 22:08:31 (708): VM state change detected. (old = 'paused', new = 'running') 2023-12-15 22:08:32 (708): Guest Log: 00:12:50.422862 timesync vgsvcTimeSyncWorker: Radical host time change: 29 506 266 000 000ns (HostNow=1 702 674 511 811 000 000 ns HostLast=1 702 645 005 545 000 000 ns) 2023-12-15 22:08:42 (708): Guest Log: 00:13:00.455147 timesync vgsvcTimeSyncWorker: Radical guest time change: 29 506 085 346 000ns (GuestNow=1 702 674 521 862 441 000 ns GuestLast=1 702 645 015 777 095 000 ns fSetTimeLastLoop=true ) 2023-12-15 22:31:06 (708): Stopping VM. 2023-12-15 22:31:10 (708): Successfully stopped VM. 2023-12-16 00:51:29 (14560): Detected: vboxwrapper 26206 2023-12-16 00:51:29 (14560): Detected: BOINC client v7.16.11 2023-12-16 00:51:30 (14560): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-16 00:51:30 (14560): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-16 00:51:31 (14560): Guest Log: 00:12:50.422862 timesync vgsvcTimeSyncWorker: Radical host time change: 29 506 266 000 000ns (HostNow=1 702 674 511 811 000 000 ns HostLast=1 702 645 005 545 000 000 ns) 2023-12-16 00:51:31 (14560): Guest Log: 00:13:00.455147 timesync vgsvcTimeSyncWorker: Radical guest time change: 29 506 085 346 000ns (GuestNow=1 702 674 521 862 441 000 ns GuestLast=1 702 645 015 777 095 000 ns fSetTimeLastLoop=true ) 2023-12-16 00:51:31 (14560): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-16 00:51:37 (14560): Successfully started VM. (PID = '7588') 2023-12-16 00:51:37 (14560): Reporting VM Process ID to BOINC. 2023-12-16 00:51:37 (14560): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-16 00:51:37 (14560): Detected: Web Application Enabled (http://localhost:55722) 2023-12-16 00:51:37 (14560): Status Report: Job Duration: '864000.000000' 2023-12-16 00:51:37 (14560): Status Report: Elapsed Time: '40664.221402' 2023-12-16 00:51:37 (14560): Status Report: CPU Time: '43322.406250' 2023-12-16 00:51:37 (14560): Preference change detected 2023-12-16 00:51:37 (14560): Setting CPU throttle for VM. (100%) 2023-12-16 00:51:37 (14560): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-16 00:51:42 (14560): Guest Log: 00:35:30.901837 timesync vgsvcTimeSyncWorker: Radical host time change: 8 439 894 000 000ns (HostNow=1 702 684 302 269 000 000 ns HostLast=1 702 675 862 375 000 000 ns) 2023-12-16 00:51:52 (14560): Guest Log: 00:35:40.902454 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 439 960 506 000ns (GuestNow=1 702 684 312 269 621 000 ns GuestLast=1 702 675 872 309 115 000 ns fSetTimeLastLoop=true ) 2023-12-16 09:52:08 (16460): Detected: vboxwrapper 26206 2023-12-16 09:52:08 (16460): Detected: BOINC client v7.16.11 2023-12-16 09:52:09 (16460): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-16 09:52:09 (16460): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-16 09:52:10 (16460): Guest Log: 00:35:30.901837 timesync vgsvcTimeSyncWorker: Radical host time change: 8 439 894 000 000ns (HostNow=1 702 684 302 269 000 000 ns HostLast=1 702 675 862 375 000 000 ns) 2023-12-16 09:52:10 (16460): Guest Log: 00:35:40.902454 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 439 960 506 000ns (GuestNow=1 702 684 312 269 621 000 ns GuestLast=1 702 675 872 309 115 000 ns fSetTimeLastLoop=true ) 2023-12-16 09:52:10 (16460): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-16 09:52:14 (16460): Successfully started VM. (PID = '5644') 2023-12-16 09:52:14 (16460): Reporting VM Process ID to BOINC. 2023-12-16 09:52:14 (16460): Guest Log: BIOS: VirtualBox 6.1.12 2023-12-16 09:52:14 (16460): Guest Log: CPUID EDX: 0x178bfbff 2023-12-16 09:52:14 (16460): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-12-16 09:52:14 (16460): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-12-16 09:52:14 (16460): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-16 09:52:14 (16460): Detected: Web Application Enabled (http://localhost:55722) 2023-12-16 09:52:14 (16460): Status Report: Job Duration: '864000.000000' 2023-12-16 09:52:14 (16460): Status Report: Elapsed Time: '41260.221402' 2023-12-16 09:52:14 (16460): Status Report: CPU Time: '43915.656250' 2023-12-16 09:52:14 (16460): Preference change detected 2023-12-16 09:52:14 (16460): Setting CPU throttle for VM. (100%) 2023-12-16 09:52:14 (16460): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-16 09:52:16 (16460): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-12-16 09:52:16 (16460): Guest Log: BIOS: Booting from Hard Disk... 2023-12-16 09:52:19 (16460): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-12-16 09:52:19 (16460): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-12-16 09:52:38 (16460): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-12-16 09:52:38 (16460): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-12-16 09:52:41 (16460): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.000132 main Log opened 2023-12-16T08:52:42.977439000Z 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.000785 main OS Product: Linux 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.000824 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.000845 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.000871 main Executable: /usr/sbin/VBoxService 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.000872 main Process ID: 3214 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.000872 main Package type: LINUX_64BITS_GENERIC 2023-12-16 09:52:41 (16460): Guest Log: 00:00:00.001899 main 5.2.6 r120293 started. Verbose level = 0 2023-12-16 09:53:03 (16460): Guest Log: 09:53:04 CET +01:00 2023-12-16: cranky: [INFO] Detected Theory App 2023-12-16 09:53:03 (16460): Guest Log: 09:53:04 CET +01:00 2023-12-16: cranky: [INFO] Checking CVMFS. 2023-12-16 09:53:03 (16460): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-16 09:53:04 (16460): 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 2023-12-16 09:53:04 (16460): Guest Log: 2.5.2.0 4063 0 27192 27915 3 1 1335640 4096001 0 65024 0 0 n/a 5 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-16 09:53:05 (16460): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-16 09:53:05 (16460): 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 2023-12-16 09:53:05 (16460): Guest Log: 2.5.2.0 4088 0 25644 22977 3 2 1335640 4096001 0 65024 0 2 0 5700 12284 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-16 09:53:05 (16460): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-16 09:53:06 (16460): 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 2023-12-16 09:53:06 (16460): Guest Log: 2.5.2.0 4038 0 27200 268 3 1 1335640 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-16 09:53:06 (16460): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-16 09:53:06 (16460): 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 2023-12-16 09:53:06 (16460): Guest Log: 2.5.2.0 4111 0 37780 17405 3 1 1335640 4096001 0 65024 0 0 n/a 4829 1298 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2023-12-16 09:53:06 (16460): Guest Log: 09:53:07 CET +01:00 2023-12-16: cranky: [INFO] Checking runc. 2023-12-16 09:53:06 (16460): Guest Log: 09:53:07 CET +01:00 2023-12-16: cranky: [INFO] Creating the filesystem. 2023-12-16 09:53:06 (16460): Guest Log: 09:53:07 CET +01:00 2023-12-16: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-16 09:53:06 (16460): Guest Log: 09:53:08 CET +01:00 2023-12-16: cranky: [INFO] Updating config.json. 2023-12-16 09:53:06 (16460): Guest Log: 09:53:08 CET +01:00 2023-12-16: cranky: [INFO] Running Container 'runc'. 2023-12-16 09:53:07 (16460): Guest Log: job: htmld=/shared/html/job 2023-12-16 09:53:07 (16460): Guest Log: job: unpack exitcode=0 2023-12-16 09:53:08 (16460): Guest Log: 09:53:10 CET +01:00 2023-12-16: cranky: [INFO] ===> [runRivet] Sat Dec 16 08:53:08 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-16 09:55:31 (16460): VM state change detected. (old = 'running', new = 'paused') 2023-12-16 09:55:51 (16460): VM state change detected. (old = 'paused', new = 'running') 2023-12-16 10:02:54 (16460): Stopping VM. 2023-12-16 10:02:57 (16460): Successfully stopped VM. 2023-12-16 11:54:53 (19852): Detected: vboxwrapper 26206 2023-12-16 11:54:53 (19852): Detected: BOINC client v7.16.11 2023-12-16 11:54:54 (19852): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-16 11:54:55 (19852): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-16 11:54:55 (19852): Guest Log: BIOS: VirtualBox 6.1.12 2023-12-16 11:54:55 (19852): Guest Log: CPUID EDX: 0x178bfbff 2023-12-16 11:54:55 (19852): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-12-16 11:54:55 (19852): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-12-16 11:54:55 (19852): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-12-16 11:54:55 (19852): Guest Log: BIOS: Booting from Hard Disk... 2023-12-16 11:54:55 (19852): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-12-16 11:54:55 (19852): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-12-16 11:54:55 (19852): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-12-16 11:54:55 (19852): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-12-16 11:54:55 (19852): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.000132 main Log opened 2023-12-16T08:52:42.977439000Z 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.000785 main OS Product: Linux 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.000824 main OS Release: 4.14.76-13.cernvm.x86_64 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.000845 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.000871 main Executable: /usr/sbin/VBoxService 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.000872 main Process ID: 3214 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.000872 main Package type: LINUX_64BITS_GENERIC 2023-12-16 11:54:55 (19852): Guest Log: 00:00:00.001899 main 5.2.6 r120293 started. Verbose level = 0 2023-12-16 11:54:55 (19852): Guest Log: 09:53:04 CET +01:00 2023-12-16: cranky: [INFO] Detected Theory App 2023-12-16 11:54:55 (19852): Guest Log: 09:53:04 CET +01:00 2023-12-16: cranky: [INFO] Checking CVMFS. 2023-12-16 11:54:55 (19852): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-12-16 11:54:55 (19852): 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 2023-12-16 11:54:55 (19852): Guest Log: 2.5.2.0 4063 0 27192 27915 3 1 1335640 4096001 0 65024 0 0 n/a 5 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-12-16 11:54:55 (19852): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-12-16 11:54:55 (19852): 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 2023-12-16 11:54:55 (19852): Guest Log: 2.5.2.0 4088 0 25644 22977 3 2 1335640 4096001 0 65024 0 2 0 5700 12284 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-12-16 11:54:55 (19852): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-12-16 11:54:55 (19852): 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 2023-12-16 11:54:55 (19852): Guest Log: 2.5.2.0 4038 0 27200 268 3 1 1335640 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-12-16 11:54:55 (19852): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-12-16 11:54:55 (19852): 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 2023-12-16 11:54:55 (19852): Guest Log: 2.5.2.0 4111 0 37780 17405 3 1 1335640 4096001 0 65024 0 0 n/a 4829 1298 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2023-12-16 11:54:55 (19852): Guest Log: 09:53:07 CET +01:00 2023-12-16: cranky: [INFO] Checking runc. 2023-12-16 11:54:55 (19852): Guest Log: 09:53:07 CET +01:00 2023-12-16: cranky: [INFO] Creating the filesystem. 2023-12-16 11:54:55 (19852): Guest Log: 09:53:07 CET +01:00 2023-12-16: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-12-16 11:54:55 (19852): Guest Log: 09:53:08 CET +01:00 2023-12-16: cranky: [INFO] Updating config.json. 2023-12-16 11:54:55 (19852): Guest Log: 09:53:08 CET +01:00 2023-12-16: cranky: [INFO] Running Container 'runc'. 2023-12-16 11:54:55 (19852): Guest Log: job: htmld=/shared/html/job 2023-12-16 11:54:55 (19852): Guest Log: job: unpack exitcode=0 2023-12-16 11:54:55 (19852): Guest Log: 09:53:10 CET +01:00 2023-12-16: cranky: [INFO] ===> [runRivet] Sat Dec 16 08:53:08 UTC 2023 [boinc pp jets 7000 20,-,310 - pythia8 8.301 tune-2m 100000 1016] 2023-12-16 11:54:55 (19852): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-16 11:55:02 (19852): Successfully started VM. (PID = '12968') 2023-12-16 11:55:02 (19852): Reporting VM Process ID to BOINC. 2023-12-16 11:55:02 (19852): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-16 11:55:02 (19852): Detected: Web Application Enabled (http://localhost:55722) 2023-12-16 11:55:02 (19852): Status Report: Job Duration: '864000.000000' 2023-12-16 11:55:02 (19852): Status Report: Elapsed Time: '41876.221402' 2023-12-16 11:55:02 (19852): Status Report: CPU Time: '44479.812500' 2023-12-16 11:55:02 (19852): Preference change detected 2023-12-16 11:55:02 (19852): Setting CPU throttle for VM. (100%) 2023-12-16 11:55:03 (19852): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-16 11:55:07 (19852): Guest Log: 00:10:00.350764 timesync vgsvcTimeSyncWorker: Radical host time change: 6 736 582 000 000ns (HostNow=1 702 724 107 443 000 000 ns HostLast=1 702 717 370 861 000 000 ns) 2023-12-16 11:55:17 (19852): Guest Log: 00:10:10.375711 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 754 232 933 000ns (GuestNow=1 702 724 117 491 658 000 ns GuestLast=1 702 717 363 258 725 000 ns fSetTimeLastLoop=true ) 2023-12-16 13:35:08 (19852): Status Report: Job Duration: '864000.000000' 2023-12-16 13:35:08 (19852): Status Report: Elapsed Time: '47876.221402' 2023-12-16 13:35:08 (19852): Status Report: CPU Time: '50481.000000' 2023-12-16 14:03:50 (19852): Stopping VM. 2023-12-16 14:03:53 (19852): Successfully stopped VM. 2023-12-16 17:31:31 (15276): Detected: vboxwrapper 26206 2023-12-16 17:31:31 (15276): Detected: BOINC client v7.16.11 2023-12-16 17:31:32 (15276): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-16 17:31:32 (15276): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-16 17:31:33 (15276): Guest Log: 00:10:00.350764 timesync vgsvcTimeSyncWorker: Radical host time change: 6 736 582 000 000ns (HostNow=1 702 724 107 443 000 000 ns HostLast=1 702 717 370 861 000 000 ns) 2023-12-16 17:31:33 (15276): Guest Log: 00:10:10.375711 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 754 232 933 000ns (GuestNow=1 702 724 117 491 658 000 ns GuestLast=1 702 717 363 258 725 000 ns fSetTimeLastLoop=true ) 2023-12-16 17:31:33 (15276): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-16 17:31:39 (15276): Successfully started VM. (PID = '20280') 2023-12-16 17:31:39 (15276): Reporting VM Process ID to BOINC. 2023-12-16 17:31:39 (15276): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-16 17:31:39 (15276): Detected: Web Application Enabled (http://localhost:55722) 2023-12-16 17:31:39 (15276): Status Report: Job Duration: '864000.000000' 2023-12-16 17:31:39 (15276): Status Report: Elapsed Time: '49597.221402' 2023-12-16 17:31:39 (15276): Status Report: CPU Time: '52201.156250' 2023-12-16 17:31:39 (15276): Preference change detected 2023-12-16 17:31:39 (15276): Setting CPU throttle for VM. (100%) 2023-12-16 17:31:40 (15276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-16 17:31:48 (15276): Guest Log: 02:18:53.119037 timesync vgsvcTimeSyncWorker: Radical host time change: 12 477 557 000 000ns (HostNow=1 702 744 307 834 000 000 ns HostLast=1 702 731 830 277 000 000 ns) 2023-12-16 17:31:58 (15276): Guest Log: 02:19:03.120136 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 477 600 133 000ns (GuestNow=1 702 744 317 835 105 000 ns GuestLast=1 702 731 840 234 972 000 ns fSetTimeLastLoop=true ) 2023-12-16 17:54:03 (15276): Stopping VM. 2023-12-16 17:54:06 (15276): Successfully stopped VM. 2023-12-16 18:04:35 (18860): Detected: vboxwrapper 26206 2023-12-16 18:04:35 (18860): Detected: BOINC client v7.16.11 2023-12-16 18:04:36 (18860): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2023-12-16 18:04:36 (18860): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-12-16 18:04:37 (18860): Guest Log: 02:18:53.119037 timesync vgsvcTimeSyncWorker: Radical host time change: 12 477 557 000 000ns (HostNow=1 702 744 307 834 000 000 ns HostLast=1 702 731 830 277 000 000 ns) 2023-12-16 18:04:37 (18860): Guest Log: 02:19:03.120136 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 477 600 133 000ns (GuestNow=1 702 744 317 835 105 000 ns GuestLast=1 702 731 840 234 972 000 ns fSetTimeLastLoop=true ) 2023-12-16 18:04:37 (18860): Starting VM using VBoxManage interface. (boinc_801e324789311ada, slot#13) 2023-12-16 18:04:44 (18860): Successfully started VM. (PID = '1032') 2023-12-16 18:04:44 (18860): Reporting VM Process ID to BOINC. 2023-12-16 18:04:44 (18860): VM state change detected. (old = 'poweredoff', new = 'running') 2023-12-16 18:04:44 (18860): Detected: Web Application Enabled (http://localhost:55722) 2023-12-16 18:04:44 (18860): Status Report: Job Duration: '864000.000000' 2023-12-16 18:04:44 (18860): Status Report: Elapsed Time: '50940.221402' 2023-12-16 18:04:44 (18860): Status Report: CPU Time: '53541.984375' 2023-12-16 18:04:44 (18860): Preference change detected 2023-12-16 18:04:44 (18860): Setting CPU throttle for VM. (100%) 2023-12-16 18:04:44 (18860): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-12-16 18:08:06 (18860): Guest Log: job: run exitcode=0 2023-12-16 18:08:06 (18860): Guest Log: job: diskusage=2592 2023-12-16 18:08:06 (18860): Guest Log: job: logsize=124 k 2023-12-16 18:08:06 (18860): Guest Log: job: times= 2023-12-16 18:08:06 (18860): Guest Log: 0m0.006s 0m0.006s 2023-12-16 18:08:06 (18860): Guest Log: 162m13.582s 0m43.310s 2023-12-16 18:08:06 (18860): Guest Log: job: cpuusage=9777 2023-12-16 18:08:06 (18860): Guest Log: 18:08:06 CET +01:00 2023-12-16: cranky: [INFO] Container 'runc' finished with status code 0. 2023-12-16 18:08:06 (18860): Guest Log: 18:08:06 CET +01:00 2023-12-16: cranky: [INFO] Preparing output. 2023-12-16 18:08:07 (18860): Guest Log: [INFO] Job Finished 2023-12-16 18:08:07 (18860): Guest Log: [INFO] Shutting Down. 2023-12-16 18:08:07 (18860): VM Completion File Detected. 2023-12-16 18:08:07 (18860): VM Completion Message: Job Finished . 2023-12-16 18:08:07 (18860): Powering off VM. 2023-12-16 18:08:08 (18860): Successfully stopped VM. 2023-12-16 18:08:08 (18860): Deregistering VM. (boinc_801e324789311ada, slot#13) 2023-12-16 18:08:08 (18860): Removing network bandwidth throttle group from VM. 2023-12-16 18:08:08 (18860): Removing VM from VirtualBox. 18:08:13 (18860): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN