| Name | Theory_2390-1145515-146_0 |
| Workunit | 148580783 |
| Created | 27 Nov 2020, 21:43:07 UTC |
| Sent | 28 Nov 2020, 0:30:37 UTC |
| Report deadline | 9 Dec 2020, 0:30:37 UTC |
| Received | 9 Dec 2020, 21:14:20 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10648192 |
| Run time | 3 hours 38 min 45 sec |
| CPU time | 3 hours 8 min 1 sec |
| Validate state | Valid |
| Credit | 107.83 |
| Device peak FLOPS | 3.55 GFLOPS |
| Application version | Theory Simulation v300.06 (vbox64_theory) windows_x86_64 |
| Peak working set size | 72.66 MB |
| Peak swap size | 77.58 MB |
| Peak disk usage | 2.15 GB |
Stderr output
<core_client_version>7.16.5</core_client_version> <![CDATA[ <stderr_txt> 2020-11-27 18:30:43 (12764): Detected: vboxwrapper 26197 2020-11-27 18:30:43 (12764): Detected: BOINC client v7.7 2020-11-27 18:30:44 (12764): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-11-27 18:30:45 (12764): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-11-27 18:30:45 (12764): Successfully copied 'init_data.xml' to the shared directory. 2020-11-27 18:30:45 (12764): Successfully copied 'input' to the shared directory. 2020-11-27 18:30:46 (12764): Create VM. (boinc_52d267b47bb094f0, slot#2) 2020-11-27 18:30:47 (12764): Setting Memory Size for VM. (630MB) 2020-11-27 18:30:47 (12764): Setting CPU Count for VM. (1) 2020-11-27 18:30:47 (12764): Setting Chipset Options for VM. 2020-11-27 18:30:48 (12764): Setting Boot Options for VM. 2020-11-27 18:30:48 (12764): Setting Network Configuration for NAT. 2020-11-27 18:30:48 (12764): Enabling VM Network Access. 2020-11-27 18:30:49 (12764): Disabling USB Support for VM. 2020-11-27 18:30:49 (12764): Disabling COM Port Support for VM. 2020-11-27 18:30:49 (12764): Disabling LPT Port Support for VM. 2020-11-27 18:30:49 (12764): Disabling Audio Support for VM. 2020-11-27 18:30:50 (12764): Disabling Clipboard Support for VM. 2020-11-27 18:30:50 (12764): Disabling Drag and Drop Support for VM. 2020-11-27 18:30:50 (12764): Adding storage controller(s) to VM. 2020-11-27 18:30:50 (12764): Adding virtual disk drive to VM. (vm_image.vdi) 2020-11-27 18:30:51 (12764): Adding VirtualBox Guest Additions to VM. 2020-11-27 18:30:51 (12764): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2020-11-27 18:30:51 (12764): forwarding host port 61774 to guest port 80 2020-11-27 18:30:51 (12764): Enabling remote desktop for VM. 2020-11-27 18:30:52 (12764): Required extension pack not installed, remote desktop not enabled. 2020-11-27 18:30:52 (12764): Enabling shared directory for VM. 2020-11-27 18:30:52 (12764): Starting VM using VBoxManage interface. (boinc_52d267b47bb094f0, slot#2) 2020-11-27 18:30:57 (12764): Successfully started VM. (PID = '19752') 2020-11-27 18:30:57 (12764): Reporting VM Process ID to BOINC. 2020-11-27 18:30:57 (12764): Guest Log: BIOS: VirtualBox 6.0.14 2020-11-27 18:30:57 (12764): Guest Log: CPUID EDX: 0x178bfbff 2020-11-27 18:30:57 (12764): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-11-27 18:30:57 (12764): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-11-27 18:30:57 (12764): Detected: Web Application Enabled (http://localhost:61774) 2020-11-27 18:30:58 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 18:31:07 (12764): Preference change detected 2020-11-27 18:31:07 (12764): Setting CPU throttle for VM. (90%) 2020-11-27 18:31:07 (12764): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-11-27 18:31:07 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 18:31:08 (12764): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-11-27 18:31:08 (12764): Guest Log: BIOS: Booting from Hard Disk... 2020-11-27 18:31:10 (12764): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-11-27 18:31:10 (12764): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-11-27 18:31:38 (12764): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-11-27 18:31:38 (12764): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-11-27 18:31:43 (12764): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.000100 main Log opened 2020-11-28T00:31:44.171296000Z 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.000269 main OS Product: Linux 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.000323 main OS Release: 4.14.76-13.cernvm.x86_64 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.000369 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.000412 main Executable: /usr/sbin/VBoxService 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.000413 main Process ID: 3199 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.000414 main Package type: LINUX_64BITS_GENERIC 2020-11-27 18:31:43 (12764): Guest Log: 00:00:00.003293 main 5.2.6 r120293 started. Verbose level = 0 2020-11-27 18:32:08 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 18:32:18 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 18:32:26 (12764): Guest Log: 19:32:17 EST -05:00 2020-11-27: cranky: [INFO] Detected Theory App 2020-11-27 18:32:26 (12764): Guest Log: 19:32:17 EST -05:00 2020-11-27: cranky: [INFO] Checking CVMFS. 2020-11-27 18:32:27 (12764): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-11-27 18:32:28 (12764): 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-27 18:32:28 (12764): Guest Log: 2.5.2.0 4029 0 28396 19290 3 1 264729 4096000 0 65024 0 0 n/a 5 5 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-11-27 18:32:29 (12764): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-11-27 18:32:30 (12764): 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-27 18:32:30 (12764): Guest Log: 2.5.2.0 4055 0 27812 13805 3 2 264729 4096000 0 65024 0 2 -100 6411 2965 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-11-27 18:32:31 (12764): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-11-27 18:32:31 (12764): 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-27 18:32:31 (12764): Guest Log: 2.5.2.0 4076 0 27212 259 3 1 264729 4096000 0 65024 0 0 n/a 4 5 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-11-27 18:32:33 (12764): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-11-27 18:32:34 (12764): 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-27 18:32:34 (12764): Guest Log: 2.5.2.0 4097 0 28696 8059 3 1 264729 4096000 0 65024 0 0 n/a 4586 3824 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-11-27 18:32:34 (12764): Guest Log: 19:32:25 EST -05:00 2020-11-27: cranky: [INFO] Checking runc. 2020-11-27 18:32:34 (12764): Guest Log: 19:32:25 EST -05:00 2020-11-27: cranky: [INFO] Creating the filesystem. 2020-11-27 18:32:34 (12764): Guest Log: 19:32:25 EST -05:00 2020-11-27: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-11-27 18:32:34 (12764): Guest Log: 19:32:25 EST -05:00 2020-11-27: cranky: [INFO] Updating config.json. 2020-11-27 18:32:34 (12764): Guest Log: 19:32:25 EST -05:00 2020-11-27: cranky: [INFO] Running Container 'runc'. 2020-11-27 18:32:36 (12764): Guest Log: job: htmld=/shared/html/job 2020-11-27 18:32:36 (12764): Guest Log: job: unpack exitcode=0 2020-11-27 18:32:38 (12764): Guest Log: 19:32:29 EST -05:00 2020-11-27: cranky: [INFO] ===> [runRivet] Sat Nov 28 00:32:27 UTC 2020 [boinc pp w1j 7000 100 - pythia6 6.425 p2010 100000 146] 2020-11-27 18:32:48 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 18:33:08 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 18:33:48 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 18:34:48 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 18:35:08 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 18:39:48 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 18:43:59 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 18:51:59 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 18:52:19 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 18:53:10 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 18:53:20 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 19:01:10 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 19:02:11 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 19:09:12 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 19:09:21 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 19:10:31 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 19:11:20 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 19:11:52 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 19:16:03 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 19:16:13 (12764): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-27 19:38:41 (12764): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-27 19:38:47 (12764): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_52d267b47bb094f0" resume Output: VBoxManage.exe: error: VM is paused due to host power management VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 409 of file VBoxManageControlVM.cpp 2020-11-27 19:38:47 (12764): Stopping VM. 2020-11-28 11:20:16 (13376): Detected: vboxwrapper 26197 2020-11-28 11:20:16 (13376): Detected: BOINC client v7.7 2020-11-28 11:20:26 (13376): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-11-28 11:20:27 (13376): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-11-28 11:20:28 (13376): Starting VM using VBoxManage interface. (boinc_52d267b47bb094f0, slot#2) 2020-11-28 11:20:51 (13376): Successfully started VM. (PID = '4316') 2020-11-28 11:20:51 (13376): Reporting VM Process ID to BOINC. 2020-11-28 11:20:51 (13376): Guest Log: 00:35:21.520304 timesync vgsvcTimeSyncWorker: Radical host time change: 56 527 192 000 000ns (HostNow=1 606 584 043 207 000 000 ns HostLast=1 606 527 516 015 000 000 ns) 2020-11-28 11:20:52 (13376): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-11-28 11:20:52 (13376): Detected: Web Application Enabled (http://localhost:61774) 2020-11-28 11:20:56 (13376): Guest Log: 00:35:31.558352 timesync vgsvcTimeSyncWorker: Radical guest time change: 57 059 324 314 000ns (GuestNow=1 606 584 053 290 112 000 ns GuestLast=1 606 526 993 965 798 000 ns fSetTimeLastLoop=true ) 2020-11-28 11:20:56 (13376): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 11:20:57 (13376): Preference change detected 2020-11-28 11:20:57 (13376): Setting CPU throttle for VM. (90%) 2020-11-28 11:20:58 (13376): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-11-28 11:20:58 (13376): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 11:21:07 (13376): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 11:22:05 (13376): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 11:25:46 (13376): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 11:26:06 (13376): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 11:40:40 (13376): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 11:40:40 (13376): Stopping VM. 2020-11-28 18:00:51 (18744): Detected: vboxwrapper 26197 2020-11-28 18:00:51 (18744): Detected: BOINC client v7.7 2020-11-28 18:00:52 (18744): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-11-28 18:00:52 (18744): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-11-28 18:00:55 (18744): ERROR: VM failed to start 2020-11-28 18:01:01 (18744): BOINC will be notified that it needs to clean up the environment. This is a temporary problem and so this job will be rescheduled for another time. 2020-11-28 18:01:02 (22312): Detected: vboxwrapper 26197 2020-11-28 18:01:02 (22312): Detected: BOINC client v7.7 2020-11-28 18:01:02 (22312): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-11-28 18:01:03 (22312): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-11-28 18:01:03 (22312): Starting VM using VBoxManage interface. (boinc_52d267b47bb094f0, slot#2) 2020-11-28 18:01:14 (22312): Successfully started VM. (PID = '12352') 2020-11-28 18:01:14 (22312): Reporting VM Process ID to BOINC. 2020-11-28 18:01:14 (22312): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-11-28 18:01:14 (22312): Detected: Web Application Enabled (http://localhost:61774) 2020-11-28 18:01:15 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:01:28 (22312): Preference change detected 2020-11-28 18:01:28 (22312): Setting CPU throttle for VM. (90%) 2020-11-28 18:01:28 (22312): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-11-28 18:01:29 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:01:30 (22312): Guest Log: 00:54:02.357145 timesync vgsvcTimeSyncWorker: Radical host time change: 22 856 965 000 000ns (HostNow=1 606 608 089 103 000 000 ns HostLast=1 606 585 232 138 000 000 ns) 2020-11-28 18:01:39 (22312): Guest Log: 00:54:12.375318 timesync vgsvcTimeSyncWorker: Radical guest time change: 22 935 032 263 000ns (GuestNow=1 606 608 099 121 178 000 ns GuestLast=1 606 585 164 088 915 000 ns fSetTimeLastLoop=true ) 2020-11-28 18:02:59 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:03:09 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:03:40 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:03:59 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:06:19 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:06:29 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:10:59 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:11:09 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:30:31 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:30:51 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:31:42 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:31:52 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:41:13 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:41:23 (22312): VM state change detected. (old = 'Paused', new = 'Running') 2020-11-28 18:44:14 (22312): VM state change detected. (old = 'Running', new = 'Paused') 2020-11-28 18:44:21 (22312): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_52d267b47bb094f0" resume Output: VBoxManage.exe: error: VM is paused due to host power management VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 409 of file VBoxManageControlVM.cpp 2020-11-28 18:44:21 (22312): Stopping VM. 2020-11-29 13:35:27 (5244): Detected: vboxwrapper 26197 2020-11-29 13:35:27 (5244): Detected: BOINC client v7.7 2020-11-29 13:35:55 (5244): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-11-29 13:35:56 (5244): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-11-29 13:35:57 (5244): ERROR: VM failed to start 2020-11-29 13:36:02 (5244): BOINC will be notified that it needs to clean up the environment. This is a temporary problem and so this job will be rescheduled for another time. 2020-12-08 22:04:44 (2508): Detected: vboxwrapper 26197 2020-12-08 22:04:44 (2508): Detected: BOINC client v7.7 2020-12-08 22:04:47 (2508): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-08 22:04:47 (2508): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-08 22:04:48 (2508): Starting VM using VBoxManage interface. (boinc_52d267b47bb094f0, slot#2) 2020-12-08 22:05:17 (2508): Successfully started VM. (PID = '21176') 2020-12-08 22:05:17 (2508): Reporting VM Process ID to BOINC. 2020-12-08 22:05:17 (2508): Guest Log: 01:35:24.076562 timesync vgsvcTimeSyncWorker: Radical host time change: 876 058 163 000 000ns (HostNow=1 607 486 705 396 000 000 ns HostLast=1 606 610 647 233 000 000 ns) 2020-12-08 22:05:17 (2508): Guest Log: 01:35:34.077077 timesync vgsvcTimeSyncWorker: Radical guest time change: 876 144 574 137 000ns (GuestNow=1 607 486 715 396 529 000 ns GuestLast=1 606 610 570 822 392 000 ns fSetTimeLastLoop=true ) 2020-12-08 22:05:17 (2508): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-08 22:05:17 (2508): Detected: Web Application Enabled (http://localhost:61774) 2020-12-08 22:26:31 (26104): Detected: vboxwrapper 26197 2020-12-08 22:26:31 (26104): Detected: BOINC client v7.7 2020-12-08 22:26:32 (26104): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-08 22:26:32 (26104): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-08 22:26:32 (26104): Starting VM using VBoxManage interface. (boinc_52d267b47bb094f0, slot#2) 2020-12-08 22:26:38 (26104): Successfully started VM. (PID = '15012') 2020-12-08 22:26:38 (26104): Reporting VM Process ID to BOINC. 2020-12-08 22:26:38 (26104): Guest Log: BIOS: VirtualBox 6.0.14 2020-12-08 22:26:38 (26104): Guest Log: CPUID EDX: 0x178bfbff 2020-12-08 22:26:38 (26104): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-12-08 22:26:38 (26104): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-08 22:26:38 (26104): Detected: Web Application Enabled (http://localhost:61774) 2020-12-08 22:26:39 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:26:50 (26104): Preference change detected 2020-12-08 22:26:50 (26104): Setting CPU throttle for VM. (90%) 2020-12-08 22:26:50 (26104): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-08 22:26:50 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:26:51 (26104): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-12-08 22:26:51 (26104): Guest Log: BIOS: Booting from Hard Disk... 2020-12-08 22:26:53 (26104): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-12-08 22:26:53 (26104): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-12-08 22:27:20 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:27:30 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:27:40 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:27:50 (26104): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-12-08 22:27:50 (26104): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-12-08 22:27:50 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:27:55 (26104): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.000426 main Log opened 2020-12-09T04:27:34.657726000Z 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.000689 main OS Product: Linux 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.000792 main OS Release: 4.14.76-13.cernvm.x86_64 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.000896 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.000991 main Executable: /usr/sbin/VBoxService 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.000993 main Process ID: 3198 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.000994 main Package type: LINUX_64BITS_GENERIC 2020-12-08 22:27:55 (26104): Guest Log: 00:00:00.005929 main 5.2.6 r120293 started. Verbose level = 0 2020-12-08 22:28:20 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:28:30 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:28:31 (26104): Guest Log: 23:28:01 EST -05:00 2020-12-08: cranky: [INFO] Detected Theory App 2020-12-08 22:28:31 (26104): Guest Log: 23:28:01 EST -05:00 2020-12-08: cranky: [INFO] Checking CVMFS. 2020-12-08 22:28:32 (26104): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-12-08 22:28:33 (26104): 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-12-08 22:28:33 (26104): Guest Log: 2.5.2.0 4097 0 25520 19346 3 1 1187433 4096000 0 65024 0 0 n/a 5 1 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-12-08 22:28:36 (26104): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-12-08 22:28:38 (26104): 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-12-08 22:28:38 (26104): Guest Log: 2.5.2.0 4055 0 25484 13897 3 2 1187433 4096000 0 65024 0 2 0 4274 1477 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-12-08 22:28:40 (26104): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-12-08 22:28:40 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:28:50 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:28:52 (26104): 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-12-08 22:28:52 (26104): Guest Log: 2.5.2.0 4030 0 27212 259 3 1 1187433 4096000 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-12-08 22:28:53 (26104): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-12-08 22:28:54 (26104): 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-12-08 22:28:54 (26104): Guest Log: 2.5.2.0 4075 0 31164 8152 3 1 1187433 4096000 0 65024 0 0 n/a 4631 1335 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-12-08 22:28:54 (26104): Guest Log: 23:28:14 EST -05:00 2020-12-08: cranky: [INFO] Checking runc. 2020-12-08 22:28:54 (26104): Guest Log: 23:28:14 EST -05:00 2020-12-08: cranky: [INFO] Creating the filesystem. 2020-12-08 22:28:54 (26104): Guest Log: 23:28:14 EST -05:00 2020-12-08: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-12-08 22:28:55 (26104): Guest Log: 23:28:15 EST -05:00 2020-12-08: cranky: [INFO] Updating config.json. 2020-12-08 22:28:55 (26104): Guest Log: 23:28:15 EST -05:00 2020-12-08: cranky: [INFO] Running Container 'runc'. 2020-12-08 22:28:55 (26104): Guest Log: job: htmld=/shared/html/job 2020-12-08 22:28:55 (26104): Guest Log: job: unpack exitcode=0 2020-12-08 22:28:57 (26104): Guest Log: 23:28:17 EST -05:00 2020-12-08: cranky: [INFO] ===> [runRivet] Wed Dec 9 04:28:15 UTC 2020 [boinc pp w1j 7000 100 - pythia6 6.425 p2010 100000 146] 2020-12-08 22:29:00 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:29:10 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:30:11 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:30:21 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:32:11 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:32:31 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:32:41 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:33:01 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:33:11 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:33:21 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:33:31 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:33:41 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:33:51 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:34:21 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:34:31 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:34:41 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:34:51 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:35:11 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:36:01 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:36:11 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:36:11 (26104): Status Report: Job Duration: '864000.000000' 2020-12-08 22:36:11 (26104): Status Report: Elapsed Time: '6000.400236' 2020-12-08 22:36:11 (26104): Status Report: CPU Time: '5284.046875' 2020-12-08 22:37:11 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:37:21 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:38:51 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:39:01 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:40:32 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:40:42 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:44:42 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:44:52 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:45:02 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:45:12 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:50:12 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:50:22 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:54:13 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:54:23 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:55:24 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:55:44 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 22:55:55 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 22:56:13 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 23:01:13 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 23:01:23 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 23:02:44 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 23:02:54 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 23:04:45 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 23:05:05 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 23:05:24 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 23:05:44 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 23:16:25 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 23:16:35 (26104): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-08 23:23:15 (26104): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-08 23:23:21 (26104): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_52d267b47bb094f0" resume Output: VBoxManage.exe: error: VM is paused due to host power management VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 409 of file VBoxManageControlVM.cpp 2020-12-08 23:23:21 (26104): Stopping VM. 2020-12-09 13:32:18 (27004): Detected: vboxwrapper 26197 2020-12-09 13:32:18 (27004): Detected: BOINC client v7.7 2020-12-09 13:32:21 (27004): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-09 13:32:21 (27004): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-09 13:32:22 (27004): Starting VM using VBoxManage interface. (boinc_52d267b47bb094f0, slot#2) 2020-12-09 13:32:33 (27004): Successfully started VM. (PID = '28308') 2020-12-09 13:32:33 (27004): Reporting VM Process ID to BOINC. 2020-12-09 13:32:33 (27004): Guest Log: 00:49:42.420436 timesync vgsvcTimeSyncWorker: Radical host time change: 50 968 644 000 000ns (HostNow=1 607 542 353 200 000 000 ns HostLast=1 607 491 384 556 000 000 ns) 2020-12-09 13:32:33 (27004): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-09 13:32:33 (27004): Detected: Web Application Enabled (http://localhost:61774) 2020-12-09 13:32:34 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:32:48 (27004): Status Report: Job Duration: '864000.000000' 2020-12-09 13:32:48 (27004): Status Report: Elapsed Time: '8599.107731' 2020-12-09 13:32:48 (27004): Status Report: CPU Time: '7638.500000' 2020-12-09 13:32:48 (27004): Preference change detected 2020-12-09 13:32:48 (27004): Setting CPU throttle for VM. (90%) 2020-12-09 13:32:49 (27004): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-09 13:32:49 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:32:57 (27004): Guest Log: 00:49:52.446500 timesync vgsvcTimeSyncWorker: Radical guest time change: 51 326 226 007 000ns (GuestNow=1 607 542 363 250 048 000 ns GuestLast=1 607 491 037 024 041 000 ns fSetTimeLastLoop=true ) 2020-12-09 13:33:07 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:33:17 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:34:17 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:34:37 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:35:15 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:36:28 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:36:57 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:37:07 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:37:17 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:37:47 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:37:58 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:38:18 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:38:37 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:38:47 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:39:48 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:39:58 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:40:18 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:40:28 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:40:47 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:40:57 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:41:17 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:41:27 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:42:08 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:42:18 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:42:28 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:42:38 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:43:48 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:43:58 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:44:08 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:44:18 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:44:38 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:44:48 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:45:08 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:45:18 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:45:29 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:45:39 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:46:09 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:46:18 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:46:38 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:46:48 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:47:08 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:47:18 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:47:28 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:47:38 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:47:49 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:48:09 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:48:29 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:48:39 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:48:58 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:49:09 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:49:18 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:49:28 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:49:48 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:49:58 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:50:29 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:50:39 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:50:49 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:50:59 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:51:08 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:51:19 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:51:39 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:51:49 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:52:19 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:52:29 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:52:59 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:53:09 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:53:29 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:53:40 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:54:09 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:54:20 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:54:49 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:54:59 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:55:49 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:55:59 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:56:40 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:56:50 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:57:20 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:57:30 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:58:50 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:59:00 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 13:59:20 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 13:59:40 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:00:00 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:00:10 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:00:20 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:00:30 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:00:39 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:00:50 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:01:10 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:01:20 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:01:40 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:01:50 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:02:00 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:02:10 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:02:20 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:02:30 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:02:40 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:02:50 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:03:00 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:03:10 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:03:30 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:03:40 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:04:01 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:04:11 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:04:30 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:04:40 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:05:10 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:05:20 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:05:50 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:06:00 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:06:31 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:06:41 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:07:00 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:07:10 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:07:20 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:07:30 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:08:11 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:08:21 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:08:41 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:08:51 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:09:01 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:09:11 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:09:40 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:09:50 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:10:11 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:10:21 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:10:31 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:10:41 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:10:51 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:11:01 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:11:21 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:11:31 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:11:41 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:11:52 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:12:01 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:12:11 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:12:31 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:12:41 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:13:11 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:13:21 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:13:32 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:13:42 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:14:02 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:14:12 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:14:22 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:14:31 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:14:51 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:15:01 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:15:11 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:15:21 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:15:31 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:15:41 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:15:51 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:16:01 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:16:11 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:16:21 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:16:41 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:17:31 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:17:53 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:18:12 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:18:22 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:18:32 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:19:12 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:19:22 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:19:42 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:19:52 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:20:12 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:20:22 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:20:42 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:20:52 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:21:02 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:21:12 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:21:42 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:21:52 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:23:03 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:23:13 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:23:33 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:23:43 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:23:52 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:24:02 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:24:42 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:24:52 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:25:13 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:25:23 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:25:53 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:26:03 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:26:13 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:26:23 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:26:43 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:27:02 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:27:23 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:27:33 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:27:53 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:28:03 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:28:33 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:28:43 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:28:53 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:29:03 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:29:13 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:29:23 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:29:53 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:30:03 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:30:13 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:30:23 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:30:43 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:30:53 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:31:03 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:31:13 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:31:23 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:31:33 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:31:43 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:31:53 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:32:13 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:32:33 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:32:43 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:33:23 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:33:33 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:33:54 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:34:04 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:34:24 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:34:34 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:34:44 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:34:54 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:35:04 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:35:24 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:35:44 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:36:13 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:36:23 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:36:33 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:36:43 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:37:04 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:37:14 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:37:24 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:37:34 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:37:44 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:37:54 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:38:24 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:38:34 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:38:44 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:38:54 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:39:14 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:39:24 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:39:34 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:39:44 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:39:54 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:40:04 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:40:25 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:40:35 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:40:45 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:40:55 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:41:05 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:41:25 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:41:34 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:41:44 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:42:14 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:42:24 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:42:34 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:42:44 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:42:54 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:43:05 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:43:25 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:43:35 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:43:45 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:43:55 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:44:45 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:44:55 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:45:05 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:45:15 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:45:35 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:45:45 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:46:15 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:46:25 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:46:35 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:46:45 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 14:53:16 (27004): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-09 14:53:26 (27004): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-09 15:08:59 (27004): Guest Log: job: run exitcode=0 2020-12-09 15:08:59 (27004): Guest Log: job: diskusage=2556 2020-12-09 15:08:59 (27004): Guest Log: job: logsize=72 k 2020-12-09 15:08:59 (27004): Guest Log: job: times= 2020-12-09 15:08:59 (27004): Guest Log: 0m0.010s 0m0.024s 2020-12-09 15:08:59 (27004): Guest Log: 113m41.133s 2m16.783s 2020-12-09 15:08:59 (27004): Guest Log: job: cpuusage=6958 2020-12-09 15:08:59 (27004): Guest Log: 16:01:42 EST -05:00 2020-12-09: cranky: [INFO] Container 'runc' finished with status code 0. 2020-12-09 15:08:59 (27004): Guest Log: 16:01:42 EST -05:00 2020-12-09: cranky: [INFO] Preparing output. 2020-12-09 15:09:00 (27004): Guest Log: [INFO] Job Finished 2020-12-09 15:09:00 (27004): Guest Log: [INFO] Shutting Down. 2020-12-09 15:09:00 (27004): VM Completion File Detected. 2020-12-09 15:09:00 (27004): VM Completion Message: Job Finished . 2020-12-09 15:09:00 (27004): Powering off VM. 2020-12-09 15:14:00 (27004): VM did not power off when requested. 2020-12-09 15:14:00 (27004): VM was successfully terminated. 2020-12-09 15:14:00 (27004): Deregistering VM. (boinc_52d267b47bb094f0, slot#2) 2020-12-09 15:14:01 (27004): Removing network bandwidth throttle group from VM. 2020-12-09 15:14:01 (27004): Removing VM from VirtualBox. 15:14:06 (27004): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN