| Name | Theory_2390-1153358-204_1 |
| Workunit | 2129952 |
| Created | 24 Sep 2021, 0:57:30 UTC |
| Sent | 27 Sep 2021, 3:53:16 UTC |
| Report deadline | 7 Oct 2021, 3:53:16 UTC |
| Received | 1 Oct 2021, 17:37:47 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 4430 |
| Run time | 2 days 19 hours 56 min 33 sec |
| CPU time | 2 days 12 hours 23 min 49 sec |
| Validate state | Valid |
| Credit | 2,226.79 |
| Device peak FLOPS | 3.93 GFLOPS |
| Application version | Theory Simulation v5.21 (vbox64_theory) windows_x86_64 |
| Peak working set size | 69.07 MB |
| Peak swap size | 78.82 MB |
| Peak disk usage | 4.54 GB |
Stderr output
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> 2021-09-27 13:53:28 (11308): Detected: vboxwrapper 26197 2021-09-27 13:53:28 (11308): Detected: BOINC client v7.7 2021-09-27 13:53:29 (11308): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-09-27 13:53:29 (11308): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-09-27 13:53:29 (11308): Successfully copied 'init_data.xml' to the shared directory. 2021-09-27 13:53:29 (11308): Successfully copied 'input' to the shared directory. 2021-09-27 13:53:31 (11308): Create VM. (boinc_dc01be86d055be97, slot#1) 2021-09-27 13:53:31 (11308): Setting Memory Size for VM. (630MB) 2021-09-27 13:53:32 (11308): Setting CPU Count for VM. (1) 2021-09-27 13:53:32 (11308): Setting Chipset Options for VM. 2021-09-27 13:53:32 (11308): Setting Boot Options for VM. 2021-09-27 13:53:32 (11308): Setting Network Configuration for NAT. 2021-09-27 13:53:33 (11308): Enabling VM Network Access. 2021-09-27 13:53:33 (11308): Disabling USB Support for VM. 2021-09-27 13:53:33 (11308): Disabling COM Port Support for VM. 2021-09-27 13:53:34 (11308): Disabling LPT Port Support for VM. 2021-09-27 13:53:34 (11308): Disabling Audio Support for VM. 2021-09-27 13:53:34 (11308): Disabling Clipboard Support for VM. 2021-09-27 13:53:35 (11308): Disabling Drag and Drop Support for VM. 2021-09-27 13:53:35 (11308): Adding storage controller(s) to VM. 2021-09-27 13:53:35 (11308): Adding virtual disk drive to VM. (vm_image.vdi) 2021-09-27 13:53:35 (11308): Adding VirtualBox Guest Additions to VM. 2021-09-27 13:53:36 (11308): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2021-09-27 13:53:36 (11308): forwarding host port 64416 to guest port 80 2021-09-27 13:53:36 (11308): Enabling remote desktop for VM. 2021-09-27 13:53:37 (11308): Required extension pack not installed, remote desktop not enabled. 2021-09-27 13:53:37 (11308): Enabling shared directory for VM. 2021-09-27 13:53:37 (11308): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-09-27 13:53:44 (11308): Successfully started VM. (PID = '15332') 2021-09-27 13:53:44 (11308): Reporting VM Process ID to BOINC. 2021-09-27 13:53:44 (11308): Guest Log: BIOS: VirtualBox 5.2.44 2021-09-27 13:53:44 (11308): Guest Log: CPUID EDX: 0x078bfbff 2021-09-27 13:53:44 (11308): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-09-27 13:53:44 (11308): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-09-27 13:53:44 (11308): Detected: Web Application Enabled (http://localhost:64416) 2021-09-27 13:53:44 (11308): Preference change detected 2021-09-27 13:53:44 (11308): Setting CPU throttle for VM. (90%) 2021-09-27 13:53:44 (11308): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-09-27 13:53:46 (11308): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-09-27 13:53:46 (11308): Guest Log: BIOS: Booting from Hard Disk... 2021-09-27 13:53:48 (11308): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-09-27 13:53:48 (11308): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-09-27 13:54:26 (11308): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-09-27 13:54:26 (11308): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-09-27 13:54:31 (11308): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.000228 main Log opened 2021-09-27T03:54:31.929829000Z 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.000393 main OS Product: Linux 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.000469 main OS Release: 4.14.76-13.cernvm.x86_64 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.000545 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.000593 main Executable: /usr/sbin/VBoxService 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.000595 main Process ID: 3200 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.000597 main Package type: LINUX_64BITS_GENERIC 2021-09-27 13:54:31 (11308): Guest Log: 00:00:00.008981 main 5.2.6 r120293 started. Verbose level = 0 2021-09-27 13:55:12 (11308): Guest Log: 05:55:12 CEST +02:00 2021-09-27: cranky: [INFO] Detected Theory App 2021-09-27 13:55:12 (11308): Guest Log: 05:55:12 CEST +02:00 2021-09-27: cranky: [INFO] Checking CVMFS. 2021-09-27 13:55:13 (11308): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2021-09-27 13:55:14 (11308): 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 2021-09-27 13:55:14 (11308): Guest Log: 2.5.2.0 4093 0 27184 21139 3 1 266433 4096000 0 65024 0 0 n/a 5 3 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2021-09-27 13:55:16 (11308): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-09-27 13:55:17 (11308): 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 2021-09-27 13:55:17 (11308): Guest Log: 2.5.2.0 4116 0 27524 16333 3 2 266433 4096000 0 65024 0 2 -100 6416 586 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-09-27 13:55:18 (11308): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2021-09-27 13:55:19 (11308): 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 2021-09-27 13:55:19 (11308): Guest Log: 2.5.2.0 4071 0 27220 267 3 1 266433 4096000 0 65024 0 0 n/a 4 1 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2021-09-27 13:55:21 (11308): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2021-09-27 13:55:22 (11308): 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 2021-09-27 13:55:22 (11308): Guest Log: 2.5.2.0 4044 0 34008 10370 3 1 266433 4096000 0 65024 0 0 n/a 5290 889 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2021-09-27 13:55:22 (11308): Guest Log: 05:55:22 CEST +02:00 2021-09-27: cranky: [INFO] Checking runc. 2021-09-27 13:55:22 (11308): Guest Log: 05:55:22 CEST +02:00 2021-09-27: cranky: [INFO] Creating the filesystem. 2021-09-27 13:55:22 (11308): Guest Log: 05:55:23 CEST +02:00 2021-09-27: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2021-09-27 13:55:22 (11308): Guest Log: 05:55:23 CEST +02:00 2021-09-27: cranky: [INFO] Updating config.json. 2021-09-27 13:55:22 (11308): Guest Log: 05:55:23 CEST +02:00 2021-09-27: cranky: [INFO] Running Container 'runc'. 2021-09-27 13:55:30 (11308): Guest Log: job: htmld=/shared/html/job 2021-09-27 13:55:30 (11308): Guest Log: job: unpack exitcode=0 2021-09-27 13:55:32 (11308): Guest Log: 05:55:33 CEST +02:00 2021-09-27: cranky: [INFO] ===> [runRivet] Mon Sep 27 03:55:31 UTC 2021 [boinc pp zinclusive 7000 -,-,50,130 - madgraph5amc 2.6.5.atlas lo1jet 100000 204] 2021-09-27 14:54:16 (11308): Stopping VM. 2021-09-27 16:29:48 (7932): Detected: vboxwrapper 26197 2021-09-27 16:29:48 (7932): Detected: BOINC client v7.7 2021-09-27 16:29:49 (7932): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-09-27 16:29:49 (7932): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-09-27 16:29:49 (7932): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-09-27 16:29:58 (7932): Successfully started VM. (PID = '1348') 2021-09-27 16:29:58 (7932): Reporting VM Process ID to BOINC. 2021-09-27 16:29:58 (7932): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-09-27 16:29:58 (7932): Detected: Web Application Enabled (http://localhost:64416) 2021-09-27 16:29:58 (7932): Preference change detected 2021-09-27 16:29:58 (7932): Setting CPU throttle for VM. (90%) 2021-09-27 16:29:58 (7932): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-09-27 16:30:04 (7932): Guest Log: 00:59:50.879286 timesync vgsvcTimeSyncWorker: Radical host time change: 5 750 383 000 000ns (HostNow=1 632 724 203 086 000 000 ns HostLast=1 632 718 452 703 000 000 ns) 2021-09-27 16:30:14 (7932): Guest Log: 01:00:00.892374 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 750 415 508 000ns (GuestNow=1 632 724 213 123 710 000 ns GuestLast=1 632 718 462 708 202 000 ns fSetTimeLastLoop=true ) 2021-09-27 17:09:42 (7932): Status Report: Job Duration: '864000.000000' 2021-09-27 17:09:42 (7932): Status Report: Elapsed Time: '6000.000000' 2021-09-27 17:09:42 (7932): Status Report: CPU Time: '3529.046875' 2021-09-27 18:49:50 (7932): Status Report: Job Duration: '864000.000000' 2021-09-27 18:49:50 (7932): Status Report: Elapsed Time: '12000.000000' 2021-09-27 18:49:50 (7932): Status Report: CPU Time: '8937.859375' 2021-09-27 20:29:59 (7932): Status Report: Job Duration: '864000.000000' 2021-09-27 20:29:59 (7932): Status Report: Elapsed Time: '18000.000000' 2021-09-27 20:29:59 (7932): Status Report: CPU Time: '14348.000000' 2021-09-27 21:38:57 (7932): Stopping VM. 2021-09-27 21:38:57 (7932): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_dc01be86d055be97" savestate Output: 2021-09-27 21:38:57 (7932): VM did not stop when requested. 2021-09-27 21:38:57 (7932): VM was successfully terminated. 2021-09-28 08:31:22 (8896): Detected: vboxwrapper 26197 2021-09-28 08:31:22 (8896): Detected: BOINC client v7.7 2021-09-28 08:31:23 (8896): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-09-28 08:31:23 (8896): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-09-28 08:31:24 (8896): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-09-28 08:31:29 (8896): Successfully started VM. (PID = '11664') 2021-09-28 08:31:29 (8896): Reporting VM Process ID to BOINC. 2021-09-28 08:31:29 (8896): Guest Log: BIOS: VirtualBox 5.2.44 2021-09-28 08:31:29 (8896): Guest Log: CPUID EDX: 0x078bfbff 2021-09-28 08:31:29 (8896): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-09-28 08:31:29 (8896): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-09-28 08:31:29 (8896): Detected: Web Application Enabled (http://localhost:64416) 2021-09-28 08:31:29 (8896): Status Report: Job Duration: '864000.000000' 2021-09-28 08:31:29 (8896): Status Report: Elapsed Time: '22133.000000' 2021-09-28 08:31:29 (8896): Status Report: CPU Time: '18070.296875' 2021-09-28 08:31:29 (8896): Preference change detected 2021-09-28 08:31:29 (8896): Setting CPU throttle for VM. (90%) 2021-09-28 08:31:29 (8896): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-09-28 08:31:31 (8896): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-09-28 08:31:31 (8896): Guest Log: BIOS: Booting from Hard Disk... 2021-09-28 08:31:34 (8896): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-09-28 08:31:34 (8896): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-09-28 08:33:30 (8896): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-09-28 08:33:30 (8896): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-09-28 08:33:31 (8896): Stopping VM. 2021-09-28 08:33:31 (8896): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_dc01be86d055be97" savestate Output: 2021-09-28 08:33:31 (8896): VM did not stop when requested. 2021-09-28 08:33:31 (8896): VM was successfully terminated. 2021-09-28 08:42:24 (12692): Detected: vboxwrapper 26197 2021-09-28 08:42:24 (12692): Detected: BOINC client v7.7 2021-09-28 08:42:25 (12692): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-09-28 08:42:25 (12692): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-09-28 08:42:26 (12692): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-09-28 08:42:31 (12692): Successfully started VM. (PID = '13640') 2021-09-28 08:42:31 (12692): Reporting VM Process ID to BOINC. 2021-09-28 08:42:31 (12692): Guest Log: BIOS: VirtualBox 5.2.44 2021-09-28 08:42:31 (12692): Guest Log: CPUID EDX: 0x078bfbff 2021-09-28 08:42:31 (12692): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-09-28 08:42:31 (12692): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-09-28 08:42:31 (12692): Detected: Web Application Enabled (http://localhost:64416) 2021-09-28 08:42:31 (12692): Status Report: Job Duration: '864000.000000' 2021-09-28 08:42:31 (12692): Status Report: Elapsed Time: '22255.000000' 2021-09-28 08:42:31 (12692): Status Report: CPU Time: '18084.625000' 2021-09-28 08:42:31 (12692): Preference change detected 2021-09-28 08:42:31 (12692): Setting CPU throttle for VM. (90%) 2021-09-28 08:42:31 (12692): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-09-28 08:42:33 (12692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-09-28 08:42:33 (12692): Guest Log: BIOS: Booting from Hard Disk... 2021-09-28 08:42:35 (12692): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-09-28 08:42:35 (12692): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-09-28 08:43:09 (12692): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-09-28 08:43:09 (12692): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-09-28 08:43:13 (12692): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.000141 main Log opened 2021-09-27T22:43:15.574478000Z 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.000254 main OS Product: Linux 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.000312 main OS Release: 4.14.76-13.cernvm.x86_64 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.000368 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.000405 main Executable: /usr/sbin/VBoxService 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.000407 main Process ID: 3205 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.000408 main Package type: LINUX_64BITS_GENERIC 2021-09-28 08:43:13 (12692): Guest Log: 00:00:00.007192 main 5.2.6 r120293 started. Verbose level = 0 2021-09-28 08:43:47 (12692): Guest Log: 00:43:48 CEST +02:00 2021-09-28: cranky: [INFO] Detected Theory App 2021-09-28 08:43:47 (12692): Guest Log: 00:43:48 CEST +02:00 2021-09-28: cranky: [INFO] Checking CVMFS. 2021-09-28 08:43:48 (12692): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2021-09-28 08:43:49 (12692): 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 2021-09-28 08:43:49 (12692): Guest Log: 2.5.2.0 4084 0 27176 21142 3 1 2297694 4096000 0 65024 0 0 n/a 5 2 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1 2021-09-28 08:43:50 (12692): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-09-28 08:43:51 (12692): 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 2021-09-28 08:43:51 (12692): Guest Log: 2.5.2.0 4109 0 27548 16339 3 2 2297694 4096000 0 65024 0 2 0 4278 904 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-09-28 08:43:53 (12692): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2021-09-28 08:43:54 (12692): 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 2021-09-28 08:43:54 (12692): Guest Log: 2.5.2.0 4038 0 27204 267 3 1 2297694 4096000 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2021-09-28 08:43:55 (12692): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2021-09-28 08:43:56 (12692): 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 2021-09-28 08:43:56 (12692): Guest Log: 2.5.2.0 4064 0 33508 10381 3 1 2297694 4096000 0 65024 0 0 n/a 5292 667 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2021-09-28 08:43:56 (12692): Guest Log: 00:43:58 CEST +02:00 2021-09-28: cranky: [INFO] Checking runc. 2021-09-28 08:43:56 (12692): Guest Log: 00:43:58 CEST +02:00 2021-09-28: cranky: [INFO] Creating the filesystem. 2021-09-28 08:43:57 (12692): Guest Log: 00:43:59 CEST +02:00 2021-09-28: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2021-09-28 08:43:57 (12692): Guest Log: 00:43:59 CEST +02:00 2021-09-28: cranky: [INFO] Updating config.json. 2021-09-28 08:43:57 (12692): Guest Log: 00:43:59 CEST +02:00 2021-09-28: cranky: [INFO] Running Container 'runc'. 2021-09-28 08:43:58 (12692): Guest Log: job: htmld=/shared/html/job 2021-09-28 08:43:58 (12692): Guest Log: job: unpack exitcode=0 2021-09-28 08:43:59 (12692): Guest Log: 00:44:01 CEST +02:00 2021-09-28: cranky: [INFO] ===> [runRivet] Mon Sep 27 22:44:00 UTC 2021 [boinc pp zinclusive 7000 -,-,50,130 - madgraph5amc 2.6.5.atlas lo1jet 100000 204] 2021-09-28 09:20:48 (12692): Stopping VM. 2021-09-28 09:20:48 (12692): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_dc01be86d055be97" savestate Output: 2021-09-28 09:20:48 (12692): VM did not stop when requested. 2021-09-28 09:20:48 (12692): VM was successfully terminated. 2021-09-28 09:22:14 (13032): Detected: vboxwrapper 26197 2021-09-28 09:22:14 (13032): Detected: BOINC client v7.7 2021-09-28 09:22:15 (13032): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-09-28 09:22:16 (13032): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-09-28 09:22:16 (13032): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-09-28 09:22:20 (13032): Successfully started VM. (PID = '13320') 2021-09-28 09:22:20 (13032): Reporting VM Process ID to BOINC. 2021-09-28 09:22:20 (13032): Guest Log: BIOS: VirtualBox 5.2.44 2021-09-28 09:22:20 (13032): Guest Log: CPUID EDX: 0x078bfbff 2021-09-28 09:22:20 (13032): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-09-28 09:22:20 (13032): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-09-28 09:22:20 (13032): Detected: Web Application Enabled (http://localhost:64416) 2021-09-28 09:22:20 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 09:22:20 (13032): Status Report: Elapsed Time: '24533.000000' 2021-09-28 09:22:20 (13032): Status Report: CPU Time: '20099.734375' 2021-09-28 09:22:20 (13032): Preference change detected 2021-09-28 09:22:20 (13032): Setting CPU throttle for VM. (90%) 2021-09-28 09:22:21 (13032): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-09-28 09:22:22 (13032): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-09-28 09:22:22 (13032): Guest Log: BIOS: Booting from Hard Disk... 2021-09-28 09:22:24 (13032): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-09-28 09:22:24 (13032): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-09-28 09:22:56 (13032): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-09-28 09:22:56 (13032): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-09-28 09:23:00 (13032): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.000192 main Log opened 2021-09-27T23:23:02.058643000Z 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.000309 main OS Product: Linux 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.000358 main OS Release: 4.14.76-13.cernvm.x86_64 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.000401 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.000443 main Executable: /usr/sbin/VBoxService 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.000445 main Process ID: 3198 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.000447 main Package type: LINUX_64BITS_GENERIC 2021-09-28 09:23:00 (13032): Guest Log: 00:00:00.007830 main 5.2.6 r120293 started. Verbose level = 0 2021-09-28 09:23:34 (13032): Guest Log: 01:23:34 CEST +02:00 2021-09-28: cranky: [INFO] Detected Theory App 2021-09-28 09:23:34 (13032): Guest Log: 01:23:34 CEST +02:00 2021-09-28: cranky: [INFO] Checking CVMFS. 2021-09-28 09:23:34 (13032): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2021-09-28 09:23:35 (13032): 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 2021-09-28 09:23:35 (13032): Guest Log: 2.5.2.0 4078 0 28316 21144 3 1 2297750 4096000 0 65024 0 0 n/a 5 1 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2021-09-28 09:23:37 (13032): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-09-28 09:23:38 (13032): 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 2021-09-28 09:23:38 (13032): Guest Log: 2.5.2.0 4052 0 27476 16339 3 2 2297750 4096000 0 65024 0 2 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-09-28 09:23:39 (13032): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2021-09-28 09:23:40 (13032): 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 2021-09-28 09:23:40 (13032): Guest Log: 2.5.2.0 4029 0 27192 267 3 1 2297750 4096000 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2021-09-28 09:23:43 (13032): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2021-09-28 09:23:43 (13032): 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 2021-09-28 09:23:43 (13032): Guest Log: 2.5.2.0 4102 0 33460 10381 3 1 2297750 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2021-09-28 09:23:43 (13032): Guest Log: 01:23:45 CEST +02:00 2021-09-28: cranky: [INFO] Checking runc. 2021-09-28 09:23:44 (13032): Guest Log: 01:23:45 CEST +02:00 2021-09-28: cranky: [INFO] Creating the filesystem. 2021-09-28 09:23:44 (13032): Guest Log: 01:23:46 CEST +02:00 2021-09-28: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2021-09-28 09:23:44 (13032): Guest Log: 01:23:46 CEST +02:00 2021-09-28: cranky: [INFO] Updating config.json. 2021-09-28 09:23:44 (13032): Guest Log: 01:23:46 CEST +02:00 2021-09-28: cranky: [INFO] Running Container 'runc'. 2021-09-28 09:23:45 (13032): Guest Log: job: htmld=/shared/html/job 2021-09-28 09:23:45 (13032): Guest Log: job: unpack exitcode=0 2021-09-28 09:23:47 (13032): Guest Log: 01:23:48 CEST +02:00 2021-09-28: cranky: [INFO] ===> [runRivet] Mon Sep 27 23:23:47 UTC 2021 [boinc pp zinclusive 7000 -,-,50,130 - madgraph5amc 2.6.5.atlas lo1jet 100000 204] 2021-09-28 11:02:42 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 11:02:42 (13032): Status Report: Elapsed Time: '30533.000000' 2021-09-28 11:02:42 (13032): Status Report: CPU Time: '25478.500000' 2021-09-28 12:42:50 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 12:42:50 (13032): Status Report: Elapsed Time: '36533.000000' 2021-09-28 12:42:50 (13032): Status Report: CPU Time: '30886.812500' 2021-09-28 14:23:01 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 14:23:01 (13032): Status Report: Elapsed Time: '42533.000000' 2021-09-28 14:23:01 (13032): Status Report: CPU Time: '36298.515625' 2021-09-28 16:03:25 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 16:03:25 (13032): Status Report: Elapsed Time: '48533.000000' 2021-09-28 16:03:25 (13032): Status Report: CPU Time: '41719.843750' 2021-09-28 17:44:16 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 17:44:16 (13032): Status Report: Elapsed Time: '54533.000000' 2021-09-28 17:44:16 (13032): Status Report: CPU Time: '47160.546875' 2021-09-28 19:25:02 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 19:25:02 (13032): Status Report: Elapsed Time: '60533.000000' 2021-09-28 19:25:02 (13032): Status Report: CPU Time: '52600.406250' 2021-09-28 21:05:48 (13032): Status Report: Job Duration: '864000.000000' 2021-09-28 21:05:48 (13032): Status Report: Elapsed Time: '66533.000000' 2021-09-28 21:05:48 (13032): Status Report: CPU Time: '58040.171875' 2021-09-28 21:41:37 (13032): Stopping VM. 2021-09-28 21:41:38 (13032): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_dc01be86d055be97" savestate Output: 2021-09-28 21:41:38 (13032): VM did not stop when requested. 2021-09-28 21:41:38 (13032): VM was successfully terminated. 2021-09-29 07:32:04 (7992): Detected: vboxwrapper 26197 2021-09-29 07:32:04 (7992): Detected: BOINC client v7.7 2021-09-29 07:32:05 (7992): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-09-29 07:32:05 (7992): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-09-29 07:32:05 (7992): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-09-29 07:32:12 (7992): Successfully started VM. (PID = '5360') 2021-09-29 07:32:12 (7992): Reporting VM Process ID to BOINC. 2021-09-29 07:32:12 (7992): Guest Log: BIOS: VirtualBox 5.2.44 2021-09-29 07:32:12 (7992): Guest Log: CPUID EDX: 0x078bfbff 2021-09-29 07:32:12 (7992): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-09-29 07:32:12 (7992): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-09-29 07:32:12 (7992): Detected: Web Application Enabled (http://localhost:64416) 2021-09-29 07:32:12 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 07:32:12 (7992): Status Report: Elapsed Time: '68666.000000' 2021-09-29 07:32:12 (7992): Status Report: CPU Time: '59971.203125' 2021-09-29 07:32:12 (7992): Preference change detected 2021-09-29 07:32:12 (7992): Setting CPU throttle for VM. (90%) 2021-09-29 07:32:12 (7992): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-09-29 07:32:14 (7992): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-09-29 07:32:14 (7992): Guest Log: BIOS: Booting from Hard Disk... 2021-09-29 07:32:18 (7992): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-09-29 07:32:18 (7992): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-09-29 07:32:53 (7992): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-09-29 07:32:53 (7992): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-09-29 07:32:58 (7992): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.000172 main Log opened 2021-09-28T21:33:01.614545000Z 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.000357 main OS Product: Linux 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.000432 main OS Release: 4.14.76-13.cernvm.x86_64 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.000479 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.000523 main Executable: /usr/sbin/VBoxService 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.000525 main Process ID: 3196 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.000527 main Package type: LINUX_64BITS_GENERIC 2021-09-29 07:32:58 (7992): Guest Log: 00:00:00.008898 main 5.2.6 r120293 started. Verbose level = 0 2021-09-29 07:33:35 (7992): Guest Log: 23:33:37 CEST +02:00 2021-09-28: cranky: [INFO] Detected Theory App 2021-09-29 07:33:35 (7992): Guest Log: 23:33:37 CEST +02:00 2021-09-28: cranky: [INFO] Checking CVMFS. 2021-09-29 07:33:36 (7992): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2021-09-29 07:33:37 (7992): 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 2021-09-29 07:33:37 (7992): Guest Log: 2.5.2.0 4031 0 28428 21148 3 1 2318265 4096000 0 65024 0 0 n/a 5 1 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1 2021-09-29 07:33:38 (7992): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-09-29 07:33:39 (7992): 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 2021-09-29 07:33:39 (7992): Guest Log: 2.5.2.0 4101 0 25492 16347 3 2 2318265 4096000 0 65024 0 2 0 4278 634 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-09-29 07:33:41 (7992): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2021-09-29 07:33:42 (7992): 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 2021-09-29 07:33:42 (7992): Guest Log: 2.5.2.0 4057 0 25172 267 3 1 2318265 4096000 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2021-09-29 07:33:43 (7992): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2021-09-29 07:33:44 (7992): 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 2021-09-29 07:33:44 (7992): Guest Log: 2.5.2.0 4079 0 33480 10389 3 1 2318265 4096000 0 65024 0 0 n/a 5299 914 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2021-09-29 07:33:44 (7992): Guest Log: 23:33:47 CEST +02:00 2021-09-28: cranky: [INFO] Checking runc. 2021-09-29 07:33:44 (7992): Guest Log: 23:33:47 CEST +02:00 2021-09-28: cranky: [INFO] Creating the filesystem. 2021-09-29 07:33:45 (7992): Guest Log: 23:33:47 CEST +02:00 2021-09-28: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2021-09-29 07:33:45 (7992): Guest Log: 23:33:47 CEST +02:00 2021-09-28: cranky: [INFO] Updating config.json. 2021-09-29 07:33:45 (7992): Guest Log: 23:33:48 CEST +02:00 2021-09-28: cranky: [INFO] Running Container 'runc'. 2021-09-29 07:33:45 (7992): Guest Log: job: htmld=/shared/html/job 2021-09-29 07:33:45 (7992): Guest Log: job: unpack exitcode=0 2021-09-29 07:33:47 (7992): Guest Log: 23:33:50 CEST +02:00 2021-09-28: cranky: [INFO] ===> [runRivet] Tue Sep 28 21:33:48 UTC 2021 [boinc pp zinclusive 7000 -,-,50,130 - madgraph5amc 2.6.5.atlas lo1jet 100000 204] 2021-09-29 09:13:35 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 09:13:35 (7992): Status Report: Elapsed Time: '74666.301264' 2021-09-29 09:13:35 (7992): Status Report: CPU Time: '65343.546875' 2021-09-29 10:54:25 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 10:54:25 (7992): Status Report: Elapsed Time: '80666.301264' 2021-09-29 10:54:25 (7992): Status Report: CPU Time: '70786.031250' 2021-09-29 12:35:15 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 12:35:15 (7992): Status Report: Elapsed Time: '86666.301264' 2021-09-29 12:35:15 (7992): Status Report: CPU Time: '76227.500000' 2021-09-29 14:16:09 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 14:16:09 (7992): Status Report: Elapsed Time: '92666.301264' 2021-09-29 14:16:09 (7992): Status Report: CPU Time: '81670.656250' 2021-09-29 15:57:06 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 15:57:06 (7992): Status Report: Elapsed Time: '98666.301264' 2021-09-29 15:57:06 (7992): Status Report: CPU Time: '87115.875000' 2021-09-29 17:38:10 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 17:38:10 (7992): Status Report: Elapsed Time: '104666.301264' 2021-09-29 17:38:10 (7992): Status Report: CPU Time: '92565.937500' 2021-09-29 19:19:13 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 19:19:13 (7992): Status Report: Elapsed Time: '110666.301264' 2021-09-29 19:19:13 (7992): Status Report: CPU Time: '98015.765625' 2021-09-29 21:00:25 (7992): Status Report: Job Duration: '864000.000000' 2021-09-29 21:00:25 (7992): Status Report: Elapsed Time: '116666.301264' 2021-09-29 21:00:25 (7992): Status Report: CPU Time: '103471.937500' 2021-09-30 07:16:59 (9768): Detected: vboxwrapper 26197 2021-09-30 07:16:59 (9768): Detected: BOINC client v7.7 2021-09-30 07:17:00 (9768): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-09-30 07:17:07 (9768): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-09-30 07:17:09 (9768): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-09-30 07:17:17 (9768): Successfully started VM. (PID = '7332') 2021-09-30 07:17:17 (9768): Reporting VM Process ID to BOINC. 2021-09-30 07:17:17 (9768): Guest Log: BIOS: VirtualBox 5.2.44 2021-09-30 07:17:17 (9768): Guest Log: CPUID EDX: 0x078bfbff 2021-09-30 07:17:17 (9768): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-09-30 07:17:17 (9768): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-09-30 07:17:17 (9768): Detected: Web Application Enabled (http://localhost:64416) 2021-09-30 07:17:17 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 07:17:17 (9768): Status Report: Elapsed Time: '119671.784307' 2021-09-30 07:17:17 (9768): Status Report: CPU Time: '106210.625000' 2021-09-30 07:17:17 (9768): Preference change detected 2021-09-30 07:17:17 (9768): Setting CPU throttle for VM. (90%) 2021-09-30 07:17:18 (9768): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-09-30 07:17:19 (9768): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-09-30 07:17:19 (9768): Guest Log: BIOS: Booting from Hard Disk... 2021-09-30 07:17:21 (9768): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-09-30 07:17:21 (9768): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-09-30 07:18:00 (9768): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-09-30 07:18:00 (9768): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-09-30 07:18:04 (9768): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.000192 main Log opened 2021-09-29T21:18:07.935532000Z 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.000323 main OS Product: Linux 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.000372 main OS Release: 4.14.76-13.cernvm.x86_64 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.000438 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.000483 main Executable: /usr/sbin/VBoxService 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.000485 main Process ID: 3198 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.000487 main Package type: LINUX_64BITS_GENERIC 2021-09-30 07:18:04 (9768): Guest Log: 00:00:00.007785 main 5.2.6 r120293 started. Verbose level = 0 2021-09-30 07:18:39 (9768): Guest Log: 23:18:42 CEST +02:00 2021-09-29: cranky: [INFO] Detected Theory App 2021-09-30 07:18:39 (9768): Guest Log: 23:18:42 CEST +02:00 2021-09-29: cranky: [INFO] Checking CVMFS. 2021-09-30 07:18:40 (9768): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2021-09-30 07:18:41 (9768): 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 2021-09-30 07:18:41 (9768): Guest Log: 2.5.2.0 4035 0 25144 21160 3 1 2719640 4096000 0 65024 0 0 n/a 5 2 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1 2021-09-30 07:18:43 (9768): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-09-30 07:18:44 (9768): 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 2021-09-30 07:18:44 (9768): Guest Log: 2.5.2.0 4078 0 27572 16355 3 2 2719640 4096000 0 65024 0 2 0 4278 510 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-09-30 07:18:45 (9768): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2021-09-30 07:18:46 (9768): 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 2021-09-30 07:18:46 (9768): Guest Log: 2.5.2.0 4100 0 27192 267 3 1 2719640 4096000 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1 2021-09-30 07:18:48 (9768): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2021-09-30 07:18:49 (9768): 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 2021-09-30 07:18:49 (9768): Guest Log: 2.5.2.0 4057 0 33520 10402 3 1 2719640 4096000 0 65024 0 0 n/a 5310 856 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2021-09-30 07:18:49 (9768): Guest Log: 23:18:52 CEST +02:00 2021-09-29: cranky: [INFO] Checking runc. 2021-09-30 07:18:49 (9768): Guest Log: 23:18:52 CEST +02:00 2021-09-29: cranky: [INFO] Creating the filesystem. 2021-09-30 07:18:49 (9768): Guest Log: 23:18:52 CEST +02:00 2021-09-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2021-09-30 07:18:49 (9768): Guest Log: 23:18:53 CEST +02:00 2021-09-29: cranky: [INFO] Updating config.json. 2021-09-30 07:18:49 (9768): Guest Log: 23:18:53 CEST +02:00 2021-09-29: cranky: [INFO] Running Container 'runc'. 2021-09-30 07:18:50 (9768): Guest Log: job: htmld=/shared/html/job 2021-09-30 07:18:50 (9768): Guest Log: job: unpack exitcode=0 2021-09-30 07:18:51 (9768): Guest Log: 23:18:55 CEST +02:00 2021-09-29: cranky: [INFO] ===> [runRivet] Wed Sep 29 21:18:53 UTC 2021 [boinc pp zinclusive 7000 -,-,50,130 - madgraph5amc 2.6.5.atlas lo1jet 100000 204] 2021-09-30 08:58:05 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 08:58:05 (9768): Status Report: Elapsed Time: '125671.784307' 2021-09-30 08:58:05 (9768): Status Report: CPU Time: '111601.281250' 2021-09-30 10:38:43 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 10:38:43 (9768): Status Report: Elapsed Time: '131671.784307' 2021-09-30 10:38:43 (9768): Status Report: CPU Time: '117034.828125' 2021-09-30 12:19:21 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 12:19:21 (9768): Status Report: Elapsed Time: '137671.784307' 2021-09-30 12:19:21 (9768): Status Report: CPU Time: '122467.312500' 2021-09-30 13:59:58 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 13:59:58 (9768): Status Report: Elapsed Time: '143671.784307' 2021-09-30 13:59:58 (9768): Status Report: CPU Time: '127897.546875' 2021-09-30 15:40:37 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 15:40:37 (9768): Status Report: Elapsed Time: '149671.784307' 2021-09-30 15:40:37 (9768): Status Report: CPU Time: '133329.687500' 2021-09-30 17:21:21 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 17:21:21 (9768): Status Report: Elapsed Time: '155671.784307' 2021-09-30 17:21:21 (9768): Status Report: CPU Time: '138763.625000' 2021-09-30 19:02:01 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 19:02:01 (9768): Status Report: Elapsed Time: '161671.784307' 2021-09-30 19:02:01 (9768): Status Report: CPU Time: '144195.093750' 2021-09-30 20:42:47 (9768): Status Report: Job Duration: '864000.000000' 2021-09-30 20:42:47 (9768): Status Report: Elapsed Time: '167671.784307' 2021-09-30 20:42:47 (9768): Status Report: CPU Time: '149628.125000' 2021-09-30 21:28:35 (9768): Stopping VM. 2021-10-01 07:18:18 (18756): Detected: vboxwrapper 26197 2021-10-01 07:18:18 (18756): Detected: BOINC client v7.7 2021-10-01 07:18:19 (18756): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-10-01 07:18:19 (18756): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-10-01 07:18:20 (18756): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-10-01 07:18:35 (18756): Successfully started VM. (PID = '10000') 2021-10-01 07:18:36 (18756): Reporting VM Process ID to BOINC. 2021-10-01 07:18:36 (18756): Guest Log: BIOS: VirtualBox 5.2.44 2021-10-01 07:18:36 (18756): Guest Log: CPUID EDX: 0x078bfbff 2021-10-01 07:18:36 (18756): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-10-01 07:18:36 (18756): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-10-01 07:18:36 (18756): Guest Log: BIOS: Booting from Hard Disk... 2021-10-01 07:18:36 (18756): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-10-01 07:18:36 (18756): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-10-01 07:18:36 (18756): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-10-01 07:18:36 (18756): Detected: Web Application Enabled (http://localhost:64416) 2021-10-01 07:18:36 (18756): Status Report: Job Duration: '864000.000000' 2021-10-01 07:18:36 (18756): Status Report: Elapsed Time: '170400.784307' 2021-10-01 07:18:36 (18756): Status Report: CPU Time: '152090.312500' 2021-10-01 07:18:36 (18756): Preference change detected 2021-10-01 07:18:36 (18756): Setting CPU throttle for VM. (90%) 2021-10-01 07:18:37 (18756): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-10-01 07:19:07 (18756): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-10-01 07:19:07 (18756): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-10-01 07:19:13 (18756): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.000145 main Log opened 2021-09-30T21:19:17.650435000Z 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.000272 main OS Product: Linux 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.000362 main OS Release: 4.14.76-13.cernvm.x86_64 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.000418 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.000470 main Executable: /usr/sbin/VBoxService 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.000472 main Process ID: 3199 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.000474 main Package type: LINUX_64BITS_GENERIC 2021-10-01 07:19:13 (18756): Guest Log: 00:00:00.006867 main 5.2.6 r120293 started. Verbose level = 0 2021-10-01 07:19:52 (18756): Guest Log: 23:19:56 CEST +02:00 2021-09-30: cranky: [INFO] Detected Theory App 2021-10-01 07:19:52 (18756): Guest Log: 23:19:56 CEST +02:00 2021-09-30: cranky: [INFO] Checking CVMFS. 2021-10-01 07:19:53 (18756): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2021-10-01 07:19:54 (18756): 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 2021-10-01 07:19:54 (18756): Guest Log: 2.5.2.0 4104 0 26288 21166 3 1 3124708 4096000 0 65024 0 0 n/a 5 1 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2021-10-01 07:19:56 (18756): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-10-01 07:19:58 (18756): 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 2021-10-01 07:19:58 (18756): Guest Log: 2.5.2.0 4060 0 27512 16363 3 2 3124708 4096000 0 65024 0 2 0 4278 600 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-10-01 07:19:59 (18756): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2021-10-01 07:20:00 (18756): 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 2021-10-01 07:20:00 (18756): Guest Log: 2.5.2.0 4038 0 25184 268 3 1 3124708 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2021-10-01 07:20:02 (18756): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2021-10-01 07:20:03 (18756): 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 2021-10-01 07:20:03 (18756): Guest Log: 2.5.2.0 4082 0 32500 10410 3 1 3124708 4096000 0 65024 0 0 n/a 5312 850 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2021-10-01 07:20:03 (18756): Guest Log: 23:20:07 CEST +02:00 2021-09-30: cranky: [INFO] Checking runc. 2021-10-01 07:20:03 (18756): Guest Log: 23:20:07 CEST +02:00 2021-09-30: cranky: [INFO] Creating the filesystem. 2021-10-01 07:20:03 (18756): Guest Log: 23:20:07 CEST +02:00 2021-09-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2021-10-01 07:20:03 (18756): Guest Log: 23:20:08 CEST +02:00 2021-09-30: cranky: [INFO] Updating config.json. 2021-10-01 07:20:03 (18756): Guest Log: 23:20:08 CEST +02:00 2021-09-30: cranky: [INFO] Running Container 'runc'. 2021-10-01 07:20:04 (18756): Guest Log: job: htmld=/shared/html/job 2021-10-01 07:20:04 (18756): Guest Log: job: unpack exitcode=0 2021-10-01 07:20:06 (18756): Guest Log: 23:20:10 CEST +02:00 2021-09-30: cranky: [INFO] ===> [runRivet] Thu Sep 30 21:20:09 UTC 2021 [boinc pp zinclusive 7000 -,-,50,130 - madgraph5amc 2.6.5.atlas lo1jet 100000 204] 2021-10-01 08:10:31 (18756): Stopping VM. 2021-10-01 08:11:33 (28316): Detected: vboxwrapper 26197 2021-10-01 08:11:33 (28316): Detected: BOINC client v7.7 2021-10-01 08:11:35 (28316): Detected: VirtualBox VboxManage Interface (Version: 5.2.44) 2021-10-01 08:11:35 (28316): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-10-01 08:11:36 (28316): Starting VM using VBoxManage interface. (boinc_dc01be86d055be97, slot#1) 2021-10-01 08:11:55 (28316): Successfully started VM. (PID = '18276') 2021-10-01 08:11:55 (28316): Reporting VM Process ID to BOINC. 2021-10-01 08:11:55 (28316): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-10-01 08:11:55 (28316): Detected: Web Application Enabled (http://localhost:64416) 2021-10-01 08:11:56 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 08:11:56 (28316): Status Report: Elapsed Time: '173461.784307' 2021-10-01 08:11:56 (28316): Status Report: CPU Time: '154854.968750' 2021-10-01 08:11:56 (28316): Preference change detected 2021-10-01 08:11:56 (28316): Setting CPU throttle for VM. (90%) 2021-10-01 08:11:56 (28316): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-10-01 09:52:35 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 09:52:35 (28316): Status Report: Elapsed Time: '179461.784307' 2021-10-01 09:52:35 (28316): Status Report: CPU Time: '160302.656250' 2021-10-01 11:32:42 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 11:32:42 (28316): Status Report: Elapsed Time: '185461.784307' 2021-10-01 11:32:42 (28316): Status Report: CPU Time: '165700.328125' 2021-10-01 13:12:49 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 13:12:49 (28316): Status Report: Elapsed Time: '191461.784307' 2021-10-01 13:12:49 (28316): Status Report: CPU Time: '171101.796875' 2021-10-01 14:53:06 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 14:53:06 (28316): Status Report: Elapsed Time: '197461.784307' 2021-10-01 14:53:06 (28316): Status Report: CPU Time: '176509.078125' 2021-10-01 16:33:13 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 16:33:13 (28316): Status Report: Elapsed Time: '203461.784307' 2021-10-01 16:33:13 (28316): Status Report: CPU Time: '181910.625000' 2021-10-01 18:13:38 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 18:13:38 (28316): Status Report: Elapsed Time: '209461.784307' 2021-10-01 18:13:38 (28316): Status Report: CPU Time: '187322.890625' 2021-10-01 19:53:50 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 19:53:50 (28316): Status Report: Elapsed Time: '215461.784307' 2021-10-01 19:53:50 (28316): Status Report: CPU Time: '192727.953125' 2021-10-01 21:33:57 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 21:33:57 (28316): Status Report: Elapsed Time: '221461.784307' 2021-10-01 21:33:57 (28316): Status Report: CPU Time: '198127.312500' 2021-10-01 23:14:10 (28316): Status Report: Job Duration: '864000.000000' 2021-10-01 23:14:10 (28316): Status Report: Elapsed Time: '227461.784307' 2021-10-01 23:14:10 (28316): Status Report: CPU Time: '203531.234375' 2021-10-02 00:55:07 (28316): Status Report: Job Duration: '864000.000000' 2021-10-02 00:55:07 (28316): Status Report: Elapsed Time: '233461.784307' 2021-10-02 00:55:07 (28316): Status Report: CPU Time: '208963.187500' 2021-10-02 02:35:22 (28316): Status Report: Job Duration: '864000.000000' 2021-10-02 02:35:22 (28316): Status Report: Elapsed Time: '239461.784307' 2021-10-02 02:35:22 (28316): Status Report: CPU Time: '214367.765625' 2021-10-02 03:32:18 (28316): Guest Log: job: run exitcode=0 2021-10-02 03:32:18 (28316): Guest Log: job: diskusage=328288 2021-10-02 03:32:18 (28316): Guest Log: job: logsize=96 k 2021-10-02 03:32:18 (28316): Guest Log: job: times= 2021-10-02 03:32:18 (28316): Guest Log: 0m0.013s 0m0.023s 2021-10-02 03:32:18 (28316): Guest Log: 1182m39.749s 9m53.233s 2021-10-02 03:32:18 (28316): Guest Log: job: cpuusage=71553 2021-10-02 03:32:18 (28316): Guest Log: 19:32:18 CEST +02:00 2021-10-01: cranky: [INFO] Container 'runc' finished with status code 0. 2021-10-02 03:32:18 (28316): Guest Log: 19:32:18 CEST +02:00 2021-10-01: cranky: [INFO] Preparing output. 2021-10-02 03:32:22 (28316): Guest Log: [INFO] Job Finished 2021-10-02 03:32:22 (28316): Guest Log: [INFO] Shutting Down. 2021-10-02 03:32:22 (28316): VM Completion File Detected. 2021-10-02 03:32:22 (28316): VM Completion Message: Job Finished . 2021-10-02 03:32:22 (28316): Powering off VM. 2021-10-02 03:37:23 (28316): VM did not power off when requested. 2021-10-02 03:37:23 (28316): VM was successfully terminated. 2021-10-02 03:37:23 (28316): Deregistering VM. (boinc_dc01be86d055be97, slot#1) 2021-10-02 03:37:23 (28316): Removing network bandwidth throttle group from VM. 2021-10-02 03:37:24 (28316): Removing VM from VirtualBox. 03:37:29 (28316): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN