| Name | Theory_2390-1152567-56_0 |
| Workunit | 147617862 |
| Created | 20 Oct 2020, 16:25:09 UTC |
| Sent | 20 Oct 2020, 19:38:53 UTC |
| Report deadline | 31 Oct 2020, 19:38:53 UTC |
| Received | 1 Nov 2020, 18:06:27 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10579626 |
| Run time | 19 hours 27 min 20 sec |
| CPU time | 19 hours 5 min 17 sec |
| Validate state | Valid |
| Credit | 737.96 |
| Device peak FLOPS | 4.55 GFLOPS |
| Application version | Theory Simulation v300.06 (vbox64_theory) windows_x86_64 |
| Peak working set size | 70.94 MB |
| Peak swap size | 77.17 MB |
| Peak disk usage | 2.76 GB |
Stderr output
<core_client_version>7.16.7</core_client_version> <![CDATA[ <stderr_txt> (1412): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-10-24 23:52:51 (1412): VM did not stop when requested. 2020-10-24 23:52:51 (1412): VM was successfully terminated. 2020-10-25 09:29:51 (8448): Detected: vboxwrapper 26197 2020-10-25 09:29:51 (8448): Detected: BOINC client v7.7 2020-10-25 09:29:52 (8448): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-10-25 09:29:52 (8448): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-10-25 09:29:52 (8448): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-10-25 09:29:57 (8448): Successfully started VM. (PID = '12564') 2020-10-25 09:29:57 (8448): Reporting VM Process ID to BOINC. 2020-10-25 09:29:57 (8448): Guest Log: BIOS: VirtualBox 6.0.14 2020-10-25 09:29:57 (8448): Guest Log: CPUID EDX: 0x178bfbff 2020-10-25 09:29:57 (8448): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-10-25 09:29:57 (8448): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-10-25 09:29:57 (8448): Detected: Web Application Enabled (http://localhost:53605) 2020-10-25 09:29:57 (8448): Status Report: Job Duration: '864000.000000' 2020-10-25 09:29:57 (8448): Status Report: Elapsed Time: '26794.000000' 2020-10-25 09:29:57 (8448): Status Report: CPU Time: '26508.640625' 2020-10-25 09:29:57 (8448): Preference change detected 2020-10-25 09:29:57 (8448): Setting CPU throttle for VM. (100%) 2020-10-25 09:29:57 (8448): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-10-25 09:29:59 (8448): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-10-25 09:29:59 (8448): Guest Log: BIOS: Booting from Hard Disk... 2020-10-25 09:30:01 (8448): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-10-25 09:30:01 (8448): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-10-25 09:30:21 (8448): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-10-25 09:30:21 (8448): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-10-25 09:30:26 (8448): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.000117 main Log opened 2020-10-25T08:30:24.993074000Z 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.000366 main OS Product: Linux 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.000421 main OS Release: 4.14.76-13.cernvm.x86_64 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.000464 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.000506 main Executable: /usr/sbin/VBoxService 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.000507 main Process ID: 3192 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.000508 main Package type: LINUX_64BITS_GENERIC 2020-10-25 09:30:26 (8448): Guest Log: 00:00:00.003295 main 5.2.6 r120293 started. Verbose level = 0 2020-10-25 09:30:51 (8448): Guest Log: 09:30:50 CET +01:00 2020-10-25: cranky: [INFO] Detected Theory App 2020-10-25 09:30:51 (8448): Guest Log: 09:30:50 CET +01:00 2020-10-25: cranky: [INFO] Checking CVMFS. 2020-10-25 09:30:52 (8448): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-10-25 09:30:52 (8448): 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 2020-10-25 09:30:52 (8448): Guest Log: 2.5.2.0 4041 0 25140 19158 3 1 1384072 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-10-25 09:30:52 (8448): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-10-25 09:30:53 (8448): 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 2020-10-25 09:30:53 (8448): Guest Log: 2.5.2.0 4090 0 27532 13537 3 2 1384072 4096001 0 65024 0 2 0 4273 1692 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-10-25 09:30:53 (8448): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-10-25 09:30:54 (8448): 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 2020-10-25 09:30:54 (8448): Guest Log: 2.5.2.0 4065 0 27216 259 3 1 1384072 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-10-25 09:30:54 (8448): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-10-25 09:30:55 (8448): 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 2020-10-25 09:30:55 (8448): Guest Log: 2.5.2.0 4018 0 30432 7792 3 1 1384072 4096001 0 65024 0 0 n/a 4499 1158 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-10-25 09:30:55 (8448): Guest Log: 09:30:54 CET +01:00 2020-10-25: cranky: [INFO] Checking runc. 2020-10-25 09:30:55 (8448): Guest Log: 09:30:54 CET +01:00 2020-10-25: cranky: [INFO] Creating the filesystem. 2020-10-25 09:30:55 (8448): Guest Log: 09:30:54 CET +01:00 2020-10-25: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-10-25 09:30:55 (8448): Guest Log: 09:30:54 CET +01:00 2020-10-25: cranky: [INFO] Updating config.json. 2020-10-25 09:30:55 (8448): Guest Log: 09:30:54 CET +01:00 2020-10-25: cranky: [INFO] Running Container 'runc'. 2020-10-25 09:30:56 (8448): Guest Log: job: htmld=/shared/html/job 2020-10-25 09:30:56 (8448): Guest Log: job: unpack exitcode=0 2020-10-25 09:30:57 (8448): Guest Log: 09:30:56 CET +01:00 2020-10-25: cranky: [INFO] ===> [runRivet] Sun Oct 25 08:30:55 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-10-25 10:40:22 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 10:47:44 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 10:49:48 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 10:56:10 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 10:57:45 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 11:11:35 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 11:28:55 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 11:34:28 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 11:34:43 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 11:39:13 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 11:43:59 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 11:52:29 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 11:56:48 (8448): Status Report: Job Duration: '864000.000000' 2020-10-25 11:56:48 (8448): Status Report: Elapsed Time: '32794.000000' 2020-10-25 11:56:48 (8448): Status Report: CPU Time: '32504.515625' 2020-10-25 12:07:12 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 12:18:53 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 12:19:07 (8448): Guest Log: 01:50:52.164298 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 832 964 247 000ns (GuestNow=1 603 624 702 997 214 000 ns GuestLast=1 603 622 870 032 967 000 ns fSetTimeLastLoop=true ) 2020-10-25 12:22:13 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 12:25:56 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 12:26:16 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 20:19:33 (8448): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-25 20:19:36 (8448): Guest Log: 01:54:22.247715 timesync vgsvcTimeSyncWorker: Radical host time change: 28 416 960 000 000ns (HostNow=1 603 653 529 207 000 000 ns HostLast=1 603 625 112 247 000 000 ns) 2020-10-25 20:19:46 (8448): Guest Log: 01:54:32.248721 timesync vgsvcTimeSyncWorker: Radical guest time change: 28 626 105 935 000ns (GuestNow=1 603 653 539 208 007 000 ns GuestLast=1 603 624 913 102 072 000 ns fSetTimeLastLoop=true ) 2020-10-25 20:22:09 (8448): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-25 23:52:19 (8448): Stopping VM. 2020-10-25 23:52:19 (8448): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-10-25 23:52:19 (8448): VM did not stop when requested. 2020-10-25 23:52:19 (8448): VM was successfully terminated. 2020-10-26 19:14:10 (6092): Detected: vboxwrapper 26197 2020-10-26 19:14:10 (6092): Detected: BOINC client v7.7 2020-10-26 19:14:11 (6092): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-10-26 19:14:11 (6092): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-10-26 19:14:12 (6092): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-10-26 19:14:17 (6092): Successfully started VM. (PID = '6532') 2020-10-26 19:14:17 (6092): Reporting VM Process ID to BOINC. 2020-10-26 19:14:17 (6092): Guest Log: BIOS: VirtualBox 6.0.14 2020-10-26 19:14:17 (6092): Guest Log: CPUID EDX: 0x178bfbff 2020-10-26 19:14:17 (6092): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-10-26 19:14:17 (6092): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-10-26 19:14:17 (6092): Detected: Web Application Enabled (http://localhost:53605) 2020-10-26 19:14:17 (6092): Status Report: Job Duration: '864000.000000' 2020-10-26 19:14:17 (6092): Status Report: Elapsed Time: '33782.000000' 2020-10-26 19:14:17 (6092): Status Report: CPU Time: '33499.593750' 2020-10-26 19:14:17 (6092): Preference change detected 2020-10-26 19:14:17 (6092): Setting CPU throttle for VM. (100%) 2020-10-26 19:14:17 (6092): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-10-26 19:14:19 (6092): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-10-26 19:14:19 (6092): Guest Log: BIOS: Booting from Hard Disk... 2020-10-26 19:14:21 (6092): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-10-26 19:14:21 (6092): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-10-26 19:14:48 (6092): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-10-26 19:14:48 (6092): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-10-26 19:14:52 (6092): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.000090 main Log opened 2020-10-26T18:14:51.097904000Z 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.000212 main OS Product: Linux 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.000255 main OS Release: 4.14.76-13.cernvm.x86_64 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.000291 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.000327 main Executable: /usr/sbin/VBoxService 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.000328 main Process ID: 3202 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.000329 main Package type: LINUX_64BITS_GENERIC 2020-10-26 19:14:52 (6092): Guest Log: 00:00:00.003404 main 5.2.6 r120293 started. Verbose level = 0 2020-10-26 19:15:10 (6092): Guest Log: 19:15:09 CET +01:00 2020-10-26: cranky: [INFO] Detected Theory App 2020-10-26 19:15:10 (6092): Guest Log: 19:15:09 CET +01:00 2020-10-26: cranky: [INFO] Checking CVMFS. 2020-10-26 19:15:11 (6092): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-10-26 19:15:11 (6092): 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 2020-10-26 19:15:11 (6092): Guest Log: 2.5.2.0 4061 0 28396 19170 3 1 1402385 4096001 0 65024 0 0 n/a 5 21 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-10-26 19:15:12 (6092): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-10-26 19:15:12 (6092): 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 2020-10-26 19:15:12 (6092): Guest Log: 2.5.2.0 4040 0 27572 13547 3 2 1402385 4096001 0 65024 0 2 0 4273 3402 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-10-26 19:15:12 (6092): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-10-26 19:15:13 (6092): 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 2020-10-26 19:15:13 (6092): Guest Log: 2.5.2.0 4019 0 27220 259 3 1 1402385 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-10-26 19:15:13 (6092): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-10-26 19:15:13 (6092): 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 2020-10-26 19:15:13 (6092): Guest Log: 2.5.2.0 4085 0 28316 7815 3 1 1402385 4096001 0 65024 0 0 n/a 4507 1510 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-10-26 19:15:13 (6092): Guest Log: 19:15:12 CET +01:00 2020-10-26: cranky: [INFO] Checking runc. 2020-10-26 19:15:14 (6092): Guest Log: 19:15:12 CET +01:00 2020-10-26: cranky: [INFO] Creating the filesystem. 2020-10-26 19:15:14 (6092): Guest Log: 19:15:12 CET +01:00 2020-10-26: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-10-26 19:15:14 (6092): Guest Log: 19:15:12 CET +01:00 2020-10-26: cranky: [INFO] Updating config.json. 2020-10-26 19:15:14 (6092): Guest Log: 19:15:12 CET +01:00 2020-10-26: cranky: [INFO] Running Container 'runc'. 2020-10-26 19:15:14 (6092): Guest Log: job: htmld=/shared/html/job 2020-10-26 19:15:14 (6092): Guest Log: job: unpack exitcode=0 2020-10-26 19:15:16 (6092): Guest Log: 19:15:14 CET +01:00 2020-10-26: cranky: [INFO] ===> [runRivet] Mon Oct 26 18:15:12 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-10-26 19:44:28 (6092): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-26 19:58:07 (6092): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-26 20:01:43 (6092): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-26 20:05:19 (6092): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-26 20:08:35 (6092): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-26 20:24:26 (6092): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-26 20:24:38 (6092): Guest Log: 00:36:40.912835 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 973 179 262 000ns (GuestNow=1 603 740 255 114 711 000 ns GuestLast=1 603 738 281 935 449 000 ns fSetTimeLastLoop=true ) 2020-10-26 21:09:51 (6092): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-26 21:12:51 (6092): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-26 21:31:37 (6092): Status Report: Job Duration: '864000.000000' 2020-10-26 21:31:37 (6092): Status Report: Elapsed Time: '39782.000000' 2020-10-26 21:31:37 (6092): Status Report: CPU Time: '39346.625000' 2020-10-26 21:36:26 (6092): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-26 21:40:05 (6092): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-26 22:40:00 (6092): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-26 22:41:02 (6092): Stopping VM. 2020-10-26 22:41:02 (6092): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-10-26 22:41:02 (6092): VM did not stop when requested. 2020-10-26 22:41:02 (6092): VM was successfully terminated. 2020-10-28 19:17:39 (7160): Detected: vboxwrapper 26197 2020-10-28 19:17:39 (7160): Detected: BOINC client v7.7 2020-10-28 19:17:40 (7160): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-10-28 19:17:41 (7160): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-10-28 19:17:41 (7160): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-10-28 19:17:46 (7160): Successfully started VM. (PID = '5124') 2020-10-28 19:17:46 (7160): Reporting VM Process ID to BOINC. 2020-10-28 19:17:46 (7160): Guest Log: BIOS: VirtualBox 6.0.14 2020-10-28 19:17:46 (7160): Guest Log: CPUID EDX: 0x178bfbff 2020-10-28 19:17:46 (7160): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-10-28 19:17:46 (7160): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-10-28 19:17:46 (7160): Detected: Web Application Enabled (http://localhost:53605) 2020-10-28 19:17:46 (7160): Status Report: Job Duration: '864000.000000' 2020-10-28 19:17:46 (7160): Status Report: Elapsed Time: '43622.000000' 2020-10-28 19:17:46 (7160): Status Report: CPU Time: '43213.234375' 2020-10-28 19:17:46 (7160): Preference change detected 2020-10-28 19:17:46 (7160): Setting CPU throttle for VM. (100%) 2020-10-28 19:17:46 (7160): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-10-28 19:17:48 (7160): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-10-28 19:17:48 (7160): Guest Log: BIOS: Booting from Hard Disk... 2020-10-28 19:17:50 (7160): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-10-28 19:17:50 (7160): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-10-28 19:18:14 (7160): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-10-28 19:18:14 (7160): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-10-28 19:18:19 (7160): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.000111 main Log opened 2020-10-28T18:18:17.665608000Z 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.000338 main OS Product: Linux 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.000387 main OS Release: 4.14.76-13.cernvm.x86_64 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.000425 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.000471 main Executable: /usr/sbin/VBoxService 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.000472 main Process ID: 3191 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.000472 main Package type: LINUX_64BITS_GENERIC 2020-10-28 19:18:19 (7160): Guest Log: 00:00:00.003046 main 5.2.6 r120293 started. Verbose level = 0 2020-10-28 19:18:24 (7160): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-28 19:21:24 (7160): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-28 19:21:44 (7160): Guest Log: 19:18:43 CET +01:00 2020-10-28: cranky: [INFO] Detected Theory App 2020-10-28 19:21:44 (7160): Guest Log: 19:18:43 CET +01:00 2020-10-28: cranky: [INFO] Checking CVMFS. 2020-10-28 19:21:45 (7160): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-10-28 19:21:48 (7160): 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 2020-10-28 19:21:48 (7160): Guest Log: 2.5.2.0 4017 0 25156 19178 3 1 1831260 4096001 0 65024 0 0 n/a 5 14 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-10-28 19:21:48 (7160): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-10-28 19:21:51 (7160): 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 2020-10-28 19:21:51 (7160): Guest Log: 2.5.2.0 4041 0 27548 13563 3 2 1831260 4096001 0 65024 0 2 0 4273 1557 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-10-28 19:21:52 (7160): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-10-28 19:21:55 (7160): 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 2020-10-28 19:21:55 (7160): Guest Log: 2.5.2.0 4065 0 28560 259 3 1 1831260 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-10-28 19:21:55 (7160): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-10-28 19:21:56 (7160): 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 2020-10-28 19:21:56 (7160): Guest Log: 2.5.2.0 4090 0 30376 7838 3 1 1831260 4096001 0 65024 0 0 n/a 4519 526 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-10-28 19:21:56 (7160): Guest Log: 19:18:54 CET +01:00 2020-10-28: cranky: [INFO] Checking runc. 2020-10-28 19:21:56 (7160): Guest Log: 19:18:54 CET +01:00 2020-10-28: cranky: [INFO] Creating the filesystem. 2020-10-28 19:21:56 (7160): Guest Log: 19:18:54 CET +01:00 2020-10-28: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-10-28 19:21:56 (7160): Guest Log: 19:18:54 CET +01:00 2020-10-28: cranky: [INFO] Updating config.json. 2020-10-28 19:21:56 (7160): Guest Log: 19:18:55 CET +01:00 2020-10-28: cranky: [INFO] Running Container 'runc'. 2020-10-28 19:21:57 (7160): Guest Log: job: htmld=/shared/html/job 2020-10-28 19:21:57 (7160): Guest Log: job: unpack exitcode=0 2020-10-28 19:21:58 (7160): Guest Log: 19:18:57 CET +01:00 2020-10-28: cranky: [INFO] ===> [runRivet] Wed Oct 28 18:18:55 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-10-28 19:25:36 (7160): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-28 21:35:24 (7160): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-28 21:35:27 (7160): Guest Log: 00:04:20.174459 timesync vgsvcTimeSyncWorker: Radical host time change: 7 794 740 000 000ns (HostNow=1 603 917 292 896 000 000 ns HostLast=1 603 909 498 156 000 000 ns) 2020-10-28 21:35:37 (7160): Guest Log: 00:04:30.181823 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 945 127 965 000ns (GuestNow=1 603 917 302 922 895 000 ns GuestLast=1 603 909 357 794 930 000 ns fSetTimeLastLoop=true ) 2020-10-28 21:36:49 (7160): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-28 21:40:23 (7160): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-28 21:40:34 (7160): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-28 21:44:11 (7160): Stopping VM. 2020-10-28 21:44:11 (7160): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-10-28 21:44:11 (7160): VM did not stop when requested. 2020-10-28 21:44:11 (7160): VM was successfully terminated. 2020-10-29 19:30:24 (5968): Detected: vboxwrapper 26197 2020-10-29 19:30:24 (5968): Detected: BOINC client v7.7 2020-10-29 19:30:25 (5968): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-10-29 19:30:25 (5968): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-10-29 19:30:26 (5968): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-10-29 19:30:30 (5968): Successfully started VM. (PID = '13976') 2020-10-29 19:30:30 (5968): Reporting VM Process ID to BOINC. 2020-10-29 19:30:30 (5968): Guest Log: BIOS: VirtualBox 6.0.14 2020-10-29 19:30:30 (5968): Guest Log: CPUID EDX: 0x178bfbff 2020-10-29 19:30:30 (5968): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-10-29 19:30:30 (5968): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-10-29 19:30:30 (5968): Detected: Web Application Enabled (http://localhost:53605) 2020-10-29 19:30:30 (5968): Status Report: Job Duration: '864000.000000' 2020-10-29 19:30:30 (5968): Status Report: Elapsed Time: '43998.000000' 2020-10-29 19:30:30 (5968): Status Report: CPU Time: '43539.375000' 2020-10-29 19:30:30 (5968): Preference change detected 2020-10-29 19:30:30 (5968): Setting CPU throttle for VM. (100%) 2020-10-29 19:30:31 (5968): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-10-29 19:30:32 (5968): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-10-29 19:30:32 (5968): Guest Log: BIOS: Booting from Hard Disk... 2020-10-29 19:30:34 (5968): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-10-29 19:30:34 (5968): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-10-29 19:31:05 (5968): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-10-29 19:31:05 (5968): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-10-29 19:31:08 (5968): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.000076 main Log opened 2020-10-29T18:31:13.102279000Z 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.000168 main OS Product: Linux 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.000207 main OS Release: 4.14.76-13.cernvm.x86_64 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.000239 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.000268 main Executable: /usr/sbin/VBoxService 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.000269 main Process ID: 3194 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.000269 main Package type: LINUX_64BITS_GENERIC 2020-10-29 19:31:08 (5968): Guest Log: 00:00:00.002713 main 5.2.6 r120293 started. Verbose level = 0 2020-10-29 19:31:35 (5968): Guest Log: 19:31:40 CET +01:00 2020-10-29: cranky: [INFO] Detected Theory App 2020-10-29 19:31:35 (5968): Guest Log: 19:31:40 CET +01:00 2020-10-29: cranky: [INFO] Checking CVMFS. 2020-10-29 19:31:36 (5968): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-10-29 19:31:36 (5968): 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 2020-10-29 19:31:36 (5968): Guest Log: 2.5.2.0 4036 0 28312 19180 3 1 1849787 4096001 0 65024 0 0 n/a 5 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-10-29 19:31:36 (5968): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-10-29 19:31:37 (5968): 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 2020-10-29 19:31:37 (5968): Guest Log: 2.5.2.0 4085 0 25640 13571 3 2 1849787 4096001 0 65024 0 2 0 4273 563 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-10-29 19:31:37 (5968): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-10-29 19:31:38 (5968): 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 2020-10-29 19:31:38 (5968): Guest Log: 2.5.2.0 4011 0 27228 259 3 1 1849787 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-10-29 19:31:38 (5968): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-10-29 19:31:38 (5968): 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 2020-10-29 19:31:38 (5968): Guest Log: 2.5.2.0 4060 0 30392 7844 3 1 1849787 4096001 0 65024 0 0 n/a 4524 3245 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-10-29 19:31:38 (5968): Guest Log: 19:31:43 CET +01:00 2020-10-29: cranky: [INFO] Checking runc. 2020-10-29 19:31:39 (5968): Guest Log: 19:31:44 CET +01:00 2020-10-29: cranky: [INFO] Creating the filesystem. 2020-10-29 19:31:39 (5968): Guest Log: 19:31:44 CET +01:00 2020-10-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-10-29 19:31:39 (5968): Guest Log: 19:31:44 CET +01:00 2020-10-29: cranky: [INFO] Updating config.json. 2020-10-29 19:31:39 (5968): Guest Log: 19:31:44 CET +01:00 2020-10-29: cranky: [INFO] Running Container 'runc'. 2020-10-29 19:31:40 (5968): Guest Log: job: htmld=/shared/html/job 2020-10-29 19:31:40 (5968): Guest Log: job: unpack exitcode=0 2020-10-29 19:31:41 (5968): Guest Log: 19:31:46 CET +01:00 2020-10-29: cranky: [INFO] ===> [runRivet] Thu Oct 29 18:31:45 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-10-29 19:36:20 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 19:42:23 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 19:49:49 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 19:56:32 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 20:00:51 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 20:08:45 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 20:16:48 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 20:27:57 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 20:35:38 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 20:54:41 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 20:55:37 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 21:00:17 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 21:01:09 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 21:10:32 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 21:11:25 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 21:23:15 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 21:34:07 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 21:37:17 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 21:39:23 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 21:54:28 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 21:56:34 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 22:17:58 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 22:18:12 (5968): Guest Log: 00:50:41.025241 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 356 164 167 000ns (GuestNow=1 604 006 238 307 655 000 ns GuestLast=1 604 003 882 143 488 000 ns fSetTimeLastLoop=true ) 2020-10-29 22:20:18 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 22:23:25 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 22:30:59 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 22:35:16 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 22:40:27 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 22:46:37 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 22:48:57 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 22:59:30 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 23:13:28 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 23:21:45 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 23:31:03 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 23:52:06 (5968): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-29 23:52:50 (5968): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-29 23:55:15 (5968): Stopping VM. 2020-10-29 23:55:16 (5968): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-10-29 23:55:16 (5968): VM did not stop when requested. 2020-10-29 23:55:16 (5968): VM was successfully terminated. 2020-10-31 10:01:59 (5332): Detected: vboxwrapper 26197 2020-10-31 10:01:59 (5332): Detected: BOINC client v7.7 2020-10-31 10:02:00 (5332): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-10-31 10:02:01 (5332): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-10-31 10:02:01 (5332): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-10-31 10:02:06 (5332): Successfully started VM. (PID = '12908') 2020-10-31 10:02:06 (5332): Reporting VM Process ID to BOINC. 2020-10-31 10:02:06 (5332): Guest Log: BIOS: VirtualBox 6.0.14 2020-10-31 10:02:06 (5332): Guest Log: CPUID EDX: 0x178bfbff 2020-10-31 10:02:06 (5332): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-10-31 10:02:06 (5332): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-10-31 10:02:06 (5332): Detected: Web Application Enabled (http://localhost:53605) 2020-10-31 10:02:06 (5332): Status Report: Job Duration: '864000.000000' 2020-10-31 10:02:06 (5332): Status Report: Elapsed Time: '49407.786381' 2020-10-31 10:02:06 (5332): Status Report: CPU Time: '48985.359375' 2020-10-31 10:02:06 (5332): Preference change detected 2020-10-31 10:02:06 (5332): Setting CPU throttle for VM. (100%) 2020-10-31 10:02:06 (5332): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-10-31 10:02:08 (5332): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-10-31 10:02:08 (5332): Guest Log: BIOS: Booting from Hard Disk... 2020-10-31 10:02:10 (5332): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-10-31 10:02:10 (5332): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-10-31 10:02:34 (5332): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-10-31 10:02:34 (5332): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-10-31 10:02:40 (5332): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.000146 main Log opened 2020-10-31T09:02:37.776878000Z 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.000324 main OS Product: Linux 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.000407 main OS Release: 4.14.76-13.cernvm.x86_64 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.000498 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.000586 main Executable: /usr/sbin/VBoxService 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.000587 main Process ID: 3202 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.000587 main Package type: LINUX_64BITS_GENERIC 2020-10-31 10:02:40 (5332): Guest Log: 00:00:00.004378 main 5.2.6 r120293 started. Verbose level = 0 2020-10-31 10:03:09 (5332): Guest Log: 10:03:06 CET +01:00 2020-10-31: cranky: [INFO] Detected Theory App 2020-10-31 10:03:09 (5332): Guest Log: 10:03:06 CET +01:00 2020-10-31: cranky: [INFO] Checking CVMFS. 2020-10-31 10:03:09 (5332): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-10-31 10:03:10 (5332): 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 2020-10-31 10:03:10 (5332): Guest Log: 2.5.2.0 4069 0 28264 19185 3 1 1868145 4096001 0 65024 0 0 n/a 5 1 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-10-31 10:03:10 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 10:12:56 (5332): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-10-31 10:12:56 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 10:12:57 (5332): 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 2020-10-31 10:12:57 (5332): Guest Log: 2.5.2.0 4095 0 27400 13585 3 2 1868145 4096001 0 65024 0 2 0 4273 721 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-10-31 10:12:58 (5332): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-10-31 10:12:58 (5332): 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 2020-10-31 10:12:58 (5332): Guest Log: 2.5.2.0 4019 0 27212 259 3 1 1868145 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-10-31 10:12:59 (5332): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-10-31 10:12:59 (5332): 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 2020-10-31 10:12:59 (5332): Guest Log: 2.5.2.0 4045 0 29380 7855 3 1 1868145 4096001 0 65024 0 0 n/a 4525 1056 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-10-31 10:12:59 (5332): Guest Log: 10:03:11 CET +01:00 2020-10-31: cranky: [INFO] Checking runc. 2020-10-31 10:12:59 (5332): Guest Log: 10:03:11 CET +01:00 2020-10-31: cranky: [INFO] Creating the filesystem. 2020-10-31 10:12:59 (5332): Guest Log: 10:03:11 CET +01:00 2020-10-31: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-10-31 10:13:00 (5332): Guest Log: 10:03:12 CET +01:00 2020-10-31: cranky: [INFO] Updating config.json. 2020-10-31 10:13:00 (5332): Guest Log: 10:03:12 CET +01:00 2020-10-31: cranky: [INFO] Running Container 'runc'. 2020-10-31 10:13:00 (5332): Guest Log: job: htmld=/shared/html/job 2020-10-31 10:13:00 (5332): Guest Log: job: unpack exitcode=0 2020-10-31 10:13:02 (5332): Guest Log: 10:03:14 CET +01:00 2020-10-31: cranky: [INFO] ===> [runRivet] Sat Oct 31 09:03:12 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-10-31 10:13:06 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 10:21:03 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 10:22:02 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 10:48:58 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 10:49:09 (5332): Guest Log: 00:01:50.210940 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 689 355 506 000ns (GuestNow=1 604 137 747 248 124 000 ns GuestLast=1 604 135 057 892 618 000 ns fSetTimeLastLoop=true ) 2020-10-31 10:49:41 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 11:13:46 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 11:15:34 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 11:18:35 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 11:20:42 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 11:31:19 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 11:33:23 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 11:57:51 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 11:58:09 (5332): Guest Log: 00:08:40.395252 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 302 274 081 000ns (GuestNow=1 604 141 877 645 008 000 ns GuestLast=1 604 139 575 370 927 000 ns fSetTimeLastLoop=true ) 2020-10-31 12:00:01 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 12:15:07 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 12:18:37 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 12:21:41 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 12:22:19 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 12:26:58 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 12:29:13 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 12:33:42 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 12:35:01 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 12:45:17 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 12:45:27 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 12:59:07 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 13:01:11 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 13:05:12 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 13:05:18 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 13:17:25 (5332): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 13:26:13 (5332): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 13:34:20 (5332): Stopping VM. 2020-10-31 13:34:20 (5332): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-10-31 13:34:20 (5332): VM did not stop when requested. 2020-10-31 13:34:20 (5332): VM was successfully terminated. 2020-10-31 18:14:58 (13512): Detected: vboxwrapper 26197 2020-10-31 18:14:58 (13512): Detected: BOINC client v7.7 2020-10-31 18:14:59 (13512): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-10-31 18:14:59 (13512): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-10-31 18:15:00 (13512): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-10-31 18:15:04 (13512): Successfully started VM. (PID = '11820') 2020-10-31 18:15:04 (13512): Reporting VM Process ID to BOINC. 2020-10-31 18:15:04 (13512): Guest Log: BIOS: VirtualBox 6.0.14 2020-10-31 18:15:04 (13512): Guest Log: CPUID EDX: 0x178bfbff 2020-10-31 18:15:04 (13512): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-10-31 18:15:04 (13512): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-10-31 18:15:04 (13512): Detected: Web Application Enabled (http://localhost:53605) 2020-10-31 18:15:04 (13512): Status Report: Job Duration: '864000.000000' 2020-10-31 18:15:04 (13512): Status Report: Elapsed Time: '51135.194762' 2020-10-31 18:15:04 (13512): Status Report: CPU Time: '50714.171875' 2020-10-31 18:15:04 (13512): Preference change detected 2020-10-31 18:15:04 (13512): Setting CPU throttle for VM. (100%) 2020-10-31 18:15:05 (13512): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-10-31 18:15:06 (13512): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-10-31 18:15:06 (13512): Guest Log: BIOS: Booting from Hard Disk... 2020-10-31 18:15:08 (13512): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-10-31 18:15:08 (13512): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-10-31 18:15:30 (13512): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-10-31 18:15:30 (13512): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-10-31 18:15:35 (13512): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.000143 main Log opened 2020-10-31T17:15:32.456208000Z 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.000465 main OS Product: Linux 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.000520 main OS Release: 4.14.76-13.cernvm.x86_64 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.000566 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.000612 main Executable: /usr/sbin/VBoxService 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.000613 main Process ID: 3184 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.000614 main Package type: LINUX_64BITS_GENERIC 2020-10-31 18:15:35 (13512): Guest Log: 00:00:00.005125 main 5.2.6 r120293 started. Verbose level = 0 2020-10-31 18:16:01 (13512): Guest Log: 18:15:59 CET +01:00 2020-10-31: cranky: [INFO] Detected Theory App 2020-10-31 18:16:01 (13512): Guest Log: 18:15:59 CET +01:00 2020-10-31: cranky: [INFO] Checking CVMFS. 2020-10-31 18:16:02 (13512): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-10-31 18:16:02 (13512): 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 2020-10-31 18:16:02 (13512): Guest Log: 2.5.2.0 4008 0 27188 19186 3 1 1886484 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-10-31 18:16:03 (13512): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-10-31 18:16:03 (13512): 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 2020-10-31 18:16:03 (13512): Guest Log: 2.5.2.0 4061 0 27520 13587 3 2 1886484 4096001 0 65024 0 2 0 4273 1072 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-10-31 18:16:04 (13512): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-10-31 18:16:06 (13512): 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 2020-10-31 18:16:06 (13512): Guest Log: 2.5.2.0 4083 0 27200 259 3 1 1886484 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-10-31 18:16:07 (13512): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-10-31 18:16:07 (13512): 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 2020-10-31 18:16:07 (13512): Guest Log: 2.5.2.0 4032 0 29988 7859 3 1 1886484 4096001 0 65024 0 0 n/a 4526 3694 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-10-31 18:16:07 (13512): Guest Log: 18:16:05 CET +01:00 2020-10-31: cranky: [INFO] Checking runc. 2020-10-31 18:16:08 (13512): Guest Log: 18:16:05 CET +01:00 2020-10-31: cranky: [INFO] Creating the filesystem. 2020-10-31 18:16:08 (13512): Guest Log: 18:16:05 CET +01:00 2020-10-31: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-10-31 18:16:08 (13512): Guest Log: 18:16:05 CET +01:00 2020-10-31: cranky: [INFO] Updating config.json. 2020-10-31 18:16:08 (13512): Guest Log: 18:16:05 CET +01:00 2020-10-31: cranky: [INFO] Running Container 'runc'. 2020-10-31 18:16:08 (13512): Guest Log: job: htmld=/shared/html/job 2020-10-31 18:16:08 (13512): Guest Log: job: unpack exitcode=0 2020-10-31 18:16:10 (13512): Guest Log: 18:16:07 CET +01:00 2020-10-31: cranky: [INFO] ===> [runRivet] Sat Oct 31 17:16:06 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-10-31 18:23:15 (13512): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 18:26:18 (13512): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 18:32:41 (13512): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 18:44:08 (13512): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 18:45:19 (13512): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 18:53:00 (13512): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 18:53:24 (13512): VM state change detected. (old = 'Running', new = 'Paused') 2020-10-31 18:58:48 (13512): VM state change detected. (old = 'Paused', new = 'Running') 2020-10-31 18:58:53 (13512): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 01:43:06 (13512): Stopping VM. 2020-11-01 01:43:06 (13512): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-11-01 01:43:06 (13512): VM did not stop when requested. 2020-11-01 01:43:06 (13512): VM was successfully terminated. 2020-11-01 13:19:28 (6240): Detected: vboxwrapper 26197 2020-11-01 13:19:28 (6240): Detected: BOINC client v7.7 2020-11-01 13:19:29 (6240): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-11-01 13:19:29 (6240): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-11-01 13:19:30 (6240): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-11-01 13:19:35 (6240): Successfully started VM. (PID = '11652') 2020-11-01 13:19:35 (6240): Reporting VM Process ID to BOINC. 2020-11-01 13:19:35 (6240): Guest Log: BIOS: VirtualBox 6.0.14 2020-11-01 13:19:35 (6240): Guest Log: CPUID EDX: 0x178bfbff 2020-11-01 13:19:35 (6240): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-11-01 13:19:35 (6240): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-11-01 13:19:35 (6240): Detected: Web Application Enabled (http://localhost:53605) 2020-11-01 13:19:35 (6240): Status Report: Job Duration: '864000.000000' 2020-11-01 13:19:35 (6240): Status Report: Elapsed Time: '52092.004023' 2020-11-01 13:19:35 (6240): Status Report: CPU Time: '51633.515625' 2020-11-01 13:19:35 (6240): Preference change detected 2020-11-01 13:19:35 (6240): Setting CPU throttle for VM. (100%) 2020-11-01 13:19:35 (6240): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-11-01 13:19:37 (6240): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-11-01 13:19:37 (6240): Guest Log: BIOS: Booting from Hard Disk... 2020-11-01 13:19:39 (6240): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-11-01 13:19:39 (6240): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-11-01 13:20:01 (6240): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-11-01 13:20:01 (6240): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-11-01 13:20:05 (6240): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.000141 main Log opened 2020-11-01T12:20:02.646432000Z 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.000283 main OS Product: Linux 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.000332 main OS Release: 4.14.76-13.cernvm.x86_64 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.000382 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.000429 main Executable: /usr/sbin/VBoxService 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.000430 main Process ID: 3205 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.000431 main Package type: LINUX_64BITS_GENERIC 2020-11-01 13:20:05 (6240): Guest Log: 00:00:00.002704 main 5.2.6 r120293 started. Verbose level = 0 2020-11-01 13:20:29 (6240): Guest Log: 13:20:26 CET +01:00 2020-11-01: cranky: [INFO] Detected Theory App 2020-11-01 13:20:29 (6240): Guest Log: 13:20:26 CET +01:00 2020-11-01: cranky: [INFO] Checking CVMFS. 2020-11-01 13:20:30 (6240): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-11-01 13:20:31 (6240): 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 2020-11-01 13:20:31 (6240): Guest Log: 2.5.2.0 4040 0 27204 19188 3 1 1904826 4096001 0 65024 0 0 n/a 5 25 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-11-01 13:20:32 (6240): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-11-01 13:20:32 (6240): 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 2020-11-01 13:20:32 (6240): Guest Log: 2.5.2.0 4091 0 25648 13593 3 2 1904826 4096001 0 65024 0 2 0 4273 1174 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-11-01 13:20:33 (6240): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-11-01 13:20:33 (6240): 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 2020-11-01 13:20:33 (6240): Guest Log: 2.5.2.0 4068 0 27196 259 3 1 1904826 4096001 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-11-01 13:20:34 (6240): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-11-01 13:20:34 (6240): 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 2020-11-01 13:20:34 (6240): Guest Log: 2.5.2.0 4018 0 28884 7863 3 1 1904826 4096001 0 65024 0 0 n/a 4526 3039 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-11-01 13:20:34 (6240): Guest Log: 13:20:32 CET +01:00 2020-11-01: cranky: [INFO] Checking runc. 2020-11-01 13:20:34 (6240): Guest Log: 13:20:32 CET +01:00 2020-11-01: cranky: [INFO] Creating the filesystem. 2020-11-01 13:20:35 (6240): Guest Log: 13:20:32 CET +01:00 2020-11-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-11-01 13:20:35 (6240): Guest Log: 13:20:32 CET +01:00 2020-11-01: cranky: [INFO] Updating config.json. 2020-11-01 13:20:35 (6240): Guest Log: 13:20:32 CET +01:00 2020-11-01: cranky: [INFO] Running Container 'runc'. 2020-11-01 13:20:35 (6240): Guest Log: job: htmld=/shared/html/job 2020-11-01 13:20:35 (6240): Guest Log: job: unpack exitcode=0 2020-11-01 13:20:37 (6240): Guest Log: 13:20:34 CET +01:00 2020-11-01: cranky: [INFO] ===> [runRivet] Sun Nov 1 12:20:32 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-11-01 13:20:59 (6240): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 13:46:51 (6240): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-01 13:47:07 (6240): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 13:47:33 (6240): Stopping VM. 2020-11-01 13:47:33 (6240): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_3853c7b2555a08e9" savestate Output: 2020-11-01 13:47:33 (6240): VM did not stop when requested. 2020-11-01 13:47:33 (6240): VM was successfully terminated. 2020-11-01 13:55:33 (8792): Detected: vboxwrapper 26197 2020-11-01 13:55:33 (8792): Detected: BOINC client v7.7 2020-11-01 13:55:34 (8792): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-11-01 13:55:34 (8792): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-11-01 13:55:34 (8792): Starting VM using VBoxManage interface. (boinc_3853c7b2555a08e9, slot#7) 2020-11-01 13:55:39 (8792): Successfully started VM. (PID = '4428') 2020-11-01 13:55:39 (8792): Reporting VM Process ID to BOINC. 2020-11-01 13:55:39 (8792): Guest Log: BIOS: VirtualBox 6.0.14 2020-11-01 13:55:39 (8792): Guest Log: CPUID EDX: 0x178bfbff 2020-11-01 13:55:39 (8792): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-11-01 13:55:39 (8792): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-11-01 13:55:39 (8792): Detected: Web Application Enabled (http://localhost:53605) 2020-11-01 13:55:39 (8792): Status Report: Job Duration: '864000.000000' 2020-11-01 13:55:39 (8792): Status Report: Elapsed Time: '52189.004023' 2020-11-01 13:55:39 (8792): Status Report: CPU Time: '51683.578125' 2020-11-01 13:55:39 (8792): Preference change detected 2020-11-01 13:55:39 (8792): Setting CPU throttle for VM. (100%) 2020-11-01 13:55:39 (8792): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-11-01 13:55:41 (8792): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-11-01 13:55:41 (8792): Guest Log: BIOS: Booting from Hard Disk... 2020-11-01 13:55:43 (8792): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-11-01 13:55:43 (8792): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-11-01 13:56:04 (8792): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-11-01 13:56:04 (8792): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-11-01 13:56:07 (8792): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.000090 main Log opened 2020-11-01T12:56:04.438682000Z 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.000197 main OS Product: Linux 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.000241 main OS Release: 4.14.76-13.cernvm.x86_64 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.000278 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.000314 main Executable: /usr/sbin/VBoxService 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.000315 main Process ID: 3193 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.000316 main Package type: LINUX_64BITS_GENERIC 2020-11-01 13:56:07 (8792): Guest Log: 00:00:00.002740 main 5.2.6 r120293 started. Verbose level = 0 2020-11-01 13:56:27 (8792): Guest Log: 13:56:24 CET +01:00 2020-11-01: cranky: [INFO] Detected Theory App 2020-11-01 13:56:27 (8792): Guest Log: 13:56:24 CET +01:00 2020-11-01: cranky: [INFO] Checking CVMFS. 2020-11-01 13:56:27 (8792): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-11-01 13:56:27 (8792): 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 2020-11-01 13:56:27 (8792): Guest Log: 2.5.2.0 4032 0 25148 19188 3 1 1904826 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-11-01 13:56:28 (8792): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-11-01 13:56:33 (8792): 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 2020-11-01 13:56:33 (8792): Guest Log: 2.5.2.0 4056 0 25404 13593 3 2 1904826 4096001 0 65024 0 2 100 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-11-01 13:56:34 (8792): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-11-01 13:56:34 (8792): 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 2020-11-01 13:56:34 (8792): Guest Log: 2.5.2.0 4076 0 27548 259 3 1 1904826 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-11-01 13:56:34 (8792): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-11-01 13:56:35 (8792): 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 2020-11-01 13:56:35 (8792): Guest Log: 2.5.2.0 4006 0 30372 7863 3 1 1904826 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-11-01 13:56:35 (8792): Guest Log: 13:56:32 CET +01:00 2020-11-01: cranky: [INFO] Checking runc. 2020-11-01 13:56:35 (8792): Guest Log: 13:56:32 CET +01:00 2020-11-01: cranky: [INFO] Creating the filesystem. 2020-11-01 13:56:35 (8792): Guest Log: 13:56:32 CET +01:00 2020-11-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-11-01 13:56:35 (8792): Guest Log: 13:56:32 CET +01:00 2020-11-01: cranky: [INFO] Updating config.json. 2020-11-01 13:56:35 (8792): Guest Log: 13:56:32 CET +01:00 2020-11-01: cranky: [INFO] Running Container 'runc'. 2020-11-01 13:56:35 (8792): Guest Log: job: htmld=/shared/html/job 2020-11-01 13:56:35 (8792): Guest Log: job: unpack exitcode=0 2020-11-01 13:56:37 (8792): Guest Log: 13:56:34 CET +01:00 2020-11-01: cranky: [INFO] ===> [runRivet] Sun Nov 1 12:56:33 UTC 2020 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.301 tune-AU2lox 100000 56] 2020-11-01 14:05:18 (8792): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 14:09:14 (8792): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-01 14:40:51 (8792): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 14:48:29 (8792): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-01 15:17:19 (8792): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 15:20:28 (8792): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-01 15:55:30 (8792): Status Report: Job Duration: '864000.000000' 2020-11-01 15:55:30 (8792): Status Report: Elapsed Time: '58189.350010' 2020-11-01 15:55:36 (8792): Status Report: CPU Time: '57950.078125' 2020-11-01 17:27:23 (8792): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 17:30:28 (8792): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-01 17:30:58 (8792): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-01 17:33:59 (8792): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-01 17:44:53 (8792): Status Report: Job Duration: '864000.000000' 2020-11-01 17:44:53 (8792): Status Report: Elapsed Time: '64189.365841' 2020-11-01 17:44:53 (8792): Status Report: CPU Time: '64143.812500' 2020-11-01 19:01:09 (8792): Guest Log: job: run exitcode=0 2020-11-01 19:01:09 (8792): Guest Log: job: diskusage=2944 2020-11-01 19:01:09 (8792): Guest Log: job: logsize=76 k 2020-11-01 19:01:09 (8792): Guest Log: job: times= 2020-11-01 19:01:09 (8792): Guest Log: 0m0.006s 0m0.009s 2020-11-01 19:01:09 (8792): Guest Log: 281m8.990s 0m51.744s 2020-11-01 19:01:09 (8792): Guest Log: job: cpuusage=16921 2020-11-01 19:01:09 (8792): Guest Log: 19:00:46 CET +01:00 2020-11-01: cranky: [INFO] Container 'runc' finished with status code 0. 2020-11-01 19:01:09 (8792): Guest Log: 19:00:46 CET +01:00 2020-11-01: cranky: [INFO] Preparing output. 2020-11-01 19:01:10 (8792): Guest Log: [INFO] Job Finished 2020-11-01 19:01:10 (8792): Guest Log: [INFO] Shutting Down. 2020-11-01 19:01:10 (8792): VM Completion File Detected. 2020-11-01 19:01:10 (8792): VM Completion Message: Job Finished . 2020-11-01 19:01:10 (8792): Powering off VM. 2020-11-01 19:06:11 (8792): VM did not power off when requested. 2020-11-01 19:06:11 (8792): VM was successfully terminated. 2020-11-01 19:06:11 (8792): Deregistering VM. (boinc_3853c7b2555a08e9, slot#7) 2020-11-01 19:06:11 (8792): Removing network bandwidth throttle group from VM. 2020-11-01 19:06:11 (8792): Removing VM from VirtualBox. 19:06:16 (8792): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN