| Name | Theory_2390-1110974-14_1 |
| Workunit | 140741794 |
| Created | 4 Jun 2020, 14:07:19 UTC |
| Sent | 4 Jun 2020, 14:14:10 UTC |
| Report deadline | 15 Jun 2020, 14:14:10 UTC |
| Received | 16 Jun 2020, 17:08:01 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10623858 |
| Run time | 8 hours 18 min 57 sec |
| CPU time | 7 hours 42 min 55 sec |
| Validate state | Valid |
| Credit | 196.85 |
| Device peak FLOPS | 2.84 GFLOPS |
| Application version | Theory Simulation v300.06 (vbox64_theory) windows_x86_64 |
| Peak working set size | 60.73 MB |
| Peak swap size | 57.54 MB |
| Peak disk usage | 2.82 GB |
Stderr output
<core_client_version>7.14.2</core_client_version> <![CDATA[ <stderr_txt> 2020-06-09 18:31:10 (3080): Detected: vboxwrapper 26197 2020-06-09 18:31:10 (3080): Detected: BOINC client v7.7 2020-06-09 18:31:10 (3080): Detected: VirtualBox VboxManage Interface (Version: 6.1.4) 2020-06-09 18:31:10 (3080): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-06-09 18:31:10 (3080): Successfully copied 'init_data.xml' to the shared directory. 2020-06-09 18:31:11 (3080): Successfully copied 'input' to the shared directory. 2020-06-09 18:31:12 (3080): Create VM. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-09 18:31:12 (3080): Setting Memory Size for VM. (630MB) 2020-06-09 18:31:13 (3080): Setting CPU Count for VM. (1) 2020-06-09 18:31:13 (3080): Setting Chipset Options for VM. 2020-06-09 18:31:13 (3080): Setting Boot Options for VM. 2020-06-09 18:31:13 (3080): Setting Network Configuration for NAT. 2020-06-09 18:31:14 (3080): Enabling VM Network Access. 2020-06-09 18:31:14 (3080): Disabling USB Support for VM. 2020-06-09 18:31:14 (3080): Disabling COM Port Support for VM. 2020-06-09 18:31:15 (3080): Disabling LPT Port Support for VM. 2020-06-09 18:31:15 (3080): Disabling Audio Support for VM. 2020-06-09 18:31:15 (3080): Disabling Clipboard Support for VM. 2020-06-09 18:31:15 (3080): Disabling Drag and Drop Support for VM. 2020-06-09 18:31:16 (3080): Adding storage controller(s) to VM. 2020-06-09 18:31:16 (3080): Adding virtual disk drive to VM. (vm_image.vdi) 2020-06-09 18:31:16 (3080): Adding VirtualBox Guest Additions to VM. 2020-06-09 18:31:17 (3080): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2020-06-09 18:31:17 (3080): forwarding host port 52096 to guest port 80 2020-06-09 18:31:17 (3080): Enabling remote desktop for VM. 2020-06-09 18:31:17 (3080): Required extension pack not installed, remote desktop not enabled. 2020-06-09 18:31:17 (3080): Enabling shared directory for VM. 2020-06-09 18:31:18 (3080): Starting VM using VBoxManage interface. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-09 18:31:25 (3080): Successfully started VM. (PID = '14704') 2020-06-09 18:31:25 (3080): Reporting VM Process ID to BOINC. 2020-06-09 18:31:25 (3080): Guest Log: BIOS: VirtualBox 6.1.4 2020-06-09 18:31:25 (3080): Guest Log: CPUID EDX: 0x178bfbff 2020-06-09 18:31:25 (3080): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-06-09 18:31:25 (3080): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-06-09 18:31:25 (3080): Detected: Web Application Enabled (http://localhost:52096) 2020-06-09 18:31:25 (3080): Preference change detected 2020-06-09 18:31:25 (3080): Setting CPU throttle for VM. (100%) 2020-06-09 18:31:25 (3080): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-06-09 18:31:27 (3080): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-06-09 18:31:27 (3080): Guest Log: BIOS: Booting from Hard Disk... 2020-06-09 18:31:29 (3080): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-06-09 18:31:29 (3080): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-06-09 18:31:50 (3080): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-06-09 18:31:50 (3080): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-06-09 18:31:55 (3080): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.000164 main Log opened 2020-06-09T16:31:56.695012000Z 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.000406 main OS Product: Linux 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.000510 main OS Release: 4.14.76-13.cernvm.x86_64 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.000713 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.000785 main Executable: /usr/sbin/VBoxService 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.000788 main Process ID: 3211 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.000789 main Package type: LINUX_64BITS_GENERIC 2020-06-09 18:31:55 (3080): Guest Log: 00:00:00.014093 main 5.2.6 r120293 started. Verbose level = 0 2020-06-09 18:32:36 (3080): Guest Log: 18:32:38 CEST +02:00 2020-06-09: cranky: [INFO] Detected Theory App 2020-06-09 18:32:36 (3080): Guest Log: 18:32:38 CEST +02:00 2020-06-09: cranky: [INFO] Checking CVMFS. 2020-06-09 18:32:38 (3080): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-06-09 18:32:39 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 18:32:48 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 18:32:49 (3080): 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-06-09 18:32:49 (3080): Guest Log: 2.5.2.0 4055 0 28324 18210 3 1 263579 4096000 0 65024 0 0 n/a 5 7 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-06-09 18:32:50 (3080): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-06-09 18:32:51 (3080): 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-06-09 18:32:51 (3080): Guest Log: 2.5.2.0 4081 0 27388 12439 3 2 263579 4096000 0 65024 0 2 -100 6411 891 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-06-09 18:32:52 (3080): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-06-09 18:32:53 (3080): 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-06-09 18:32:53 (3080): Guest Log: 2.5.2.0 4101 0 26376 252 3 1 263579 4096000 0 65024 0 0 n/a 4 5 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-06-09 18:32:54 (3080): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-06-09 18:32:55 (3080): 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-06-09 18:32:55 (3080): Guest Log: 2.5.2.0 4129 0 27676 6766 3 1 263579 4096000 0 65024 0 0 n/a 4114 301 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-06-09 18:32:55 (3080): Guest Log: 18:32:48 CEST +02:00 2020-06-09: cranky: [INFO] Checking runc. 2020-06-09 18:32:55 (3080): Guest Log: 18:32:48 CEST +02:00 2020-06-09: cranky: [INFO] Creating the filesystem. 2020-06-09 18:32:55 (3080): Guest Log: 18:32:48 CEST +02:00 2020-06-09: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-06-09 18:32:56 (3080): Guest Log: 18:32:48 CEST +02:00 2020-06-09: cranky: [INFO] Updating config.json. 2020-06-09 18:32:56 (3080): Guest Log: 18:32:48 CEST +02:00 2020-06-09: cranky: [INFO] Running Container 'runc'. 2020-06-09 18:32:57 (3080): Guest Log: job: htmld=/shared/html/job 2020-06-09 18:32:57 (3080): Guest Log: job: unpack exitcode=0 2020-06-09 18:32:58 (3080): Guest Log: 18:32:50 CEST +02:00 2020-06-09: cranky: [INFO] ===> [runRivet] Tue Jun 9 16:32:49 UTC 2020 [boinc pp jets 7000 150,-,2360 - pythia6 6.425 350 100000 14] 2020-06-09 18:38:40 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 18:38:50 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 18:45:01 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 18:45:11 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 18:46:01 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 18:46:11 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 18:53:42 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 18:53:52 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 19:09:10 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 19:09:55 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 19:15:11 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 19:16:17 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 19:23:03 (3080): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 19:23:09 (3080): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 19:41:24 (1572): Detected: vboxwrapper 26197 2020-06-09 19:41:24 (1572): Detected: BOINC client v7.7 2020-06-09 19:41:25 (1572): Detected: VirtualBox VboxManage Interface (Version: 6.1.4) 2020-06-09 19:41:26 (1572): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-06-09 19:41:26 (1572): Starting VM using VBoxManage interface. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-09 19:41:37 (1572): Successfully started VM. (PID = '9988') 2020-06-09 19:41:37 (1572): Reporting VM Process ID to BOINC. 2020-06-09 19:41:37 (1572): Guest Log: BIOS: VirtualBox 6.1.4 2020-06-09 19:41:37 (1572): Guest Log: CPUID EDX: 0x178bfbff 2020-06-09 19:41:37 (1572): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-06-09 19:41:37 (1572): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-06-09 19:41:37 (1572): Detected: Web Application Enabled (http://localhost:52096) 2020-06-09 19:41:37 (1572): Preference change detected 2020-06-09 19:41:37 (1572): Setting CPU throttle for VM. (100%) 2020-06-09 19:41:38 (1572): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-06-09 19:41:39 (1572): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-06-09 19:41:39 (1572): Guest Log: BIOS: Booting from Hard Disk... 2020-06-09 19:41:48 (1572): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-06-09 19:41:48 (1572): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-06-09 19:42:10 (1572): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-06-09 19:42:10 (1572): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-06-09 19:42:17 (1572): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.000241 main Log opened 2020-06-09T17:42:17.855652000Z 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.000394 main OS Product: Linux 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.000479 main OS Release: 4.14.76-13.cernvm.x86_64 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.000704 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.000773 main Executable: /usr/sbin/VBoxService 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.000775 main Process ID: 3212 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.000776 main Package type: LINUX_64BITS_GENERIC 2020-06-09 19:42:17 (1572): Guest Log: 00:00:00.006608 main 5.2.6 r120293 started. Verbose level = 0 2020-06-09 19:42:53 (1572): Guest Log: 19:42:53 CEST +02:00 2020-06-09: cranky: [INFO] Detected Theory App 2020-06-09 19:42:53 (1572): Guest Log: 19:42:53 CEST +02:00 2020-06-09: cranky: [INFO] Checking CVMFS. 2020-06-09 19:42:53 (1572): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-06-09 19:42:54 (1572): 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-06-09 19:42:54 (1572): Guest Log: 2.5.2.0 4127 0 25464 18210 3 1 1031489 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-06-09 19:42:56 (1572): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-06-09 19:42:58 (1572): 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-06-09 19:42:58 (1572): Guest Log: 2.5.2.0 4053 0 27648 12439 3 2 1031489 4096000 0 65024 0 2 100 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-06-09 19:43:00 (1572): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-06-09 19:43:01 (1572): 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-06-09 19:43:01 (1572): Guest Log: 2.5.2.0 4099 0 27212 252 3 1 1031489 4096000 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-06-09 19:43:04 (1572): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-06-09 19:43:04 (1572): 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-06-09 19:43:04 (1572): Guest Log: 2.5.2.0 4075 0 30456 6767 3 1 1031489 4096000 0 65024 0 0 n/a 4117 3408 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-06-09 19:43:04 (1572): Guest Log: 19:43:06 CEST +02:00 2020-06-09: cranky: [INFO] Checking runc. 2020-06-09 19:43:05 (1572): Guest Log: 19:43:06 CEST +02:00 2020-06-09: cranky: [INFO] Creating the filesystem. 2020-06-09 19:43:05 (1572): Guest Log: 19:43:06 CEST +02:00 2020-06-09: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-06-09 19:43:05 (1572): Guest Log: 19:43:07 CEST +02:00 2020-06-09: cranky: [INFO] Updating config.json. 2020-06-09 19:43:05 (1572): Guest Log: 19:43:07 CEST +02:00 2020-06-09: cranky: [INFO] Running Container 'runc'. 2020-06-09 19:43:07 (1572): Guest Log: job: htmld=/shared/html/job 2020-06-09 19:43:07 (1572): Guest Log: job: unpack exitcode=0 2020-06-09 19:43:08 (1572): Guest Log: 19:43:09 CEST +02:00 2020-06-09: cranky: [INFO] ===> [runRivet] Tue Jun 9 17:43:08 UTC 2020 [boinc pp jets 7000 150,-,2360 - pythia6 6.425 350 100000 14] 2020-06-09 19:53:44 (1572): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 19:53:45 (1572): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 20:09:22 (1572): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 20:09:32 (1572): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 20:19:05 (1572): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-09 20:19:07 (1572): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-09 20:20:32 (1572): Stopping VM. 2020-06-09 20:20:33 (1572): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_e92e8a4c8a5db30b" savestate Output: 2020-06-09 20:20:33 (1572): VM did not stop when requested. 2020-06-09 20:20:33 (1572): VM was NOT successfully terminated. 2020-06-11 15:02:28 (14012): Detected: vboxwrapper 26197 2020-06-11 15:02:28 (14012): Detected: BOINC client v7.7 2020-06-11 15:02:30 (14012): Detected: VirtualBox VboxManage Interface (Version: 6.1.4) 2020-06-11 15:02:30 (14012): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-06-11 15:02:31 (14012): Starting VM using VBoxManage interface. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-11 15:02:44 (14012): Successfully started VM. (PID = '18844') 2020-06-11 15:02:44 (14012): Reporting VM Process ID to BOINC. 2020-06-11 15:02:44 (14012): Guest Log: BIOS: VirtualBox 6.1.4 2020-06-11 15:02:44 (14012): Guest Log: CPUID EDX: 0x178bfbff 2020-06-11 15:02:44 (14012): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-06-11 15:02:44 (14012): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-06-11 15:02:44 (14012): Guest Log: BIOS: Booting from Hard Disk... 2020-06-11 15:02:44 (14012): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-06-11 15:02:51 (14012): Detected: Web Application Enabled (http://localhost:52096) 2020-06-11 15:02:51 (14012): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-06-11 15:02:51 (14012): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-06-11 15:03:01 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:03:24 (14012): Preference change detected 2020-06-11 15:03:24 (14012): Setting CPU throttle for VM. (100%) 2020-06-11 15:03:24 (14012): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-06-11 15:03:24 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:03:34 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:03:54 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:04:04 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:04:15 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:04:22 (14012): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-06-11 15:04:22 (14012): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-06-11 15:04:30 (14012): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.000161 main Log opened 2020-06-11T13:04:22.131767000Z 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.001792 main OS Product: Linux 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.001934 main OS Release: 4.14.76-13.cernvm.x86_64 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.001988 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.002035 main Executable: /usr/sbin/VBoxService 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.002037 main Process ID: 3219 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.002038 main Package type: LINUX_64BITS_GENERIC 2020-06-11 15:04:30 (14012): Guest Log: 00:00:00.005612 main 5.2.6 r120293 started. Verbose level = 0 2020-06-11 15:04:54 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:05:04 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:05:14 (14012): Guest Log: 15:04:56 CEST +02:00 2020-06-11: cranky: [INFO] Detected Theory App 2020-06-11 15:05:14 (14012): Guest Log: 15:04:56 CEST +02:00 2020-06-11: cranky: [INFO] Checking CVMFS. 2020-06-11 15:05:22 (14012): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-06-11 15:05:22 (14012): 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-06-11 15:05:22 (14012): Guest Log: 2.5.2.0 4060 0 27200 18219 3 1 1048861 4096000 0 65024 0 0 n/a 5 8 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-06-11 15:05:22 (14012): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-06-11 15:05:22 (14012): 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-06-11 15:05:22 (14012): Guest Log: 2.5.2.0 4108 0 27412 12455 3 2 1048861 4096000 0 65024 0 2 0 4273 1096 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-06-11 15:05:22 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:05:34 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:05:36 (14012): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-06-11 15:05:36 (14012): 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-06-11 15:05:37 (14012): Guest Log: 2.5.2.0 4083 0 25664 252 3 1 1048861 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-06-11 15:05:38 (14012): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-06-11 15:05:40 (14012): 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-06-11 15:05:40 (14012): Guest Log: 2.5.2.0 4134 0 30328 6776 3 1 1048861 4096000 0 65024 0 0 n/a 4121 1378 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-06-11 15:05:40 (14012): Guest Log: 15:05:10 CEST +02:00 2020-06-11: cranky: [INFO] Checking runc. 2020-06-11 15:05:40 (14012): Guest Log: 15:05:10 CEST +02:00 2020-06-11: cranky: [INFO] Creating the filesystem. 2020-06-11 15:05:40 (14012): Guest Log: 15:05:10 CEST +02:00 2020-06-11: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-06-11 15:05:40 (14012): Guest Log: 15:05:10 CEST +02:00 2020-06-11: cranky: [INFO] Updating config.json. 2020-06-11 15:05:40 (14012): Guest Log: 15:05:11 CEST +02:00 2020-06-11: cranky: [INFO] Running Container 'runc'. 2020-06-11 15:05:41 (14012): Guest Log: job: htmld=/shared/html/job 2020-06-11 15:05:41 (14012): Guest Log: job: unpack exitcode=0 2020-06-11 15:05:42 (14012): Guest Log: 15:05:13 CEST +02:00 2020-06-11: cranky: [INFO] ===> [runRivet] Thu Jun 11 13:05:12 UTC 2020 [boinc pp jets 7000 150,-,2360 - pythia6 6.425 350 100000 14] 2020-06-11 15:05:47 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:06:05 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:06:15 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:06:25 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:06:47 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:07:55 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:08:07 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:08:27 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:08:36 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:08:55 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:09:05 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:09:15 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:09:26 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:09:36 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:09:56 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:10:06 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:10:16 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:10:45 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:13:46 (14012): Status Report: Job Duration: '864000.000000' 2020-06-11 15:13:46 (14012): Status Report: Elapsed Time: '6000.321307' 2020-06-11 15:13:46 (14012): Status Report: CPU Time: '5140.359375' 2020-06-11 15:22:42 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:22:50 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:25:13 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:25:14 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:33:27 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:33:28 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:48:42 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:48:58 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:49:08 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:49:18 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:51:59 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:52:09 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:54:22 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:54:29 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:54:49 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:54:59 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 15:58:11 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 15:58:20 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 16:03:32 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 16:03:41 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 16:03:51 (14012): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-11 16:04:01 (14012): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-11 18:23:57 (14012): Guest Log: 03:14:33.686670 timesync vgsvcTimeSyncWorker: Radical host time change: 7 547 171 000 000ns (HostNow=1 591 892 633 532 000 000 ns HostLast=1 591 885 086 361 000 000 ns) 2020-06-11 18:23:58 (14012): Guest Log: 03:14:34.305909 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 550 987 076 000ns (GuestNow=1 591 892 335 774 494 000 ns GuestLast=1 591 884 784 787 418 000 ns fSetTimeLastLoop=false) 2020-06-11 18:24:01 (14012): Stopping VM. 2020-06-13 15:53:48 (14884): Detected: vboxwrapper 26197 2020-06-13 15:53:48 (14884): Detected: BOINC client v7.7 2020-06-13 15:53:50 (14884): Detected: VirtualBox VboxManage Interface (Version: Unknown) 2020-06-13 15:53:50 (14884): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-06-13 15:53:50 (14884): Starting VM using VBoxManage interface. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-13 15:54:08 (14884): Successfully started VM. (PID = '3160') 2020-06-13 15:54:08 (14884): Reporting VM Process ID to BOINC. 2020-06-13 15:54:10 (14884): Guest Log: 03:14:54.395495 timesync vgsvcTimeSyncWorker: Radical host time change: 163 801 948 000 000ns (HostNow=1 592 056 444 282 000 000 ns HostLast=1 591 892 642 334 000 000 ns) 2020-06-13 15:54:10 (14884): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-06-13 15:54:10 (14884): Detected: Web Application Enabled (http://localhost:52096) 2020-06-13 15:54:11 (14884): Status Report: Job Duration: '864000.000000' 2020-06-13 15:54:11 (14884): Status Report: Elapsed Time: '9597.846222' 2020-06-13 15:54:11 (14884): Status Report: CPU Time: '8728.656250' 2020-06-13 15:54:11 (14884): Preference change detected 2020-06-13 15:54:11 (14884): Setting CPU throttle for VM. (100%) 2020-06-13 15:54:20 (14884): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-06-13 15:54:20 (14884): Guest Log: 03:15:04.397032 timesync vgsvcTimeSyncWorker: Radical guest time change: 164 097 814 596 000ns (GuestNow=1 592 056 454 283 630 000 ns GuestLast=1 591 892 356 469 034 000 ns fSetTimeLastLoop=true ) 2020-06-13 15:54:24 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 15:54:52 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 15:56:46 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 15:56:53 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 15:59:05 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 15:59:12 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:01:46 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:01:54 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:03:04 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:03:24 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:04:45 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:05:04 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:05:33 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:05:54 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:08:07 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:08:25 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:09:15 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:09:25 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:11:20 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:11:25 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:11:56 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:12:06 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:12:26 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:12:35 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:14:39 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:14:46 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:15:36 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:15:46 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:16:08 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:16:16 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:16:37 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:16:56 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:17:57 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:18:17 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:20:11 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:20:26 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:21:09 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:21:17 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:21:28 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:21:47 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:23:12 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:23:18 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:23:33 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:23:47 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:24:00 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:24:27 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:25:39 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:25:50 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:27:28 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:27:38 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:27:58 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:28:08 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:29:29 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:29:39 (14884): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-13 16:34:50 (14884): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-13 16:34:59 (14884): Stopping VM. 2020-06-13 16:34:59 (14884): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_e92e8a4c8a5db30b" savestate Output: 2020-06-13 16:34:59 (14884): VM did not stop when requested. 2020-06-13 16:34:59 (14884): VM was NOT successfully terminated. 2020-06-14 11:10:18 (14180): Detected: vboxwrapper 26197 2020-06-14 11:10:18 (14180): Detected: BOINC client v7.7 2020-06-14 11:10:20 (14180): Detected: VirtualBox VboxManage Interface (Version: 6.1.4) 2020-06-14 11:10:20 (14180): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-06-14 11:10:21 (14180): Starting VM using VBoxManage interface. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-14 11:10:28 (14180): Successfully started VM. (PID = '14492') 2020-06-14 11:10:28 (14180): Reporting VM Process ID to BOINC. 2020-06-14 11:10:28 (14180): Guest Log: BIOS: VirtualBox 6.1.4 2020-06-14 11:10:28 (14180): Guest Log: CPUID EDX: 0x178bfbff 2020-06-14 11:10:28 (14180): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-06-14 11:10:28 (14180): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-06-14 11:10:28 (14180): Detected: Web Application Enabled (http://localhost:52096) 2020-06-14 11:10:30 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:10:39 (14180): Status Report: Job Duration: '864000.000000' 2020-06-14 11:10:39 (14180): Status Report: Elapsed Time: '11490.145207' 2020-06-14 11:10:39 (14180): Status Report: CPU Time: '10748.343750' 2020-06-14 11:10:39 (14180): Preference change detected 2020-06-14 11:10:39 (14180): Setting CPU throttle for VM. (100%) 2020-06-14 11:10:39 (14180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-06-14 11:10:40 (14180): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-06-14 11:10:40 (14180): Guest Log: BIOS: Booting from Hard Disk... 2020-06-14 11:10:40 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:10:43 (14180): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-06-14 11:10:43 (14180): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-06-14 11:11:09 (14180): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-06-14 11:11:09 (14180): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-06-14 11:11:09 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:15:26 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:15:31 (14180): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.000116 main Log opened 2020-06-14T09:11:16.147700000Z 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.000235 main OS Product: Linux 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.000295 main OS Release: 4.14.76-13.cernvm.x86_64 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.000335 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.000387 main Executable: /usr/sbin/VBoxService 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.000388 main Process ID: 3212 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.000389 main Package type: LINUX_64BITS_GENERIC 2020-06-14 11:15:31 (14180): Guest Log: 00:00:00.005513 main 5.2.6 r120293 started. Verbose level = 0 2020-06-14 11:15:36 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:15:46 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:16:11 (14180): Guest Log: 11:11:46 CEST +02:00 2020-06-14: cranky: [INFO] Detected Theory App 2020-06-14 11:16:11 (14180): Guest Log: 11:11:46 CEST +02:00 2020-06-14: cranky: [INFO] Checking CVMFS. 2020-06-14 11:16:12 (14180): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-06-14 11:16:13 (14180): 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-06-14 11:16:13 (14180): Guest Log: 2.5.2.0 4124 0 26644 18226 3 1 1067096 4096000 0 65024 0 0 n/a 5 3 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-06-14 11:16:14 (14180): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-06-14 11:16:15 (14180): 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-06-14 11:16:15 (14180): Guest Log: 2.5.2.0 4050 0 27704 12477 3 2 1067096 4096000 0 65024 0 2 0 4272 2187 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-06-14 11:16:16 (14180): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-06-14 11:16:17 (14180): 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-06-14 11:16:17 (14180): Guest Log: 2.5.2.0 4099 0 25160 252 3 1 1067096 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-06-14 11:16:18 (14180): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-06-14 11:16:19 (14180): 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-06-14 11:16:19 (14180): Guest Log: 2.5.2.0 4076 0 28376 6792 3 1 1067096 4096000 0 65024 0 0 n/a 4127 1536 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-06-14 11:16:19 (14180): Guest Log: 11:11:54 CEST +02:00 2020-06-14: cranky: [INFO] Checking runc. 2020-06-14 11:16:19 (14180): Guest Log: 11:11:54 CEST +02:00 2020-06-14: cranky: [INFO] Creating the filesystem. 2020-06-14 11:16:19 (14180): Guest Log: 11:11:54 CEST +02:00 2020-06-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-06-14 11:16:19 (14180): Guest Log: 11:11:54 CEST +02:00 2020-06-14: cranky: [INFO] Updating config.json. 2020-06-14 11:16:19 (14180): Guest Log: 11:11:54 CEST +02:00 2020-06-14: cranky: [INFO] Running Container 'runc'. 2020-06-14 11:16:20 (14180): Guest Log: job: htmld=/shared/html/job 2020-06-14 11:16:20 (14180): Guest Log: job: unpack exitcode=0 2020-06-14 11:16:22 (14180): Guest Log: 11:11:56 CEST +02:00 2020-06-14: cranky: [INFO] ===> [runRivet] Sun Jun 14 09:11:55 UTC 2020 [boinc pp jets 7000 150,-,2360 - pythia6 6.425 350 100000 14] 2020-06-14 11:18:49 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:18:57 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:21:58 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:22:07 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:26:40 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:26:48 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:27:19 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:27:28 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:28:19 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:28:28 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:33:29 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:33:39 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:38:51 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:39:00 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 11:52:36 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 11:52:56 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:05:50 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 12:06:00 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:06:40 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 12:06:50 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:10:41 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 12:10:51 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:22:53 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 12:23:03 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:31:28 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 12:31:35 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:44:47 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 12:44:57 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:49:50 (14180): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 12:49:58 (14180): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 12:54:52 (14180): Stopping VM. 2020-06-14 12:54:53 (14180): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_e92e8a4c8a5db30b" savestate Output: 2020-06-14 12:54:53 (14180): VM did not stop when requested. 2020-06-14 12:54:53 (14180): VM was NOT successfully terminated. 2020-06-14 19:01:32 (13368): Detected: vboxwrapper 26197 2020-06-14 19:01:32 (13368): Detected: BOINC client v7.7 2020-06-14 19:01:33 (13368): Detected: VirtualBox VboxManage Interface (Version: 6.1.4) 2020-06-14 19:01:33 (13368): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-06-14 19:01:34 (13368): Starting VM using VBoxManage interface. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-14 19:01:42 (13368): Successfully started VM. (PID = '17888') 2020-06-14 19:01:42 (13368): Reporting VM Process ID to BOINC. 2020-06-14 19:01:42 (13368): Guest Log: BIOS: VirtualBox 6.1.4 2020-06-14 19:01:42 (13368): Guest Log: CPUID EDX: 0x178bfbff 2020-06-14 19:01:42 (13368): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-06-14 19:01:42 (13368): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-06-14 19:01:42 (13368): Detected: Web Application Enabled (http://localhost:52096) 2020-06-14 19:01:42 (13368): Status Report: Job Duration: '864000.000000' 2020-06-14 19:01:42 (13368): Status Report: Elapsed Time: '16913.392872' 2020-06-14 19:01:42 (13368): Status Report: CPU Time: '16404.578125' 2020-06-14 19:01:42 (13368): Preference change detected 2020-06-14 19:01:42 (13368): Setting CPU throttle for VM. (100%) 2020-06-14 19:01:42 (13368): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-06-14 19:01:44 (13368): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 19:01:54 (13368): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-06-14 19:01:54 (13368): Guest Log: BIOS: Booting from Hard Disk... 2020-06-14 19:01:54 (13368): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 19:01:56 (13368): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-06-14 19:01:56 (13368): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-06-14 19:02:16 (13368): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-06-14 19:02:16 (13368): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-06-14 19:02:21 (13368): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.000601 main Log opened 2020-06-14T17:02:21.865425000Z 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.002531 main OS Product: Linux 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.005644 main OS Release: 4.14.76-13.cernvm.x86_64 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.005808 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.005870 main Executable: /usr/sbin/VBoxService 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.005872 main Process ID: 3208 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.005873 main Package type: LINUX_64BITS_GENERIC 2020-06-14 19:02:21 (13368): Guest Log: 00:00:00.031251 main 5.2.6 r120293 started. Verbose level = 0 2020-06-14 19:02:24 (13368): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 19:02:34 (13368): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 19:02:53 (13368): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 19:03:03 (13368): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 19:03:16 (13368): Guest Log: 19:02:58 CEST +02:00 2020-06-14: cranky: [INFO] Detected Theory App 2020-06-14 19:03:16 (13368): Guest Log: 19:02:58 CEST +02:00 2020-06-14: cranky: [INFO] Checking CVMFS. 2020-06-14 19:03:17 (13368): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-06-14 19:03:18 (13368): 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-06-14 19:03:18 (13368): Guest Log: 2.5.2.0 4099 0 26172 18227 3 1 1084483 4096000 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-06-14 19:03:19 (13368): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-06-14 19:03:20 (13368): 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-06-14 19:03:20 (13368): Guest Log: 2.5.2.0 4074 0 27652 12479 3 2 1084483 4096000 0 65024 0 2 0 4272 2355 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-06-14 19:03:21 (13368): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-06-14 19:03:22 (13368): 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-06-14 19:03:23 (13368): Guest Log: 2.5.2.0 4123 0 25700 252 3 1 1084483 4096000 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-06-14 19:03:24 (13368): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-06-14 19:03:25 (13368): 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-06-14 19:03:25 (13368): Guest Log: 2.5.2.0 4052 0 29740 6795 3 1 1084483 4096000 0 65024 0 0 n/a 4128 3122 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-06-14 19:03:25 (13368): Guest Log: 19:03:05 CEST +02:00 2020-06-14: cranky: [INFO] Checking runc. 2020-06-14 19:03:25 (13368): Guest Log: 19:03:05 CEST +02:00 2020-06-14: cranky: [INFO] Creating the filesystem. 2020-06-14 19:03:25 (13368): Guest Log: 19:03:05 CEST +02:00 2020-06-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-06-14 19:03:25 (13368): Guest Log: 19:03:06 CEST +02:00 2020-06-14: cranky: [INFO] Updating config.json. 2020-06-14 19:03:25 (13368): Guest Log: 19:03:06 CEST +02:00 2020-06-14: cranky: [INFO] Running Container 'runc'. 2020-06-14 19:03:26 (13368): Guest Log: job: htmld=/shared/html/job 2020-06-14 19:03:26 (13368): Guest Log: job: unpack exitcode=0 2020-06-14 19:03:27 (13368): Guest Log: 19:03:08 CEST +02:00 2020-06-14: cranky: [INFO] ===> [runRivet] Sun Jun 14 17:03:06 UTC 2020 [boinc pp jets 7000 150,-,2360 - pythia6 6.425 350 100000 14] 2020-06-14 19:06:14 (13368): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 19:06:24 (13368): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 19:22:17 (13368): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 19:22:27 (13368): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 19:32:19 (13368): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 19:32:29 (13368): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 19:37:19 (13368): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-14 19:37:29 (13368): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-14 19:43:47 (13368): Stopping VM. 2020-06-14 19:43:47 (13368): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_e92e8a4c8a5db30b" savestate Output: 2020-06-14 19:43:47 (13368): VM did not stop when requested. 2020-06-14 19:43:47 (13368): VM was NOT successfully terminated. 2020-06-16 13:55:34 (13308): Detected: vboxwrapper 26197 2020-06-16 13:55:34 (13308): Detected: BOINC client v7.7 2020-06-16 13:55:37 (13308): Detected: VirtualBox VboxManage Interface (Version: 6.1.4) 2020-06-16 13:55:37 (13308): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-06-16 13:55:39 (13308): Starting VM using VBoxManage interface. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-16 13:55:47 (13308): Successfully started VM. (PID = '13964') 2020-06-16 13:55:47 (13308): Reporting VM Process ID to BOINC. 2020-06-16 13:55:47 (13308): Guest Log: BIOS: VirtualBox 6.1.4 2020-06-16 13:55:47 (13308): Guest Log: CPUID EDX: 0x178bfbff 2020-06-16 13:55:47 (13308): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-06-16 13:55:47 (13308): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-06-16 13:55:47 (13308): Detected: Web Application Enabled (http://localhost:52096) 2020-06-16 13:55:48 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 13:55:56 (13308): Status Report: Job Duration: '864000.000000' 2020-06-16 13:55:56 (13308): Status Report: Elapsed Time: '19344.392872' 2020-06-16 13:55:56 (13308): Status Report: CPU Time: '18782.187500' 2020-06-16 13:55:56 (13308): Preference change detected 2020-06-16 13:55:56 (13308): Setting CPU throttle for VM. (100%) 2020-06-16 13:55:56 (13308): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-06-16 13:55:57 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 13:55:58 (13308): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-06-16 13:55:58 (13308): Guest Log: BIOS: Booting from Hard Disk... 2020-06-16 13:56:00 (13308): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-06-16 13:56:00 (13308): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-06-16 13:56:17 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 13:56:37 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 13:56:55 (13308): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-06-16 13:56:55 (13308): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-06-16 13:57:01 (13308): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.000133 main Log opened 2020-06-16T11:57:01.610184000Z 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.000282 main OS Product: Linux 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.000341 main OS Release: 4.14.76-13.cernvm.x86_64 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.000386 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.000440 main Executable: /usr/sbin/VBoxService 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.000442 main Process ID: 3215 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.000443 main Package type: LINUX_64BITS_GENERIC 2020-06-16 13:57:01 (13308): Guest Log: 00:00:00.005877 main 5.2.6 r120293 started. Verbose level = 0 2020-06-16 13:57:30 (13308): Guest Log: 13:57:31 CEST +02:00 2020-06-16: cranky: [INFO] Detected Theory App 2020-06-16 13:57:30 (13308): Guest Log: 13:57:31 CEST +02:00 2020-06-16: cranky: [INFO] Checking CVMFS. 2020-06-16 13:57:32 (13308): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-06-16 13:57:33 (13308): 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-06-16 13:57:33 (13308): Guest Log: 2.5.2.0 4078 0 26644 18244 3 1 1101862 4096000 0 65024 0 0 n/a 5 6 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-06-16 13:57:34 (13308): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-06-16 13:57:35 (13308): 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-06-16 13:57:35 (13308): Guest Log: 2.5.2.0 4098 0 27540 12491 3 2 1101862 4096000 0 65024 0 2 0 4273 1074 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-06-16 13:57:36 (13308): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-06-16 13:57:39 (13308): 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-06-16 13:57:39 (13308): Guest Log: 2.5.2.0 4126 0 27176 252 3 1 1101862 4096000 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-06-16 13:57:39 (13308): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-06-16 13:57:40 (13308): 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-06-16 13:57:40 (13308): Guest Log: 2.5.2.0 4056 0 29044 6805 3 1 1101862 4096000 0 65024 0 0 n/a 4133 707 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-06-16 13:57:40 (13308): Guest Log: 13:57:40 CEST +02:00 2020-06-16: cranky: [INFO] Checking runc. 2020-06-16 13:57:41 (13308): Guest Log: 13:57:41 CEST +02:00 2020-06-16: cranky: [INFO] Creating the filesystem. 2020-06-16 13:57:41 (13308): Guest Log: 13:57:41 CEST +02:00 2020-06-16: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-06-16 13:57:41 (13308): Guest Log: 13:57:41 CEST +02:00 2020-06-16: cranky: [INFO] Updating config.json. 2020-06-16 13:57:41 (13308): Guest Log: 13:57:41 CEST +02:00 2020-06-16: cranky: [INFO] Running Container 'runc'. 2020-06-16 13:57:41 (13308): Guest Log: job: htmld=/shared/html/job 2020-06-16 13:57:41 (13308): Guest Log: job: unpack exitcode=0 2020-06-16 13:57:43 (13308): Guest Log: 13:57:43 CEST +02:00 2020-06-16: cranky: [INFO] ===> [runRivet] Tue Jun 16 11:57:42 UTC 2020 [boinc pp jets 7000 150,-,2360 - pythia6 6.425 350 100000 14] 2020-06-16 14:00:08 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 14:00:18 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 14:07:26 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 14:07:27 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 14:07:30 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 14:07:40 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 14:09:10 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 14:09:20 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 14:13:31 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 14:13:41 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 14:47:27 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 14:49:38 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 15:38:34 (13308): Guest Log: 01:38:40.155518 timesync vgsvcTimeSyncWorker: Radical host time change: 1 946 759 000 000ns (HostNow=1 592 314 709 021 000 000 ns HostLast=1 592 312 762 262 000 000 ns) 2020-06-16 15:38:34 (13308): Guest Log: 01:38:40.289467 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 947 731 064 000ns (GuestNow=1 592 314 541 725 470 000 ns GuestLast=1 592 312 593 994 406 000 ns fSetTimeLastLoop=false) 2020-06-16 15:40:06 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 15:40:32 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 16:11:48 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 16:11:58 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 16:16:18 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 16:17:29 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 16:17:49 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 16:17:59 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 16:18:52 (13308): Status Report: Job Duration: '864000.000000' 2020-06-16 16:18:52 (13308): Status Report: Elapsed Time: '25344.771025' 2020-06-16 16:18:52 (13308): Status Report: CPU Time: '24704.437500' 2020-06-16 18:19:03 (13308): Guest Log: 04:17:23.593285 timesync vgsvcTimeSyncWorker: Radical host time change: 6 604 328 000 000ns (HostNow=1 592 324 342 899 000 000 ns HostLast=1 592 317 738 571 000 000 ns) 2020-06-16 18:19:03 (13308): Guest Log: 04:17:24.155686 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 601 453 663 000ns (GuestNow=1 592 324 065 203 288 000 ns GuestLast=1 592 317 463 749 625 000 ns fSetTimeLastLoop=false) 2020-06-16 18:19:17 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 18:19:34 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 18:20:15 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 18:20:35 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 18:21:58 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 18:22:06 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 18:40:59 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 18:41:09 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 18:49:52 (13308): VM state change detected. (old = 'Running', new = 'Paused') 2020-06-16 18:50:02 (13308): VM state change detected. (old = 'Paused', new = 'Running') 2020-06-16 19:02:39 (13308): Guest Log: job: run exitcode=0 2020-06-16 19:02:39 (13308): Guest Log: job: diskusage=1984 2020-06-16 19:02:39 (13308): Guest Log: job: logsize=60 k 2020-06-16 19:02:39 (13308): Guest Log: job: times= 2020-06-16 19:02:39 (13308): Guest Log: 0m0.013s 0m0.023s 2020-06-16 19:02:39 (13308): Guest Log: 289m17.301s 2m39.568s 2020-06-16 19:02:39 (13308): Guest Log: job: cpuusage=17517 2020-06-16 19:02:39 (13308): Guest Log: 18:57:00 CEST +02:00 2020-06-16: cranky: [INFO] Container 'runc' finished with status code 0. 2020-06-16 19:02:39 (13308): Guest Log: 18:57:00 CEST +02:00 2020-06-16: cranky: [INFO] Preparing output. 2020-06-16 19:02:41 (13308): Guest Log: [INFO] Job Finished 2020-06-16 19:02:41 (13308): Guest Log: [INFO] Shutting Down. 2020-06-16 19:02:41 (13308): VM Completion File Detected. 2020-06-16 19:02:41 (13308): VM Completion Message: Job Finished . 2020-06-16 19:02:41 (13308): Powering off VM. 2020-06-16 19:07:42 (13308): VM did not power off when requested. 2020-06-16 19:07:42 (13308): VM was successfully terminated. 2020-06-16 19:07:42 (13308): Deregistering VM. (boinc_e92e8a4c8a5db30b, slot#6) 2020-06-16 19:07:42 (13308): Removing network bandwidth throttle group from VM. 2020-06-16 19:07:42 (13308): Removing VM from VirtualBox. 19:07:48 (13308): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN