| Name | Theory_2390-1125309-270_0 |
| Workunit | 192111650 |
| Created | 14 Jul 2022, 16:02:37 UTC |
| Sent | 15 Jul 2022, 4:21:58 UTC |
| Report deadline | 26 Jul 2022, 4:21:58 UTC |
| Received | 30 Jul 2022, 4:30:23 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10695100 |
| Run time | 2 days 1 hours 5 min 3 sec |
| CPU time | 14 hours 35 min 51 sec |
| Validate state | Valid |
| Credit | 2,242.84 |
| Device peak FLOPS | 5.48 GFLOPS |
| Application version | Theory Simulation v300.06 (vbox64_theory) windows_x86_64 |
| Peak working set size | 67.44 MB |
| Peak swap size | 82.97 MB |
| Peak disk usage | 3.30 GB |
Stderr output
<core_client_version>7.16.20</core_client_version> <![CDATA[ <stderr_txt> 2022-07-15 06:22:09 (13684): Detected: vboxwrapper 26197 2022-07-15 06:22:09 (13684): Detected: BOINC client v7.7 2022-07-15 06:22:10 (13684): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-15 06:22:10 (13684): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-15 06:22:10 (13684): Successfully copied 'init_data.xml' to the shared directory. 2022-07-15 06:22:10 (13684): Successfully copied 'input' to the shared directory. 2022-07-15 06:22:11 (13684): Create VM. (boinc_89404c5753fb291d, slot#5) 2022-07-15 06:22:12 (13684): Setting Memory Size for VM. (630MB) 2022-07-15 06:22:12 (13684): Setting CPU Count for VM. (1) 2022-07-15 06:22:12 (13684): Setting Chipset Options for VM. 2022-07-15 06:22:12 (13684): Setting Boot Options for VM. 2022-07-15 06:22:13 (13684): Setting Network Configuration for NAT. 2022-07-15 06:22:13 (13684): Enabling VM Network Access. 2022-07-15 06:22:13 (13684): Disabling USB Support for VM. 2022-07-15 06:22:13 (13684): Disabling COM Port Support for VM. 2022-07-15 06:22:14 (13684): Disabling LPT Port Support for VM. 2022-07-15 06:22:14 (13684): Disabling Audio Support for VM. 2022-07-15 06:22:14 (13684): Disabling Clipboard Support for VM. 2022-07-15 06:22:14 (13684): Disabling Drag and Drop Support for VM. 2022-07-15 06:22:15 (13684): Adding storage controller(s) to VM. 2022-07-15 06:22:15 (13684): Adding virtual disk drive to VM. (vm_image.vdi) 2022-07-15 06:22:15 (13684): Adding VirtualBox Guest Additions to VM. 2022-07-15 06:22:15 (13684): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2022-07-15 06:22:16 (13684): forwarding host port 58014 to guest port 80 2022-07-15 06:22:16 (13684): Enabling remote desktop for VM. 2022-07-15 06:22:16 (13684): Enabling shared directory for VM. 2022-07-15 06:22:17 (13684): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-15 06:22:20 (13684): Successfully started VM. (PID = '12944') 2022-07-15 06:22:20 (13684): Reporting VM Process ID to BOINC. 2022-07-15 06:22:20 (13684): Guest Log: BIOS: VirtualBox 6.1.28 2022-07-15 06:22:20 (13684): Guest Log: CPUID EDX: 0x178bfbff 2022-07-15 06:22:20 (13684): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-07-15 06:22:20 (13684): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-15 06:22:20 (13684): Detected: Web Application Enabled (http://localhost:58014) 2022-07-15 06:22:20 (13684): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-15 06:22:20 (13684): Preference change detected 2022-07-15 06:22:20 (13684): Setting CPU throttle for VM. (30%) 2022-07-15 06:22:21 (13684): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-15 06:22:22 (13684): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-15 06:22:22 (13684): Guest Log: BIOS: Booting from Hard Disk... 2022-07-15 06:22:24 (13684): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-15 06:22:24 (13684): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-15 06:22:52 (13684): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-15 06:22:52 (13684): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-15 06:22:57 (13684): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.000048 main Log opened 2022-07-15T04:22:52.601368000Z 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.000098 main OS Product: Linux 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.000117 main OS Release: 4.14.76-13.cernvm.x86_64 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.000132 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.000151 main Executable: /usr/sbin/VBoxService 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.000151 main Process ID: 3200 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.000152 main Package type: LINUX_64BITS_GENERIC 2022-07-15 06:22:57 (13684): Guest Log: 00:00:00.005718 main 5.2.6 r120293 started. Verbose level = 0 2022-07-15 06:23:39 (13684): Guest Log: 06:23:34 CEST +02:00 2022-07-15: cranky: [INFO] Detected Theory App 2022-07-15 06:23:39 (13684): Guest Log: 06:23:34 CEST +02:00 2022-07-15: cranky: [INFO] Checking CVMFS. 2022-07-15 06:23:40 (13684): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-07-15 06:23:41 (13684): 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 2022-07-15 06:23:41 (13684): Guest Log: 2.5.2.0 4044 0 28596 23370 3 1 264992 4096000 0 65024 0 0 n/a 5 2 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-07-15 06:23:42 (13684): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-07-15 06:23:43 (13684): 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 2022-07-15 06:23:43 (13684): Guest Log: 2.5.2.0 4119 0 27540 18721 3 2 264992 4096000 0 65024 0 2 -100 7754 400 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-07-15 06:23:44 (13684): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-07-15 06:23:45 (13684): 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 2022-07-15 06:23:45 (13684): Guest Log: 2.5.2.0 4093 0 27220 268 3 1 264992 4096000 0 65024 0 0 n/a 4 3 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-07-15 06:23:46 (13684): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-07-15 06:23:48 (13684): 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 2022-07-15 06:23:48 (13684): Guest Log: 2.5.2.0 4071 0 33480 12818 3 1 264992 4096000 0 65024 0 0 n/a 2842 355 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-07-15 06:23:48 (13684): Guest Log: 06:23:44 CEST +02:00 2022-07-15: cranky: [INFO] Checking runc. 2022-07-15 06:23:49 (13684): Guest Log: 06:23:44 CEST +02:00 2022-07-15: cranky: [INFO] Creating the filesystem. 2022-07-15 06:23:49 (13684): Guest Log: 06:23:44 CEST +02:00 2022-07-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-07-15 06:23:49 (13684): Guest Log: 06:23:44 CEST +02:00 2022-07-15: cranky: [INFO] Updating config.json. 2022-07-15 06:23:49 (13684): Guest Log: 06:23:44 CEST +02:00 2022-07-15: cranky: [INFO] Running Container 'runc'. 2022-07-15 06:24:41 (13684): Guest Log: job: htmld=/shared/html/job 2022-07-15 06:24:41 (13684): Guest Log: job: unpack exitcode=0 2022-07-15 06:24:41 (13684): Guest Log: 06:24:36 CEST +02:00 2022-07-15: cranky: [INFO] ===> [runRivet] Fri Jul 15 04:24:36 UTC 2022 [boinc pp jets 7000 65 - pythia8 8.240 cr1 100000 270] 2022-07-15 06:51:54 (13684): Stopping VM. 2022-07-15 06:53:31 (13316): Detected: vboxwrapper 26197 2022-07-15 06:53:31 (13316): Detected: BOINC client v7.7 2022-07-15 06:53:31 (13316): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-15 06:53:32 (13316): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-15 06:53:32 (13316): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-15 06:53:37 (13316): Successfully started VM. (PID = '6812') 2022-07-15 06:53:37 (13316): Reporting VM Process ID to BOINC. 2022-07-15 06:53:37 (13316): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-15 06:53:37 (13316): Detected: Web Application Enabled (http://localhost:58014) 2022-07-15 06:53:37 (13316): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-15 06:53:37 (13316): Preference change detected 2022-07-15 06:53:37 (13316): Setting CPU throttle for VM. (30%) 2022-07-15 06:53:37 (13316): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-15 07:31:05 (13316): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 07:31:25 (13316): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 07:31:35 (13316): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 07:31:45 (13316): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 07:31:55 (13316): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 07:32:05 (13316): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 08:03:01 (13316): Stopping VM. 2022-07-15 08:04:23 (14600): Detected: vboxwrapper 26197 2022-07-15 08:04:23 (14600): Detected: BOINC client v7.7 2022-07-15 08:04:24 (14600): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-15 08:04:24 (14600): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-15 08:04:24 (14600): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-15 08:04:30 (14600): Successfully started VM. (PID = '15320') 2022-07-15 08:04:30 (14600): Reporting VM Process ID to BOINC. 2022-07-15 08:04:30 (14600): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-15 08:04:30 (14600): Detected: Web Application Enabled (http://localhost:58014) 2022-07-15 08:04:30 (14600): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-15 08:04:30 (14600): Preference change detected 2022-07-15 08:04:30 (14600): Setting CPU throttle for VM. (30%) 2022-07-15 08:04:30 (14600): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-15 08:06:22 (14600): Status Report: Job Duration: '864000.000000' 2022-07-15 08:06:22 (14600): Status Report: Elapsed Time: '6000.553101' 2022-07-15 08:06:22 (14600): Status Report: CPU Time: '1530.375000' 2022-07-15 08:09:58 (14600): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 08:10:18 (14600): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 08:22:29 (14600): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 08:22:39 (14600): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 08:51:01 (14600): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 08:51:11 (14600): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 09:37:52 (14600): Stopping VM. 2022-07-15 09:39:54 (8272): Detected: vboxwrapper 26197 2022-07-15 09:39:54 (8272): Detected: BOINC client v7.7 2022-07-15 09:39:54 (8272): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-15 09:39:55 (8272): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-15 09:39:55 (8272): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-15 09:40:00 (8272): Successfully started VM. (PID = '324') 2022-07-15 09:40:00 (8272): Reporting VM Process ID to BOINC. 2022-07-15 09:40:00 (8272): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-15 09:40:00 (8272): Detected: Web Application Enabled (http://localhost:58014) 2022-07-15 09:40:00 (8272): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-15 09:40:00 (8272): Status Report: Job Duration: '864000.000000' 2022-07-15 09:40:00 (8272): Status Report: Elapsed Time: '11442.553101' 2022-07-15 09:40:00 (8272): Status Report: CPU Time: '3170.984375' 2022-07-15 09:40:00 (8272): Preference change detected 2022-07-15 09:40:00 (8272): Setting CPU throttle for VM. (30%) 2022-07-15 09:40:01 (8272): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-15 10:43:27 (8272): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 10:43:37 (8272): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 11:20:18 (8272): Status Report: Job Duration: '864000.000000' 2022-07-15 11:20:18 (8272): Status Report: Elapsed Time: '17443.553101' 2022-07-15 11:20:18 (8272): Status Report: CPU Time: '4982.968750' 2022-07-15 12:07:12 (8272): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-15 12:07:22 (8272): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-15 13:00:36 (8272): Status Report: Job Duration: '864000.000000' 2022-07-15 13:00:36 (8272): Status Report: Elapsed Time: '23443.553101' 2022-07-15 13:00:36 (8272): Status Report: CPU Time: '6790.953125' 2022-07-15 13:38:00 (8272): VM state change detected. (old = 'Running', new = 'Saving') 2022-07-15 13:38:01 (8272): Stopping VM. 2022-07-15 13:38:01 (8272): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_89404c5753fb291d" savestate Output: 2022-07-15 13:38:01 (8272): VM did not stop when requested. 2022-07-15 13:38:01 (8272): VM was successfully terminated. 2022-07-22 06:25:50 (6868): Detected: vboxwrapper 26197 2022-07-22 06:25:50 (6868): Detected: BOINC client v7.7 2022-07-22 06:25:51 (6868): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-22 06:25:51 (6868): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-22 06:25:51 (6868): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-22 06:25:55 (6868): Successfully started VM. (PID = '12508') 2022-07-22 06:25:55 (6868): Reporting VM Process ID to BOINC. 2022-07-22 06:25:55 (6868): Guest Log: BIOS: VirtualBox 6.1.28 2022-07-22 06:25:55 (6868): Guest Log: CPUID EDX: 0x178bfbff 2022-07-22 06:25:55 (6868): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-07-22 06:25:55 (6868): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-22 06:25:55 (6868): Detected: Web Application Enabled (http://localhost:58014) 2022-07-22 06:25:55 (6868): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-22 06:25:55 (6868): Status Report: Job Duration: '864000.000000' 2022-07-22 06:25:55 (6868): Status Report: Elapsed Time: '25686.553101' 2022-07-22 06:25:55 (6868): Status Report: CPU Time: '7466.734375' 2022-07-22 06:25:55 (6868): Preference change detected 2022-07-22 06:25:55 (6868): Setting CPU throttle for VM. (30%) 2022-07-22 06:25:56 (6868): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-22 06:25:57 (6868): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-22 06:25:57 (6868): Guest Log: BIOS: Booting from Hard Disk... 2022-07-22 06:26:00 (6868): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-22 06:26:00 (6868): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-22 06:26:29 (6868): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-22 06:26:29 (6868): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-22 06:26:33 (6868): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.000054 main Log opened 2022-07-22T04:26:29.498342000Z 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.000110 main OS Product: Linux 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.000129 main OS Release: 4.14.76-13.cernvm.x86_64 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.000145 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.000161 main Executable: /usr/sbin/VBoxService 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.000161 main Process ID: 3203 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.000162 main Package type: LINUX_64BITS_GENERIC 2022-07-22 06:26:33 (6868): Guest Log: 00:00:00.001973 main 5.2.6 r120293 started. Verbose level = 0 2022-07-22 06:27:10 (6868): Guest Log: 06:27:06 CEST +02:00 2022-07-22: cranky: [INFO] Detected Theory App 2022-07-22 06:27:10 (6868): Guest Log: 06:27:06 CEST +02:00 2022-07-22: cranky: [INFO] Checking CVMFS. 2022-07-22 06:27:11 (6868): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-07-22 06:27:12 (6868): 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 2022-07-22 06:27:12 (6868): Guest Log: 2.5.2.0 4045 0 28516 23429 3 1 1583708 4096001 0 65024 0 0 n/a 5 5 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-07-22 06:27:13 (6868): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-07-22 06:27:13 (6868): 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 2022-07-22 06:27:13 (6868): Guest Log: 2.5.2.0 4124 0 25540 18777 3 2 1583708 4096001 0 65024 0 2 0 5614 287 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-07-22 06:27:14 (6868): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-07-22 06:27:15 (6868): 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 2022-07-22 06:27:15 (6868): Guest Log: 2.5.2.0 4072 0 27220 268 3 1 1583708 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-07-22 06:27:16 (6868): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-07-22 06:27:17 (6868): 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 2022-07-22 06:27:17 (6868): Guest Log: 2.5.2.0 4101 0 34540 12880 3 1 1583708 4096001 0 65024 0 0 n/a 2870 327 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-07-22 06:27:17 (6868): Guest Log: 06:27:13 CEST +02:00 2022-07-22: cranky: [INFO] Checking runc. 2022-07-22 06:27:17 (6868): Guest Log: 06:27:13 CEST +02:00 2022-07-22: cranky: [INFO] Creating the filesystem. 2022-07-22 06:27:17 (6868): Guest Log: 06:27:13 CEST +02:00 2022-07-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-07-22 06:27:18 (6868): Guest Log: 06:27:14 CEST +02:00 2022-07-22: cranky: [INFO] Updating config.json. 2022-07-22 06:27:18 (6868): Guest Log: 06:27:14 CEST +02:00 2022-07-22: cranky: [INFO] Running Container 'runc'. 2022-07-22 06:27:18 (6868): Guest Log: job: htmld=/shared/html/job 2022-07-22 06:27:18 (6868): Guest Log: job: unpack exitcode=0 2022-07-22 06:27:20 (6868): Guest Log: 06:27:16 CEST +02:00 2022-07-22: cranky: [INFO] ===> [runRivet] Fri Jul 22 04:27:14 UTC 2022 [boinc pp jets 7000 65 - pythia8 8.240 cr1 100000 270] 2022-07-22 06:55:51 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 06:56:01 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 07:15:42 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 07:15:52 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 07:50:55 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 07:51:05 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 07:51:44 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 07:51:54 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 08:06:46 (6868): Status Report: Job Duration: '864000.000000' 2022-07-22 08:06:46 (6868): Status Report: Elapsed Time: '31686.553101' 2022-07-22 08:06:46 (6868): Status Report: CPU Time: '9027.015625' 2022-07-22 08:40:57 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 08:41:17 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 08:41:47 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 08:42:07 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 08:48:07 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 08:48:17 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 09:42:30 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 09:42:41 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 09:42:50 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 09:43:01 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 09:43:10 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 09:43:30 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 09:48:32 (6868): Status Report: Job Duration: '864000.000000' 2022-07-22 09:48:32 (6868): Status Report: Elapsed Time: '37687.553101' 2022-07-22 09:48:32 (6868): Status Report: CPU Time: '10836.953125' 2022-07-22 10:09:42 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:09:52 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:10:12 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:10:22 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:14:13 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:14:33 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:14:43 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:14:53 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:25:54 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:26:04 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:26:33 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:26:44 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:27:04 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:27:43 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:34:44 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:35:14 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:42:24 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:42:34 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:45:55 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:46:05 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 10:49:35 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 10:50:05 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:15:57 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:16:07 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:16:17 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:16:27 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:18:47 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:19:07 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:20:27 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:20:47 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:21:57 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:22:17 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:24:47 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:24:57 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:27:57 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:28:37 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:28:47 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:28:57 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:29:17 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:29:37 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:29:47 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:29:57 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:35:01 (6868): Status Report: Job Duration: '864000.000000' 2022-07-22 11:35:01 (6868): Status Report: Elapsed Time: '43687.553101' 2022-07-22 11:35:01 (6868): Status Report: CPU Time: '12649.343750' 2022-07-22 11:37:18 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:37:38 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:43:39 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:43:49 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 11:46:19 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 11:48:18 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 13:00:14 (6868): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-22 13:00:23 (6868): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-22 13:17:50 (6868): Status Report: Job Duration: '864000.000000' 2022-07-22 13:17:50 (6868): Status Report: Elapsed Time: '49687.553101' 2022-07-22 13:17:50 (6868): Status Report: CPU Time: '14457.468750' 2022-07-22 14:57:56 (6868): Status Report: Job Duration: '864000.000000' 2022-07-22 14:57:56 (6868): Status Report: Elapsed Time: '55687.553101' 2022-07-22 14:57:56 (6868): Status Report: CPU Time: '16261.875000' 2022-07-22 16:38:02 (6868): Status Report: Job Duration: '864000.000000' 2022-07-22 16:38:02 (6868): Status Report: Elapsed Time: '61687.553101' 2022-07-22 16:38:02 (6868): Status Report: CPU Time: '18067.171875' 2022-07-22 17:52:52 (6868): VM state change detected. (old = 'Running', new = 'Saving') 2022-07-22 17:52:52 (6868): Stopping VM. 2022-07-22 17:52:52 (6868): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_89404c5753fb291d" savestate Output: 2022-07-22 17:52:52 (6868): VM did not stop when requested. 2022-07-22 17:52:52 (6868): VM was successfully terminated. 2022-07-22 17:54:20 (2948): Detected: vboxwrapper 26197 2022-07-22 17:54:20 (2948): Detected: BOINC client v7.7 2022-07-22 17:54:21 (2948): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-22 17:54:22 (2948): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-22 17:54:22 (2948): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-22 17:54:26 (2948): Successfully started VM. (PID = '13460') 2022-07-22 17:54:26 (2948): Reporting VM Process ID to BOINC. 2022-07-22 17:54:26 (2948): Guest Log: BIOS: VirtualBox 6.1.28 2022-07-22 17:54:26 (2948): Guest Log: CPUID EDX: 0x178bfbff 2022-07-22 17:54:26 (2948): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-07-22 17:54:26 (2948): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-22 17:54:26 (2948): Detected: Web Application Enabled (http://localhost:58014) 2022-07-22 17:54:26 (2948): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-22 17:54:26 (2948): Status Report: Job Duration: '864000.000000' 2022-07-22 17:54:26 (2948): Status Report: Elapsed Time: '66172.553101' 2022-07-22 17:54:26 (2948): Status Report: CPU Time: '19418.828125' 2022-07-22 17:54:26 (2948): Preference change detected 2022-07-22 17:54:26 (2948): Setting CPU throttle for VM. (30%) 2022-07-22 17:54:26 (2948): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-22 17:54:28 (2948): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-22 17:54:28 (2948): Guest Log: BIOS: Booting from Hard Disk... 2022-07-22 17:54:31 (2948): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-22 17:54:31 (2948): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-22 17:55:03 (2948): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-22 17:55:03 (2948): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-22 17:55:10 (2948): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.000191 main Log opened 2022-07-22T15:55:17.863665000Z 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.000371 main OS Product: Linux 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.000502 main OS Release: 4.14.76-13.cernvm.x86_64 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.000579 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.000665 main Executable: /usr/sbin/VBoxService 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.000667 main Process ID: 3205 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.000669 main Package type: LINUX_64BITS_GENERIC 2022-07-22 17:55:10 (2948): Guest Log: 00:00:00.006164 main 5.2.6 r120293 started. Verbose level = 0 2022-07-22 17:55:36 (2948): Guest Log: 17:55:43 CEST +02:00 2022-07-22: cranky: [INFO] Detected Theory App 2022-07-22 17:55:36 (2948): Guest Log: 17:55:43 CEST +02:00 2022-07-22: cranky: [INFO] Checking CVMFS. 2022-07-22 17:55:38 (2948): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-07-22 17:55:38 (2948): 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 2022-07-22 17:55:38 (2948): Guest Log: 2.5.2.0 4064 0 26092 23431 3 1 2286599 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-07-22 17:55:39 (2948): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-07-22 17:55:40 (2948): 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 2022-07-22 17:55:40 (2948): Guest Log: 2.5.2.0 4098 0 27548 18783 3 2 2286599 4096001 0 65024 0 2 0 5616 855 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-07-22 17:55:42 (2948): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-07-22 17:55:42 (2948): 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 2022-07-22 17:55:42 (2948): Guest Log: 2.5.2.0 4089 0 25144 268 3 1 2286599 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-07-22 17:55:44 (2948): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-07-22 17:55:45 (2948): 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 2022-07-22 17:55:45 (2948): Guest Log: 2.5.2.0 4042 0 33932 12882 3 1 2286599 4096001 0 65024 0 0 n/a 2870 1004 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-07-22 17:55:45 (2948): Guest Log: 17:55:52 CEST +02:00 2022-07-22: cranky: [INFO] Checking runc. 2022-07-22 17:55:45 (2948): Guest Log: 17:55:52 CEST +02:00 2022-07-22: cranky: [INFO] Creating the filesystem. 2022-07-22 17:55:45 (2948): Guest Log: 17:55:52 CEST +02:00 2022-07-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-07-22 17:55:45 (2948): Guest Log: 17:55:52 CEST +02:00 2022-07-22: cranky: [INFO] Updating config.json. 2022-07-22 17:55:45 (2948): Guest Log: 17:55:52 CEST +02:00 2022-07-22: cranky: [INFO] Running Container 'runc'. 2022-07-22 17:55:45 (2948): Guest Log: job: htmld=/shared/html/job 2022-07-22 17:55:46 (2948): Guest Log: job: unpack exitcode=0 2022-07-22 17:55:47 (2948): Guest Log: 17:55:54 CEST +02:00 2022-07-22: cranky: [INFO] ===> [runRivet] Fri Jul 22 15:55:53 UTC 2022 [boinc pp jets 7000 65 - pythia8 8.240 cr1 100000 270] 2022-07-22 18:27:03 (2948): VM state change detected. (old = 'Running', new = 'Saving') 2022-07-22 18:27:03 (2948): Stopping VM. 2022-07-22 18:27:03 (2948): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_89404c5753fb291d" savestate Output: 2022-07-22 18:27:03 (2948): VM did not stop when requested. 2022-07-22 18:27:03 (2948): VM was successfully terminated. 2022-07-23 10:49:15 (12216): Detected: vboxwrapper 26197 2022-07-23 10:49:15 (12216): Detected: BOINC client v7.7 2022-07-23 10:49:15 (12216): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-23 10:49:16 (12216): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-23 10:49:16 (12216): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-23 10:49:20 (12216): Successfully started VM. (PID = '15668') 2022-07-23 10:49:20 (12216): Reporting VM Process ID to BOINC. 2022-07-23 10:49:20 (12216): Guest Log: BIOS: VirtualBox 6.1.28 2022-07-23 10:49:20 (12216): Guest Log: CPUID EDX: 0x178bfbff 2022-07-23 10:49:20 (12216): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-07-23 10:49:20 (12216): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-23 10:49:20 (12216): Detected: Web Application Enabled (http://localhost:58014) 2022-07-23 10:49:20 (12216): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-23 10:49:20 (12216): Status Report: Job Duration: '864000.000000' 2022-07-23 10:49:20 (12216): Status Report: Elapsed Time: '68127.553101' 2022-07-23 10:49:20 (12216): Status Report: CPU Time: '20002.062500' 2022-07-23 10:49:20 (12216): Preference change detected 2022-07-23 10:49:20 (12216): Setting CPU throttle for VM. (30%) 2022-07-23 10:49:20 (12216): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-23 10:49:22 (12216): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-23 10:49:22 (12216): Guest Log: BIOS: Booting from Hard Disk... 2022-07-23 10:49:25 (12216): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-23 10:49:25 (12216): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-23 10:49:56 (12216): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-23 10:49:56 (12216): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-23 10:50:02 (12216): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.000049 main Log opened 2022-07-23T08:50:01.539910000Z 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.000098 main OS Product: Linux 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.000117 main OS Release: 4.14.76-13.cernvm.x86_64 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.000134 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.000149 main Executable: /usr/sbin/VBoxService 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.000149 main Process ID: 3205 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.000150 main Package type: LINUX_64BITS_GENERIC 2022-07-23 10:50:02 (12216): Guest Log: 00:00:00.002183 main 5.2.6 r120293 started. Verbose level = 0 2022-07-23 10:50:36 (12216): Guest Log: 10:50:35 CEST +02:00 2022-07-23: cranky: [INFO] Detected Theory App 2022-07-23 10:50:36 (12216): Guest Log: 10:50:35 CEST +02:00 2022-07-23: cranky: [INFO] Checking CVMFS. 2022-07-23 10:50:37 (12216): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-07-23 10:50:37 (12216): 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 2022-07-23 10:50:37 (12216): Guest Log: 2.5.2.0 4043 0 27164 23435 3 1 2305433 4096001 0 65024 0 0 n/a 5 4 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-07-23 10:50:38 (12216): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-07-23 10:50:39 (12216): 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 2022-07-23 10:50:39 (12216): Guest Log: 2.5.2.0 4091 0 27604 18789 3 2 2305433 4096001 0 65024 0 2 0 5616 624 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-07-23 10:50:40 (12216): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-07-23 10:50:41 (12216): 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 2022-07-23 10:50:41 (12216): Guest Log: 2.5.2.0 4069 0 27228 268 3 1 2305433 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-07-23 10:50:42 (12216): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-07-23 10:50:43 (12216): 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 2022-07-23 10:50:43 (12216): Guest Log: 2.5.2.0 4118 0 35604 12890 3 1 2305433 4096001 0 65024 0 0 n/a 2874 463 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-07-23 10:50:43 (12216): Guest Log: 10:50:42 CEST +02:00 2022-07-23: cranky: [INFO] Checking runc. 2022-07-23 10:50:43 (12216): Guest Log: 10:50:42 CEST +02:00 2022-07-23: cranky: [INFO] Creating the filesystem. 2022-07-23 10:50:43 (12216): Guest Log: 10:50:42 CEST +02:00 2022-07-23: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-07-23 10:50:43 (12216): Guest Log: 10:50:42 CEST +02:00 2022-07-23: cranky: [INFO] Updating config.json. 2022-07-23 10:50:44 (12216): Guest Log: 10:50:43 CEST +02:00 2022-07-23: cranky: [INFO] Running Container 'runc'. 2022-07-23 10:50:44 (12216): Guest Log: job: htmld=/shared/html/job 2022-07-23 10:50:44 (12216): Guest Log: job: unpack exitcode=0 2022-07-23 10:50:46 (12216): Guest Log: 10:50:45 CEST +02:00 2022-07-23: cranky: [INFO] ===> [runRivet] Sat Jul 23 08:50:43 UTC 2022 [boinc pp jets 7000 65 - pythia8 8.240 cr1 100000 270] 2022-07-23 10:54:27 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 10:54:37 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 10:54:47 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 10:54:57 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 10:55:37 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 10:55:57 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 10:56:57 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 10:57:07 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 10:57:37 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 10:57:47 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 10:58:37 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 10:58:47 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:00:57 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:01:07 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:01:27 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:01:37 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:02:37 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:02:47 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:03:08 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:03:18 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:05:47 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:05:57 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:06:07 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:06:17 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:06:37 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:06:47 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 11:06:57 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 11:07:17 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 12:25:42 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 12:25:52 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 12:32:32 (12216): Status Report: Job Duration: '864000.000000' 2022-07-23 12:32:32 (12216): Status Report: Elapsed Time: '74127.553101' 2022-07-23 12:32:32 (12216): Status Report: CPU Time: '21805.156250' 2022-07-23 12:34:22 (12216): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-23 12:34:32 (12216): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-23 12:35:15 (12216): VM state change detected. (old = 'Running', new = 'Saving') 2022-07-23 12:35:16 (12216): Stopping VM. 2022-07-23 12:35:17 (12216): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_89404c5753fb291d" savestate Output: 2022-07-23 12:35:17 (12216): VM did not stop when requested. 2022-07-23 12:35:17 (12216): VM was successfully terminated. 2022-07-24 12:36:00 (16408): Detected: vboxwrapper 26197 2022-07-24 12:36:00 (16408): Detected: BOINC client v7.7 2022-07-24 12:36:01 (16408): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-24 12:36:01 (16408): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-24 12:36:01 (16408): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-24 12:36:06 (16408): Successfully started VM. (PID = '8920') 2022-07-24 12:36:06 (16408): Reporting VM Process ID to BOINC. 2022-07-24 12:36:06 (16408): Guest Log: BIOS: VirtualBox 6.1.28 2022-07-24 12:36:06 (16408): Guest Log: CPUID EDX: 0x178bfbff 2022-07-24 12:36:06 (16408): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-07-24 12:36:06 (16408): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-24 12:36:06 (16408): Detected: Web Application Enabled (http://localhost:58014) 2022-07-24 12:36:06 (16408): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-24 12:36:06 (16408): Status Report: Job Duration: '864000.000000' 2022-07-24 12:36:06 (16408): Status Report: Elapsed Time: '74280.553101' 2022-07-24 12:36:06 (16408): Status Report: CPU Time: '21850.375000' 2022-07-24 12:36:06 (16408): Preference change detected 2022-07-24 12:36:06 (16408): Setting CPU throttle for VM. (30%) 2022-07-24 12:36:06 (16408): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-24 12:36:08 (16408): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-24 12:36:08 (16408): Guest Log: BIOS: Booting from Hard Disk... 2022-07-24 12:36:11 (16408): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-24 12:36:11 (16408): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-24 12:36:41 (16408): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-24 12:36:41 (16408): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-24 12:36:46 (16408): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.000171 main Log opened 2022-07-24T10:36:44.557751000Z 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.000323 main OS Product: Linux 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.000380 main OS Release: 4.14.76-13.cernvm.x86_64 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.000411 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.000441 main Executable: /usr/sbin/VBoxService 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.000442 main Process ID: 3217 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.000443 main Package type: LINUX_64BITS_GENERIC 2022-07-24 12:36:46 (16408): Guest Log: 00:00:00.002923 main 5.2.6 r120293 started. Verbose level = 0 2022-07-24 12:37:27 (16408): Guest Log: 12:37:26 CEST +02:00 2022-07-24: cranky: [INFO] Detected Theory App 2022-07-24 12:37:27 (16408): Guest Log: 12:37:26 CEST +02:00 2022-07-24: cranky: [INFO] Checking CVMFS. 2022-07-24 12:37:28 (16408): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-07-24 12:37:29 (16408): 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 2022-07-24 12:37:29 (16408): Guest Log: 2.5.2.0 4083 0 28588 23442 3 1 2324562 4096001 0 65024 0 0 n/a 5 3 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-07-24 12:37:30 (16408): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-07-24 12:37:31 (16408): 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 2022-07-24 12:37:31 (16408): Guest Log: 2.5.2.0 4139 0 27516 18797 3 2 2324562 4096001 0 65024 0 2 0 5616 376 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-07-24 12:37:32 (16408): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-07-24 12:37:33 (16408): 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 2022-07-24 12:37:33 (16408): Guest Log: 2.5.2.0 4058 0 27192 268 3 1 2324562 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-07-24 12:37:34 (16408): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-07-24 12:37:35 (16408): 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 2022-07-24 12:37:35 (16408): Guest Log: 2.5.2.0 4109 0 32500 12898 3 1 2324562 4096001 0 65024 0 0 n/a 2877 233 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-07-24 12:37:35 (16408): Guest Log: 12:37:34 CEST +02:00 2022-07-24: cranky: [INFO] Checking runc. 2022-07-24 12:37:35 (16408): Guest Log: 12:37:34 CEST +02:00 2022-07-24: cranky: [INFO] Creating the filesystem. 2022-07-24 12:37:35 (16408): Guest Log: 12:37:34 CEST +02:00 2022-07-24: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-07-24 12:37:36 (16408): Guest Log: 12:37:34 CEST +02:00 2022-07-24: cranky: [INFO] Updating config.json. 2022-07-24 12:37:36 (16408): Guest Log: 12:37:34 CEST +02:00 2022-07-24: cranky: [INFO] Running Container 'runc'. 2022-07-24 12:37:36 (16408): Guest Log: job: htmld=/shared/html/job 2022-07-24 12:37:36 (16408): Guest Log: job: unpack exitcode=0 2022-07-24 12:37:38 (16408): Guest Log: 12:37:36 CEST +02:00 2022-07-24: cranky: [INFO] ===> [runRivet] Sun Jul 24 10:37:35 UTC 2022 [boinc pp jets 7000 65 - pythia8 8.240 cr1 100000 270] 2022-07-24 12:54:43 (16408): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-24 12:54:53 (16408): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-24 12:55:03 (16408): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-24 12:55:13 (16408): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-24 12:56:22 (16408): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-24 12:56:32 (16408): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-24 12:57:03 (16408): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-24 12:57:43 (16408): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-24 13:04:34 (16408): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-24 13:04:44 (16408): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-24 13:05:14 (16408): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-24 13:05:24 (16408): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-24 13:05:44 (16408): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-24 13:06:14 (16408): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-24 14:18:18 (16408): Status Report: Job Duration: '864000.000000' 2022-07-24 14:18:18 (16408): Status Report: Elapsed Time: '80280.553101' 2022-07-24 14:18:18 (16408): Status Report: CPU Time: '23652.296875' 2022-07-24 15:58:25 (16408): Status Report: Job Duration: '864000.000000' 2022-07-24 15:58:25 (16408): Status Report: Elapsed Time: '86280.553101' 2022-07-24 15:58:25 (16408): Status Report: CPU Time: '25457.218750' 2022-07-24 17:03:19 (16408): VM state change detected. (old = 'Running', new = 'Saving') 2022-07-24 17:03:20 (16408): Stopping VM. 2022-07-24 17:03:20 (16408): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_89404c5753fb291d" savestate Output: 2022-07-24 17:03:20 (16408): VM did not stop when requested. 2022-07-24 17:03:20 (16408): VM was successfully terminated. 2022-07-29 06:27:04 (12160): Detected: vboxwrapper 26197 2022-07-29 06:27:04 (12160): Detected: BOINC client v7.7 2022-07-29 06:27:04 (12160): Detected: VirtualBox VboxManage Interface (Version: 6.1.28) 2022-07-29 06:27:05 (12160): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-29 06:27:05 (12160): Starting VM using VBoxManage interface. (boinc_89404c5753fb291d, slot#5) 2022-07-29 06:27:09 (12160): Successfully started VM. (PID = '15076') 2022-07-29 06:27:09 (12160): Reporting VM Process ID to BOINC. 2022-07-29 06:27:09 (12160): Guest Log: BIOS: VirtualBox 6.1.28 2022-07-29 06:27:09 (12160): Guest Log: CPUID EDX: 0x178bfbff 2022-07-29 06:27:09 (12160): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-07-29 06:27:09 (12160): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-07-29 06:27:09 (12160): Detected: Web Application Enabled (http://localhost:58014) 2022-07-29 06:27:09 (12160): Detected: Remote Desktop Enabled (localhost:58015) 2022-07-29 06:27:09 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 06:27:09 (12160): Status Report: Elapsed Time: '90171.553101' 2022-07-29 06:27:09 (12160): Status Report: CPU Time: '26628.421875' 2022-07-29 06:27:09 (12160): Preference change detected 2022-07-29 06:27:09 (12160): Setting CPU throttle for VM. (30%) 2022-07-29 06:27:09 (12160): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-29 06:27:11 (12160): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-29 06:27:11 (12160): Guest Log: BIOS: Booting from Hard Disk... 2022-07-29 06:27:14 (12160): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-29 06:27:14 (12160): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-29 06:27:50 (12160): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-29 06:27:50 (12160): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-29 06:27:57 (12160): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.000050 main Log opened 2022-07-29T04:27:54.951436000Z 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.000102 main OS Product: Linux 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.000126 main OS Release: 4.14.76-13.cernvm.x86_64 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.000144 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.000159 main Executable: /usr/sbin/VBoxService 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.000160 main Process ID: 3205 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.000160 main Package type: LINUX_64BITS_GENERIC 2022-07-29 06:27:57 (12160): Guest Log: 00:00:00.001982 main 5.2.6 r120293 started. Verbose level = 0 2022-07-29 06:28:36 (12160): Guest Log: 06:28:33 CEST +02:00 2022-07-29: cranky: [INFO] Detected Theory App 2022-07-29 06:28:36 (12160): Guest Log: 06:28:33 CEST +02:00 2022-07-29: cranky: [INFO] Checking CVMFS. 2022-07-29 06:28:37 (12160): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-07-29 06:28:38 (12160): 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 2022-07-29 06:28:38 (12160): Guest Log: 2.5.2.0 4074 0 27188 23472 3 1 2343705 4096001 0 65024 0 0 n/a 5 2 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-07-29 06:28:39 (12160): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-07-29 06:28:39 (12160): 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 2022-07-29 06:28:39 (12160): Guest Log: 2.5.2.0 4054 0 27584 18849 3 2 2343705 4096001 0 65024 0 2 0 5616 834 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-07-29 06:28:40 (12160): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-07-29 06:28:41 (12160): 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 2022-07-29 06:28:41 (12160): Guest Log: 2.5.2.0 4095 0 26368 268 3 1 2343705 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-07-29 06:28:42 (12160): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-07-29 06:28:43 (12160): 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 2022-07-29 06:28:43 (12160): Guest Log: 2.5.2.0 4123 0 33728 12931 3 1 2343705 4096001 0 65024 0 0 n/a 2882 236 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-07-29 06:28:43 (12160): Guest Log: 06:28:40 CEST +02:00 2022-07-29: cranky: [INFO] Checking runc. 2022-07-29 06:28:43 (12160): Guest Log: 06:28:40 CEST +02:00 2022-07-29: cranky: [INFO] Creating the filesystem. 2022-07-29 06:28:43 (12160): Guest Log: 06:28:40 CEST +02:00 2022-07-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-07-29 06:28:43 (12160): Guest Log: 06:28:40 CEST +02:00 2022-07-29: cranky: [INFO] Updating config.json. 2022-07-29 06:28:43 (12160): Guest Log: 06:28:40 CEST +02:00 2022-07-29: cranky: [INFO] Running Container 'runc'. 2022-07-29 06:28:44 (12160): Guest Log: job: htmld=/shared/html/job 2022-07-29 06:28:44 (12160): Guest Log: job: unpack exitcode=0 2022-07-29 06:28:45 (12160): Guest Log: 06:28:42 CEST +02:00 2022-07-29: cranky: [INFO] ===> [runRivet] Fri Jul 29 04:28:41 UTC 2022 [boinc pp jets 7000 65 - pythia8 8.240 cr1 100000 270] 2022-07-29 08:07:15 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 08:07:15 (12160): Status Report: Elapsed Time: '96171.553101' 2022-07-29 08:07:15 (12160): Status Report: CPU Time: '28426.750000' 2022-07-29 09:40:27 (12160): VM state change detected. (old = 'Running', new = 'Paused') 2022-07-29 09:40:38 (12160): VM state change detected. (old = 'Paused', new = 'Running') 2022-07-29 09:47:33 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 09:47:33 (12160): Status Report: Elapsed Time: '102171.553101' 2022-07-29 09:47:33 (12160): Status Report: CPU Time: '30234.812500' 2022-07-29 11:27:39 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 11:27:39 (12160): Status Report: Elapsed Time: '108171.553101' 2022-07-29 11:27:39 (12160): Status Report: CPU Time: '32041.046875' 2022-07-29 13:07:45 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 13:07:45 (12160): Status Report: Elapsed Time: '114171.553101' 2022-07-29 13:07:45 (12160): Status Report: CPU Time: '33848.625000' 2022-07-29 14:47:52 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 14:47:52 (12160): Status Report: Elapsed Time: '120171.553101' 2022-07-29 14:47:52 (12160): Status Report: CPU Time: '35654.687500' 2022-07-29 16:27:58 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 16:27:58 (12160): Status Report: Elapsed Time: '126171.553101' 2022-07-29 16:27:58 (12160): Status Report: CPU Time: '37461.406250' 2022-07-29 18:08:04 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 18:08:04 (12160): Status Report: Elapsed Time: '132171.553101' 2022-07-29 18:08:04 (12160): Status Report: CPU Time: '39266.468750' 2022-07-29 19:48:11 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 19:48:11 (12160): Status Report: Elapsed Time: '138171.553101' 2022-07-29 19:48:11 (12160): Status Report: CPU Time: '41070.921875' 2022-07-29 21:28:17 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 21:28:17 (12160): Status Report: Elapsed Time: '144171.553101' 2022-07-29 21:28:17 (12160): Status Report: CPU Time: '42876.859375' 2022-07-29 23:08:24 (12160): Status Report: Job Duration: '864000.000000' 2022-07-29 23:08:24 (12160): Status Report: Elapsed Time: '150171.553101' 2022-07-29 23:08:24 (12160): Status Report: CPU Time: '44681.437500' 2022-07-30 00:48:31 (12160): Status Report: Job Duration: '864000.000000' 2022-07-30 00:48:31 (12160): Status Report: Elapsed Time: '156171.553101' 2022-07-30 00:48:31 (12160): Status Report: CPU Time: '46485.828125' 2022-07-30 02:28:39 (12160): Status Report: Job Duration: '864000.000000' 2022-07-30 02:28:39 (12160): Status Report: Elapsed Time: '162171.553101' 2022-07-30 02:28:39 (12160): Status Report: CPU Time: '48291.921875' 2022-07-30 04:08:45 (12160): Status Report: Job Duration: '864000.000000' 2022-07-30 04:08:45 (12160): Status Report: Elapsed Time: '168171.553101' 2022-07-30 04:08:45 (12160): Status Report: CPU Time: '50096.375000' 2022-07-30 05:48:52 (12160): Status Report: Job Duration: '864000.000000' 2022-07-30 05:48:52 (12160): Status Report: Elapsed Time: '174171.553101' 2022-07-30 05:48:52 (12160): Status Report: CPU Time: '51900.718750' 2022-07-30 06:24:57 (12160): Guest Log: job: run exitcode=0 2022-07-30 06:24:57 (12160): Guest Log: job: diskusage=7088 2022-07-30 06:24:57 (12160): Guest Log: job: logsize=132 k 2022-07-30 06:24:57 (12160): Guest Log: job: times= 2022-07-30 06:24:57 (12160): Guest Log: 0m0.005s 0m0.006s 2022-07-30 06:24:57 (12160): Guest Log: 1418m20.655s 6m6.833s 2022-07-30 06:24:57 (12160): Guest Log: job: cpuusage=85467 2022-07-30 06:24:58 (12160): Guest Log: 06:24:57 CEST +02:00 2022-07-30: cranky: [INFO] Container 'runc' finished with status code 0. 2022-07-30 06:24:58 (12160): Guest Log: 06:24:57 CEST +02:00 2022-07-30: cranky: [INFO] Preparing output. 2022-07-30 06:25:02 (12160): Guest Log: [INFO] Job Finished 2022-07-30 06:25:03 (12160): Guest Log: [INFO] Shutting Down. 2022-07-30 06:25:03 (12160): VM Completion File Detected. 2022-07-30 06:25:03 (12160): VM Completion Message: Job Finished . 2022-07-30 06:25:03 (12160): Powering off VM. 2022-07-30 06:30:04 (12160): VM did not power off when requested. 2022-07-30 06:30:04 (12160): VM was successfully terminated. 2022-07-30 06:30:04 (12160): Deregistering VM. (boinc_89404c5753fb291d, slot#5) 2022-07-30 06:30:04 (12160): Removing network bandwidth throttle group from VM. 2022-07-30 06:30:04 (12160): Removing VM from VirtualBox. 06:30:10 (12160): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN