Name | Theory_2279-776344-155_0 |
Workunit | 1949545 |
Created | 6 Nov 2019, 14:45:07 UTC |
Sent | 7 Nov 2019, 20:14:20 UTC |
Report deadline | 17 Nov 2019, 20:14:20 UTC |
Received | 25 Nov 2019, 18:18:13 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 3626 |
Run time | 2 days 15 hours 34 min 40 sec |
CPU time | 2 days 12 hours 39 min 39 sec |
Validate state | Task was reported too late to validate |
Credit | 0.00 |
Device peak FLOPS | 3.03 GFLOPS |
Application version | Theory Simulation v5.18 (vbox64_theory) windows_x86_64 |
Peak working set size | 75.04 MB |
Peak swap size | 104.57 MB |
Peak disk usage | 1.22 GB |
<core_client_version>7.14.2</core_client_version> <![CDATA[ <stderr_txt> 2019-11-10 12:43:13 (5528): Detected: vboxwrapper 26197 2019-11-10 12:43:13 (5528): Detected: BOINC client v7.7 2019-11-10 12:43:14 (5528): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-10 12:43:14 (5528): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-10 12:43:14 (5528): Successfully copied 'init_data.xml' to the shared directory. 2019-11-10 12:43:15 (5528): Successfully copied 'input' to the shared directory. 2019-11-10 12:43:16 (5528): Create VM. (boinc_307a7f3efa5bfd67, slot#2) 2019-11-10 12:43:18 (5528): Setting Memory Size for VM. (630MB) 2019-11-10 12:43:19 (5528): Setting CPU Count for VM. (1) 2019-11-10 12:43:20 (5528): Setting Chipset Options for VM. 2019-11-10 12:43:21 (5528): Setting Boot Options for VM. 2019-11-10 12:43:21 (5528): Setting Network Configuration for NAT. 2019-11-10 12:43:22 (5528): Enabling VM Network Access. 2019-11-10 12:43:23 (5528): Disabling USB Support for VM. 2019-11-10 12:43:24 (5528): Disabling COM Port Support for VM. 2019-11-10 12:43:25 (5528): Disabling LPT Port Support for VM. 2019-11-10 12:43:26 (5528): Disabling Audio Support for VM. 2019-11-10 12:43:26 (5528): Disabling Clipboard Support for VM. 2019-11-10 12:43:28 (5528): Disabling Drag and Drop Support for VM. 2019-11-10 12:43:28 (5528): Adding storage controller(s) to VM. 2019-11-10 12:43:29 (5528): Adding virtual disk drive to VM. (vm_image.vdi) 2019-11-10 12:43:30 (5528): Adding VirtualBox Guest Additions to VM. 2019-11-10 12:43:31 (5528): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-11-10 12:43:31 (5528): forwarding host port 60800 to guest port 80 2019-11-10 12:43:32 (5528): Enabling remote desktop for VM. 2019-11-10 12:43:33 (5528): Enabling shared directory for VM. 2019-11-10 12:43:34 (5528): Starting VM using VBoxManage interface. (boinc_307a7f3efa5bfd67, slot#2) 2019-11-10 12:43:44 (5528): Successfully started VM. (PID = '9900') 2019-11-10 12:43:44 (5528): Reporting VM Process ID to BOINC. 2019-11-10 12:43:44 (5528): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-10 12:43:44 (5528): Guest Log: CPUID EDX: 0x078bfbff 2019-11-10 12:43:44 (5528): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-10 12:43:44 (5528): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-10 12:43:44 (5528): Detected: Web Application Enabled (http://localhost:60800) 2019-11-10 12:43:44 (5528): Detected: Remote Desktop Enabled (localhost:60801) 2019-11-10 12:43:44 (5528): Preference change detected 2019-11-10 12:43:44 (5528): Setting CPU throttle for VM. (100%) 2019-11-10 12:43:45 (5528): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-10 12:43:46 (5528): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-10 12:43:46 (5528): Guest Log: BIOS: Booting from Hard Disk... 2019-11-10 12:43:50 (5528): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-10 12:43:50 (5528): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-10 12:44:20 (5528): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-10 12:44:20 (5528): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-10 12:44:28 (5528): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000452 main Log opened 2019-11-10T11:44:29.823404000Z 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000659 main OS Product: Linux 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000747 main OS Release: 4.14.76-13.cernvm.x86_64 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000865 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000947 main Executable: /usr/sbin/VBoxService 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000950 main Process ID: 3206 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.000952 main Package type: LINUX_64BITS_GENERIC 2019-11-10 12:44:28 (5528): Guest Log: 00:00:00.009772 main 5.2.6 r120293 started. Verbose level = 0 2019-11-10 12:45:09 (5528): Guest Log: 12:45:11 CET +01:00 2019-11-10: cranky: [INFO] Detected Theory App 2019-11-10 12:45:09 (5528): Guest Log: 12:45:11 CET +01:00 2019-11-10: cranky: [INFO] Checking CVMFS. 2019-11-10 12:45:30 (5528): Guest Log: 12:45:31 CET +01:00 2019-11-10: cranky: [INFO] Checking runc. 2019-11-10 12:45:30 (5528): Guest Log: 12:45:31 CET +01:00 2019-11-10: cranky: [INFO] Creating the filesystem. 2019-11-10 12:45:30 (5528): Guest Log: 12:45:31 CET +01:00 2019-11-10: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2019-11-10 12:45:30 (5528): Guest Log: 12:45:32 CET +01:00 2019-11-10: cranky: [INFO] Updating config.json. 2019-11-10 12:45:30 (5528): Guest Log: 12:45:32 CET +01:00 2019-11-10: cranky: [INFO] Running Container 'runc'. 2019-11-10 12:45:33 (5528): Guest Log: 12:45:34 CET +01:00 2019-11-10: cranky: [INFO] ===> [runRivet] Sun Nov 10 11:45:33 UTC 2019 [boinc pp jets 7000 25,-,480 - pythia8 8.235 tune-A2 100000 155] 2019-11-10 14:53:58 (5528): Status Report: Job Duration: '864000.000000' 2019-11-10 14:53:58 (5528): Status Report: Elapsed Time: '6000.097343' 2019-11-10 14:53:58 (5528): Status Report: CPU Time: '7294.484375' 2019-11-10 16:43:52 (5528): Status Report: Job Duration: '864000.000000' 2019-11-10 16:43:52 (5528): Status Report: Elapsed Time: '12003.486061' 2019-11-10 16:43:52 (5528): Status Report: CPU Time: '13295.703125' 2019-11-10 18:30:52 (5528): Status Report: Job Duration: '864000.000000' 2019-11-10 18:30:52 (5528): Status Report: Elapsed Time: '18003.788134' 2019-11-10 18:30:52 (5528): Status Report: CPU Time: '18269.625000' 2019-11-10 20:18:33 (5528): Status Report: Job Duration: '864000.000000' 2019-11-10 20:18:33 (5528): Status Report: Elapsed Time: '24003.814358' 2019-11-10 20:18:33 (5528): Status Report: CPU Time: '22742.906250' 2019-11-10 22:05:48 (5528): Status Report: Job Duration: '864000.000000' 2019-11-10 22:05:48 (5528): Status Report: Elapsed Time: '30004.060652' 2019-11-10 22:05:48 (5528): Status Report: CPU Time: '27319.109375' 2019-11-10 22:05:50 (5528): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-11 19:32:23 (5528): Error in resume VM for VM: -182 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: 2019-11-11 19:32:24 (5528): Guest Log: 09:21:27.418264 timesync vgsvcTimeSyncWorker: Radical host time change: 77 103 357 000 000ns (HostNow=1 573 497 050 450 000 000 ns HostLast=1 573 419 947 093 000 000 ns) 2019-11-11 19:32:24 (5528): Guest Log: 09:21:37.513325 timesync vgsvcTimeSyncWorker: Radical guest time change: 77 103 507 036 000ns (GuestNow=1 573 497 060 598 568 000 ns GuestLast=1 573 419 957 091 532 000 ns fSetTimeLastLoop=true ) 2019-11-11 19:32:28 (5528): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-11 21:19:50 (5528): Status Report: Job Duration: '864000.000000' 2019-11-11 21:19:50 (5528): Status Report: Elapsed Time: '36004.679388' 2019-11-11 21:19:50 (5528): Status Report: CPU Time: '32355.515625' 2019-11-11 23:06:49 (5528): Status Report: Job Duration: '864000.000000' 2019-11-11 23:06:49 (5528): Status Report: Elapsed Time: '42005.202383' 2019-11-11 23:06:49 (5528): Status Report: CPU Time: '38548.578125' 2019-11-11 23:36:28 (5528): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-12 19:56:23 (5528): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-12 19:56:24 (5528): Guest Log: 13:27:08.305840 timesync vgsvcTimeSyncWorker: Radical host time change: 73 043 565 000 000ns (HostNow=1 573 584 822 216 000 000 ns HostLast=1 573 511 778 651 000 000 ns) 2019-11-12 19:56:24 (5528): Guest Log: 13:27:18.315277 timesync vgsvcTimeSyncWorker: Radical guest time change: 73 040 834 400 000ns (GuestNow=1 573 584 832 225 451 000 ns GuestLast=1 573 511 791 391 051 000 ns fSetTimeLastLoop=true ) 2019-11-12 19:56:24 (5528): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-12 21:15:56 (5528): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-13 01:04:16 (5528): Error in resume VM for VM: -182 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: 2019-11-13 01:04:17 (5528): Guest Log: 14:49:30.411670 timesync vgsvcTimeSyncWorker: Radical host time change: 13 547 911 000 000ns (HostNow=1 573 603 302 225 000 000 ns HostLast=1 573 589 754 314 000 000 ns) 2019-11-13 01:04:17 (5528): Guest Log: 14:49:40.426860 timesync vgsvcTimeSyncWorker: Radical guest time change: 13 547 918 499 000ns (GuestNow=1 573 603 312 240 263 000 ns GuestLast=1 573 589 764 321 764 000 ns fSetTimeLastLoop=true ) 2019-11-13 01:04:22 (5528): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-13 01:05:26 (5528): Status Report: Job Duration: '864000.000000' 2019-11-13 01:05:26 (5528): Status Report: Elapsed Time: '48005.692606' 2019-11-13 01:05:26 (5528): Status Report: CPU Time: '45026.828125' 2019-11-13 02:55:02 (5528): Status Report: Job Duration: '864000.000000' 2019-11-13 02:55:02 (5528): Status Report: Elapsed Time: '54006.390093' 2019-11-13 02:55:02 (5528): Status Report: CPU Time: '51289.484375' 2019-11-13 04:36:35 (5528): Status Report: Job Duration: '864000.000000' 2019-11-13 04:36:35 (5528): Status Report: Elapsed Time: '60007.072369' 2019-11-13 04:36:35 (5528): Status Report: CPU Time: '57311.437500' 2019-11-13 04:44:44 (5528): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-13 07:38:57 (5528): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-13 07:38:57 (5528): Guest Log: 18:32:37.034048 timesync vgsvcTimeSyncWorker: Radical host time change: 10 440 219 000 000ns (HostNow=1 573 627 119 058 000 000 ns HostLast=1 573 616 678 839 000 000 ns) 2019-11-13 07:38:57 (5528): Guest Log: 18:32:47.044392 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 440 220 961 000ns (GuestNow=1 573 627 129 068 371 000 ns GuestLast=1 573 616 688 847 410 000 ns fSetTimeLastLoop=true ) 2019-11-13 07:38:57 (5528): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-13 09:24:55 (5528): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-13 09:31:56 (5528): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-13 09:31:56 (5528): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-13 09:32:17 (5528): Stopping VM. 2019-11-13 09:32:17 (5528): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" savestate Output: 2019-11-13 09:32:17 (5528): VM did not stop when requested. 2019-11-13 09:32:17 (5528): VM was successfully terminated. 2019-11-16 18:29:57 (5796): Detected: vboxwrapper 26197 2019-11-16 18:29:57 (5796): Detected: BOINC client v7.7 2019-11-16 18:29:59 (5796): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-16 18:29:59 (5796): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-16 18:30:00 (5796): Starting VM using VBoxManage interface. (boinc_307a7f3efa5bfd67, slot#2) 2019-11-16 18:30:09 (5796): Successfully started VM. (PID = '9224') 2019-11-16 18:30:09 (5796): Reporting VM Process ID to BOINC. 2019-11-16 18:30:09 (5796): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-16 18:30:09 (5796): Guest Log: CPUID EDX: 0x078bfbff 2019-11-16 18:30:09 (5796): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-16 18:30:09 (5796): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-16 18:30:09 (5796): Detected: Web Application Enabled (http://localhost:60800) 2019-11-16 18:30:09 (5796): Detected: Remote Desktop Enabled (localhost:60801) 2019-11-16 18:30:09 (5796): Status Report: Job Duration: '864000.000000' 2019-11-16 18:30:09 (5796): Status Report: Elapsed Time: '65406.970470' 2019-11-16 18:30:09 (5796): Status Report: CPU Time: '63865.937500' 2019-11-16 18:30:09 (5796): Preference change detected 2019-11-16 18:30:09 (5796): Setting CPU throttle for VM. (100%) 2019-11-16 18:30:09 (5796): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-16 18:30:11 (5796): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-16 18:30:11 (5796): Guest Log: BIOS: Booting from Hard Disk... 2019-11-16 18:30:14 (5796): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-16 18:30:14 (5796): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-16 18:30:51 (5796): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-16 18:30:51 (5796): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-16 18:30:58 (5796): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000312 main Log opened 2019-11-16T17:30:58.774753000Z 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000617 main OS Product: Linux 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000699 main OS Release: 4.14.76-13.cernvm.x86_64 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000806 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000890 main Executable: /usr/sbin/VBoxService 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000894 main Process ID: 3210 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.000896 main Package type: LINUX_64BITS_GENERIC 2019-11-16 18:30:58 (5796): Guest Log: 00:00:00.010528 main 5.2.6 r120293 started. Verbose level = 0 2019-11-16 18:31:42 (5796): Guest Log: 18:31:43 CET +01:00 2019-11-16: cranky: [INFO] Detected Theory App 2019-11-16 18:31:42 (5796): Guest Log: 18:31:43 CET +01:00 2019-11-16: cranky: [INFO] Checking CVMFS. 2019-11-16 18:32:08 (5796): Guest Log: 18:32:08 CET +01:00 2019-11-16: cranky: [INFO] Checking runc. 2019-11-16 18:32:08 (5796): Guest Log: 18:32:08 CET +01:00 2019-11-16: cranky: [INFO] Creating the filesystem. 2019-11-16 18:32:09 (5796): Guest Log: 18:32:09 CET +01:00 2019-11-16: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2019-11-16 18:32:09 (5796): Guest Log: 18:32:09 CET +01:00 2019-11-16: cranky: [INFO] Updating config.json. 2019-11-16 18:32:09 (5796): Guest Log: 18:32:09 CET +01:00 2019-11-16: cranky: [INFO] Running Container 'runc'. 2019-11-16 18:32:11 (5796): Guest Log: 18:32:11 CET +01:00 2019-11-16: cranky: [INFO] ===> [runRivet] Sat Nov 16 17:32:11 UTC 2019 [boinc pp jets 7000 25,-,480 - pythia8 8.235 tune-A2 100000 155] 2019-11-16 20:10:53 (5796): Status Report: Job Duration: '864000.000000' 2019-11-16 20:10:53 (5796): Status Report: Elapsed Time: '71406.970470' 2019-11-16 20:10:53 (5796): Status Report: CPU Time: '69864.593750' 2019-11-16 21:55:14 (5796): Status Report: Job Duration: '864000.000000' 2019-11-16 21:55:14 (5796): Status Report: Elapsed Time: '77407.245916' 2019-11-16 21:55:14 (5796): Status Report: CPU Time: '76074.312500' 2019-11-16 23:37:27 (5796): Status Report: Job Duration: '864000.000000' 2019-11-16 23:37:27 (5796): Status Report: Elapsed Time: '83407.945638' 2019-11-16 23:37:27 (5796): Status Report: CPU Time: '82173.062500' 2019-11-16 23:59:51 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-17 13:09:14 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-17 13:09:14 (5796): Guest Log: 05:28:57.919989 timesync vgsvcTimeSyncWorker: Radical host time change: 47 358 160 000 000ns (HostNow=1 573 992 544 788 000 000 ns HostLast=1 573 945 186 628 000 000 ns) 2019-11-17 13:09:14 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-17 13:09:15 (5796): Guest Log: 05:29:07.954268 timesync vgsvcTimeSyncWorker: Radical guest time change: 47 358 204 239 000ns (GuestNow=1 573 992 554 833 184 000 ns GuestLast=1 573 945 196 628 945 000 ns fSetTimeLastLoop=true ) 2019-11-17 14:27:51 (5796): Status Report: Job Duration: '864000.000000' 2019-11-17 14:27:51 (5796): Status Report: Elapsed Time: '89407.945638' 2019-11-17 14:27:51 (5796): Status Report: CPU Time: '88221.687500' 2019-11-17 16:08:38 (5796): Status Report: Job Duration: '864000.000000' 2019-11-17 16:08:38 (5796): Status Report: Elapsed Time: '95407.945638' 2019-11-17 16:08:38 (5796): Status Report: CPU Time: '94249.640625' 2019-11-17 17:49:26 (5796): Status Report: Job Duration: '864000.000000' 2019-11-17 17:49:26 (5796): Status Report: Elapsed Time: '101407.945638' 2019-11-17 17:49:26 (5796): Status Report: CPU Time: '100286.281250' 2019-11-17 19:30:39 (5796): Status Report: Job Duration: '864000.000000' 2019-11-17 19:30:39 (5796): Status Report: Elapsed Time: '107407.945638' 2019-11-17 19:30:39 (5796): Status Report: CPU Time: '106333.765625' 2019-11-17 21:14:07 (5796): Status Report: Job Duration: '864000.000000' 2019-11-17 21:14:07 (5796): Status Report: Elapsed Time: '113408.446462' 2019-11-17 21:14:07 (5796): Status Report: CPU Time: '112483.093750' 2019-11-17 22:01:11 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-19 19:39:07 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-19 19:39:08 (5796): Guest Log: 14:21:12.503610 timesync vgsvcTimeSyncWorker: Radical host time change: 164 266 438 000 000ns (HostNow=1 574 188 734 017 000 000 ns HostLast=1 574 024 467 579 000 000 ns) 2019-11-19 19:39:08 (5796): Guest Log: 14:21:22.510574 timesync vgsvcTimeSyncWorker: Radical guest time change: 164 264 696 370 000ns (GuestNow=1 574 188 744 051 333 000 ns GuestLast=1 574 024 479 354 963 000 ns fSetTimeLastLoop=true ) 2019-11-19 19:39:08 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-19 20:36:28 (5796): Status Report: Job Duration: '864000.000000' 2019-11-19 20:36:28 (5796): Status Report: Elapsed Time: '119409.147274' 2019-11-19 20:36:28 (5796): Status Report: CPU Time: '118689.375000' 2019-11-19 22:21:09 (5796): Status Report: Job Duration: '864000.000000' 2019-11-19 22:21:09 (5796): Status Report: Elapsed Time: '125409.263151' 2019-11-19 22:21:09 (5796): Status Report: CPU Time: '124861.203125' 2019-11-19 23:14:53 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-20 19:34:01 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-20 19:34:02 (5796): Guest Log: 17:57:19.873912 timesync vgsvcTimeSyncWorker: Radical host time change: 73 139 352 000 000ns (HostNow=1 574 274 828 383 000 000 ns HostLast=1 574 201 689 031 000 000 ns) 2019-11-20 19:34:02 (5796): Guest Log: 17:57:29.876161 timesync vgsvcTimeSyncWorker: Radical guest time change: 73 136 970 432 000ns (GuestNow=1 574 274 838 385 265 000 ns GuestLast=1 574 201 701 414 833 000 ns fSetTimeLastLoop=true ) 2019-11-20 19:34:02 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-20 20:25:19 (5796): Status Report: Job Duration: '864000.000000' 2019-11-20 20:25:19 (5796): Status Report: Elapsed Time: '131410.195886' 2019-11-20 20:25:19 (5796): Status Report: CPU Time: '131059.468750' 2019-11-20 21:52:39 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-21 17:54:37 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-21 17:54:38 (5796): Guest Log: 20:16:13.769655 timesync vgsvcTimeSyncWorker: Radical host time change: 72 113 121 000 000ns (HostNow=1 574 355 264 697 000 000 ns HostLast=1 574 283 151 576 000 000 ns) 2019-11-21 17:54:38 (5796): Guest Log: 20:16:23.771044 timesync vgsvcTimeSyncWorker: Radical guest time change: 72 112 419 675 000ns (GuestNow=1 574 355 274 698 406 000 ns GuestLast=1 574 283 162 278 731 000 ns fSetTimeLastLoop=true ) 2019-11-21 17:54:38 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-21 18:10:32 (5796): Status Report: Job Duration: '864000.000000' 2019-11-21 18:10:32 (5796): Status Report: Elapsed Time: '137410.766723' 2019-11-21 18:10:32 (5796): Status Report: CPU Time: '137226.125000' 2019-11-21 19:52:08 (5796): Status Report: Job Duration: '864000.000000' 2019-11-21 19:52:08 (5796): Status Report: Elapsed Time: '143410.766723' 2019-11-21 19:52:08 (5796): Status Report: CPU Time: '143289.078125' 2019-11-21 21:32:56 (5796): Status Report: Job Duration: '864000.000000' 2019-11-21 21:32:56 (5796): Status Report: Elapsed Time: '149410.766723' 2019-11-21 21:32:56 (5796): Status Report: CPU Time: '149313.468750' 2019-11-21 23:13:44 (5796): Status Report: Job Duration: '864000.000000' 2019-11-21 23:13:44 (5796): Status Report: Elapsed Time: '155410.766723' 2019-11-21 23:13:44 (5796): Status Report: CPU Time: '155320.296875' 2019-11-21 23:20:36 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-22 18:31:44 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-22 18:31:45 (5796): Guest Log: 25:42:33.559903 timesync vgsvcTimeSyncWorker: Radical host time change: 69 066 431 000 000ns (HostNow=1 574 443 900 914 000 000 ns HostLast=1 574 374 834 483 000 000 ns) 2019-11-22 18:31:45 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-22 18:31:51 (5796): Guest Log: 25:42:43.569707 timesync vgsvcTimeSyncWorker: Radical guest time change: 69 066 436 587 000ns (GuestNow=1 574 443 910 923 822 000 ns GuestLast=1 574 374 844 487 235 000 ns fSetTimeLastLoop=true ) 2019-11-22 20:05:56 (5796): Status Report: Job Duration: '864000.000000' 2019-11-22 20:05:56 (5796): Status Report: Elapsed Time: '161410.766723' 2019-11-22 20:05:56 (5796): Status Report: CPU Time: '161343.796875' 2019-11-22 21:46:43 (5796): Status Report: Job Duration: '864000.000000' 2019-11-22 21:46:43 (5796): Status Report: Elapsed Time: '167410.766723' 2019-11-22 21:46:43 (5796): Status Report: CPU Time: '167339.484375' 2019-11-22 22:00:37 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-23 14:28:06 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-23 14:28:07 (5796): Guest Log: 29:11:32.740148 timesync vgsvcTimeSyncWorker: Radical host time change: 59 253 453 000 000ns (HostNow=1 574 515 680 352 000 000 ns HostLast=1 574 456 426 899 000 000 ns) 2019-11-23 14:28:07 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-23 14:28:10 (5796): Guest Log: 29:11:42.746382 timesync vgsvcTimeSyncWorker: Radical guest time change: 59 250 264 024 000ns (GuestNow=1 574 515 690 358 254 000 ns GuestLast=1 574 456 440 094 230 000 ns fSetTimeLastLoop=true ) 2019-11-23 15:55:09 (5796): Status Report: Job Duration: '864000.000000' 2019-11-23 15:55:09 (5796): Status Report: Elapsed Time: '173410.766723' 2019-11-23 15:55:09 (5796): Status Report: CPU Time: '173352.656250' 2019-11-23 17:42:59 (5796): Status Report: Job Duration: '864000.000000' 2019-11-23 17:42:59 (5796): Status Report: Elapsed Time: '179411.328773' 2019-11-23 17:42:59 (5796): Status Report: CPU Time: '179645.671875' 2019-11-23 19:42:01 (5796): Status Report: Job Duration: '864000.000000' 2019-11-23 19:42:01 (5796): Status Report: Elapsed Time: '185411.356023' 2019-11-23 19:42:01 (5796): Status Report: CPU Time: '186475.390625' 2019-11-23 21:43:54 (5796): Status Report: Job Duration: '864000.000000' 2019-11-23 21:43:54 (5796): Status Report: Elapsed Time: '191412.670034' 2019-11-23 21:43:54 (5796): Status Report: CPU Time: '193406.281250' 2019-11-23 21:48:01 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-24 16:16:10 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-24 16:16:11 (5796): Guest Log: 36:31:37.613452 timesync vgsvcTimeSyncWorker: Radical host time change: 66 478 696 000 000ns (HostNow=1 574 608 550 724 000 000 ns HostLast=1 574 542 072 028 000 000 ns) 2019-11-24 16:16:11 (5796): Guest Log: 36:31:47.618498 timesync vgsvcTimeSyncWorker: Radical guest time change: 66 475 503 777 000ns (GuestNow=1 574 608 560 729 064 000 ns GuestLast=1 574 542 085 225 287 000 ns fSetTimeLastLoop=true ) 2019-11-24 16:16:11 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-24 17:54:45 (5796): Status Report: Job Duration: '864000.000000' 2019-11-24 17:54:45 (5796): Status Report: Elapsed Time: '197413.518005' 2019-11-24 17:54:45 (5796): Status Report: CPU Time: '199529.062500' 2019-11-24 19:36:21 (5796): Status Report: Job Duration: '864000.000000' 2019-11-24 19:36:21 (5796): Status Report: Elapsed Time: '203413.518005' 2019-11-24 19:36:21 (5796): Status Report: CPU Time: '205582.812500' 2019-11-24 21:17:37 (5796): Status Report: Job Duration: '864000.000000' 2019-11-24 21:17:37 (5796): Status Report: Elapsed Time: '209413.518005' 2019-11-24 21:17:37 (5796): Status Report: CPU Time: '211629.531250' 2019-11-24 21:58:38 (5796): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-25 18:00:49 (5796): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307a7f3efa5bfd67" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2019-11-25 18:00:50 (5796): Guest Log: 42:14:27.749640 timesync vgsvcTimeSyncWorker: Radical host time change: 72 129 215 000 000ns (HostNow=1 574 701 238 112 000 000 ns HostLast=1 574 629 108 897 000 000 ns) 2019-11-25 18:00:50 (5796): Guest Log: 42:14:37.750794 timesync vgsvcTimeSyncWorker: Radical guest time change: 72 127 799 832 000ns (GuestNow=1 574 701 248 386 590 000 ns GuestLast=1 574 629 120 586 758 000 ns fSetTimeLastLoop=true ) 2019-11-25 18:00:50 (5796): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-25 19:01:15 (5796): Status Report: Job Duration: '864000.000000' 2019-11-25 19:01:15 (5796): Status Report: Elapsed Time: '215413.518005' 2019-11-25 19:01:15 (5796): Status Report: CPU Time: '217701.781250' 2019-11-25 19:12:44 (5796): Guest Log: 19:12:43 CET +01:00 2019-11-25: cranky: [INFO] Container 'runc' finished with status code 0. 2019-11-25 19:12:44 (5796): Guest Log: 19:12:43 CET +01:00 2019-11-25: cranky: [INFO] Preparing output. 2019-11-25 19:12:47 (5796): Guest Log: [INFO] Job Finished 2019-11-25 19:12:47 (5796): Guest Log: [INFO] Shutting Down. 2019-11-25 19:12:47 (5796): VM Completion File Detected. 2019-11-25 19:12:47 (5796): VM Completion Message: Job Finished . 2019-11-25 19:12:47 (5796): Powering off VM. 2019-11-25 19:17:48 (5796): VM did not power off when requested. 2019-11-25 19:17:48 (5796): VM was successfully terminated. 2019-11-25 19:17:48 (5796): Deregistering VM. (boinc_307a7f3efa5bfd67, slot#2) 2019-11-25 19:17:48 (5796): Removing network bandwidth throttle group from VM. 2019-11-25 19:17:48 (5796): Removing VM from VirtualBox. 19:17:54 (5796): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN