| Name | Theory_2390-1123994-260_1 |
| Workunit | 189650392 |
| Created | 1 Jun 2022, 8:17:21 UTC |
| Sent | 1 Jun 2022, 16:15:53 UTC |
| Report deadline | 12 Jun 2022, 16:15:53 UTC |
| Received | 13 Jun 2022, 16:12:32 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10654154 |
| Run time | 1 days 1 hours 48 min 54 sec |
| CPU time | 1 days 1 hours 40 min 8 sec |
| Validate state | Valid |
| Credit | 841.90 |
| Device peak FLOPS | 3.91 GFLOPS |
| Application version | Theory Simulation v300.06 (vbox64_theory) windows_x86_64 |
| Peak working set size | 72.91 MB |
| Peak swap size | 76.05 MB |
| Peak disk usage | 2.70 GB |
Stderr output
<core_client_version>7.16.20</core_client_version> <![CDATA[ <stderr_txt> 2022-06-09 22:25:52 (19488): Detected: vboxwrapper 26197 2022-06-09 22:25:52 (19488): Detected: BOINC client v7.7 2022-06-09 22:25:52 (19488): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2022-06-09 22:25:53 (19488): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-06-09 22:25:53 (19488): Successfully copied 'init_data.xml' to the shared directory. 2022-06-09 22:25:53 (19488): Successfully copied 'input' to the shared directory. 2022-06-09 22:25:53 (19488): Create VM. (boinc_90f03cf5ab12d140, slot#13) 2022-06-09 22:25:54 (19488): Setting Memory Size for VM. (630MB) 2022-06-09 22:25:54 (19488): Setting CPU Count for VM. (1) 2022-06-09 22:25:54 (19488): Setting Chipset Options for VM. 2022-06-09 22:25:55 (19488): Setting Boot Options for VM. 2022-06-09 22:25:55 (19488): Setting Network Configuration for NAT. 2022-06-09 22:25:55 (19488): Enabling VM Network Access. 2022-06-09 22:25:55 (19488): Disabling USB Support for VM. 2022-06-09 22:25:56 (19488): Disabling COM Port Support for VM. 2022-06-09 22:25:56 (19488): Disabling LPT Port Support for VM. 2022-06-09 22:25:56 (19488): Disabling Audio Support for VM. 2022-06-09 22:25:57 (19488): Disabling Clipboard Support for VM. 2022-06-09 22:25:57 (19488): Disabling Drag and Drop Support for VM. 2022-06-09 22:25:57 (19488): Adding storage controller(s) to VM. 2022-06-09 22:25:58 (19488): Adding virtual disk drive to VM. (vm_image.vdi) 2022-06-09 22:25:58 (19488): Adding VirtualBox Guest Additions to VM. 2022-06-09 22:26:00 (19488): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2022-06-09 22:26:02 (19488): forwarding host port 55923 to guest port 80 2022-06-09 22:26:03 (19488): Enabling remote desktop for VM. 2022-06-09 22:26:04 (19488): Required extension pack not installed, remote desktop not enabled. 2022-06-09 22:26:04 (19488): Enabling shared directory for VM. 2022-06-09 22:26:05 (19488): Starting VM using VBoxManage interface. (boinc_90f03cf5ab12d140, slot#13) 2022-06-09 22:26:12 (19488): Successfully started VM. (PID = '7372') 2022-06-09 22:26:12 (19488): Reporting VM Process ID to BOINC. 2022-06-09 22:26:12 (19488): Guest Log: BIOS: VirtualBox 6.0.14 2022-06-09 22:26:12 (19488): Guest Log: CPUID EDX: 0x178bfbff 2022-06-09 22:26:12 (19488): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2022-06-09 22:26:12 (19488): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-06-09 22:26:12 (19488): Detected: Web Application Enabled (http://localhost:55923) 2022-06-09 22:26:12 (19488): Preference change detected 2022-06-09 22:26:12 (19488): Setting CPU throttle for VM. (100%) 2022-06-09 22:26:13 (19488): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds)) 2022-06-09 22:26:14 (19488): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-06-09 22:26:14 (19488): Guest Log: BIOS: Booting from Hard Disk... 2022-06-09 22:26:17 (19488): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-06-09 22:26:17 (19488): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-06-09 22:26:41 (19488): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-06-09 22:26:41 (19488): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-06-09 22:26:45 (19488): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.000222 main Log opened 2022-06-10T04:26:45.463698000Z 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.000394 main OS Product: Linux 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.000453 main OS Release: 4.14.76-13.cernvm.x86_64 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.000514 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.000595 main Executable: /usr/sbin/VBoxService 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.000597 main Process ID: 3191 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.000598 main Package type: LINUX_64BITS_GENERIC 2022-06-09 22:26:45 (19488): Guest Log: 00:00:00.007398 main 5.2.6 r120293 started. Verbose level = 0 2022-06-09 22:27:11 (19488): Guest Log: 22:27:10 MDT -06:00 2022-06-09: cranky: [INFO] Detected Theory App 2022-06-09 22:27:11 (19488): Guest Log: 22:27:10 MDT -06:00 2022-06-09: cranky: [INFO] Checking CVMFS. 2022-06-09 22:27:11 (19488): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-06-09 22:27:13 (19488): 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 2022-06-09 22:27:13 (19488): Guest Log: 2.5.2.0 4028 0 26116 23113 3 1 264856 4096000 0 65024 0 0 n/a 5 3 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-06-09 22:27:14 (19488): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-06-09 22:27:15 (19488): 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 2022-06-09 22:27:16 (19488): Guest Log: 2.5.2.0 4051 0 27372 18437 3 2 264856 4096000 0 65024 0 2 -100 7754 3802 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-06-09 22:27:16 (19488): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-06-09 22:27:17 (19488): 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 2022-06-09 22:27:17 (19488): Guest Log: 2.5.2.0 4093 0 25156 268 3 1 264856 4096000 0 65024 0 0 n/a 4 4 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-06-09 22:27:18 (19488): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-06-09 22:27:20 (19488): 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 2022-06-09 22:27:21 (19488): Guest Log: 2.5.2.0 4071 0 31456 12581 3 1 264856 4096000 0 65024 0 0 n/a 2788 1562 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-06-09 22:27:21 (19488): Guest Log: 22:27:19 MDT -06:00 2022-06-09: cranky: [INFO] Checking runc. 2022-06-09 22:27:21 (19488): Guest Log: 22:27:19 MDT -06:00 2022-06-09: cranky: [INFO] Creating the filesystem. 2022-06-09 22:27:21 (19488): Guest Log: 22:27:19 MDT -06:00 2022-06-09: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-06-09 22:27:21 (19488): Guest Log: 22:27:19 MDT -06:00 2022-06-09: cranky: [INFO] Updating config.json. 2022-06-09 22:27:21 (19488): Guest Log: 22:27:19 MDT -06:00 2022-06-09: cranky: [INFO] Running Container 'runc'. 2022-06-09 22:27:21 (19488): Guest Log: job: htmld=/shared/html/job 2022-06-09 22:27:21 (19488): Guest Log: job: unpack exitcode=0 2022-06-09 22:27:24 (19488): Guest Log: 22:27:23 MDT -06:00 2022-06-09: cranky: [INFO] ===> [runRivet] Fri Jun 10 04:27:22 UTC 2022 [boinc pp jets 7000 500 - pythia8 8.235 tune-4cx 100000 260] 2022-06-09 23:10:34 (19488): Stopping VM. 2022-06-10 20:10:49 (11320): Detected: vboxwrapper 26197 2022-06-10 20:10:49 (11320): Detected: BOINC client v7.7 2022-06-10 20:10:50 (11320): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2022-06-10 20:10:50 (11320): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-06-10 20:10:50 (11320): Starting VM using VBoxManage interface. (boinc_90f03cf5ab12d140, slot#13) 2022-06-10 20:11:07 (11320): Successfully started VM. (PID = '19648') 2022-06-10 20:11:07 (11320): Reporting VM Process ID to BOINC. 2022-06-10 20:11:07 (11320): Guest Log: 00:44:31.043128 timesync vgsvcTimeSyncWorker: Radical host time change: 75 600 202 000 000ns (HostNow=1 654 913 466 626 000 000 ns HostLast=1 654 837 866 424 000 000 ns) 2022-06-10 20:11:08 (11320): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-06-10 20:11:08 (11320): Detected: Web Application Enabled (http://localhost:55923) 2022-06-10 20:11:09 (11320): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-10 20:11:11 (11320): Preference change detected 2022-06-10 20:11:11 (11320): Setting CPU throttle for VM. (100%) 2022-06-10 20:11:12 (11320): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds)) 2022-06-10 20:11:12 (11320): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-10 20:11:13 (11320): Stopping VM. 2022-06-12 03:48:49 (16752): Detected: vboxwrapper 26197 2022-06-12 03:48:49 (16752): Detected: BOINC client v7.7 2022-06-12 03:48:50 (16752): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2022-06-12 03:48:50 (16752): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-06-12 03:48:50 (16752): Starting VM using VBoxManage interface. (boinc_90f03cf5ab12d140, slot#13) 2022-06-12 03:49:01 (16752): Successfully started VM. (PID = '15372') 2022-06-12 03:49:01 (16752): Reporting VM Process ID to BOINC. 2022-06-12 03:49:01 (16752): VM state change detected. (old = 'PoweredOff', new = 'Running') 2022-06-12 03:49:01 (16752): Detected: Web Application Enabled (http://localhost:55923) 2022-06-12 03:49:01 (16752): Preference change detected 2022-06-12 03:49:01 (16752): Setting CPU throttle for VM. (100%) 2022-06-12 03:49:02 (16752): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds)) 2022-06-12 03:49:02 (16752): Guest Log: 00:44:41.060777 timesync vgsvcTimeSyncWorker: Radical host time change: 113 876 079 000 000ns (HostNow=1 655 027 342 705 000 000 ns HostLast=1 654 913 466 626 000 000 ns) 2022-06-12 03:49:02 (16752): Guest Log: 00:44:41.061032 timesync vgsvcTimeSyncWorker: Radical guest time change: 75 600 232 258 000ns (GuestNow=1 654 913 476 658 624 000 ns GuestLast=1 654 837 876 426 366 000 ns fSetTimeLastLoop=true ) 2022-06-12 03:49:12 (16752): Guest Log: 00:44:51.067680 timesync vgsvcTimeSyncWorker: Radical guest time change: 113 876 053 295 000ns (GuestNow=1 655 027 352 711 919 000 ns GuestLast=1 654 913 476 658 624 000 ns fSetTimeLastLoop=true ) 2022-06-12 04:42:45 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 04:42:55 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 04:44:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 04:44:55 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 04:45:25 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 04:45:35 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 04:47:46 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 04:48:16 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 04:52:57 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 04:52:57 (16752): Status Report: Elapsed Time: '6000.803427' 2022-06-12 04:52:57 (16752): Status Report: CPU Time: '6209.031250' 2022-06-12 04:54:46 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 04:55:36 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 06:33:57 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 06:33:57 (16752): Status Report: Elapsed Time: '12001.803427' 2022-06-12 06:33:57 (16752): Status Report: CPU Time: '12201.875000' 2022-06-12 07:53:02 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 07:53:42 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 08:14:45 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 08:14:45 (16752): Status Report: Elapsed Time: '18001.803427' 2022-06-12 08:14:45 (16752): Status Report: CPU Time: '18197.171875' 2022-06-12 08:42:39 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 08:50:19 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 08:50:49 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 08:51:09 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 08:54:49 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 08:55:09 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 08:55:29 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 08:55:39 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 08:56:30 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 08:56:40 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:00:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:00:21 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:03:51 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:04:01 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:04:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:04:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:05:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:05:31 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:06:22 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:06:52 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:15:24 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:15:54 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:16:14 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:16:24 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:20:34 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:20:44 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:24:54 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:25:04 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:25:54 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:26:14 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:29:15 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:29:35 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:31:15 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:31:36 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:35:36 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:35:46 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:36:06 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:36:26 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:36:36 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:36:46 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 09:41:26 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 09:41:46 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 10:08:12 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 10:08:12 (16752): Status Report: Elapsed Time: '24001.803427' 2022-06-12 10:08:12 (16752): Status Report: CPU Time: '24227.312500' 2022-06-12 10:42:57 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 10:43:07 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 10:43:27 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 10:43:37 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 10:43:47 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:03:58 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:04:08 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:09:49 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:09:55 (16752): Guest Log: 07:23:59.096881 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 163 100 017 000ns (GuestNow=1 655 053 453 834 549 000 ns GuestLast=1 655 051 290 734 532 000 ns fSetTimeLastLoop=true ) 2022-06-12 11:09:59 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:11:09 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:11:39 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:11:49 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:14:50 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:15:10 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:15:30 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:16:00 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:18:50 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:19:10 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:21:00 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:21:20 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:22:00 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:22:10 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:22:20 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:22:40 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:25:10 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:25:20 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:26:10 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:26:21 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:28:01 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:28:11 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:29:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:29:31 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:29:41 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:29:51 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:35:32 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:35:42 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:35:52 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:36:02 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 11:39:42 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 11:39:52 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 12:19:41 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 12:19:41 (16752): Status Report: Elapsed Time: '30001.803427' 2022-06-12 12:19:41 (16752): Status Report: CPU Time: '30253.468750' 2022-06-12 13:18:26 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 13:18:36 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 13:28:27 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 13:28:37 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 13:31:08 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 13:31:18 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 13:39:59 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 13:40:09 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 14:00:30 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 14:00:30 (16752): Status Report: Elapsed Time: '36001.803427' 2022-06-12 14:00:30 (16752): Status Report: CPU Time: '36269.218750' 2022-06-12 14:42:39 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 14:46:19 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 14:46:29 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 14:50:31 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 14:52:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 14:52:31 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 14:55:01 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 14:55:21 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 14:55:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 14:55:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 14:55:51 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 14:56:01 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 14:56:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 14:56:21 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:04:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:04:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:05:21 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:05:42 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:05:52 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:06:02 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:08:03 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:08:13 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:09:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:09:46 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:15:45 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:16:15 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:24:56 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:25:06 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:25:36 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:25:46 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:26:06 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:26:26 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:27:37 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:27:57 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:28:07 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:28:17 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:28:27 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:28:47 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:29:07 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:29:17 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:29:57 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:30:17 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:33:37 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:33:47 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:35:37 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:35:47 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:36:27 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:36:47 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:40:38 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:40:48 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:41:58 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 15:42:18 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 15:54:34 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 15:54:34 (16752): Status Report: Elapsed Time: '42002.073622' 2022-06-12 15:54:34 (16752): Status Report: CPU Time: '42294.828125' 2022-06-12 16:42:38 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:42:48 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 16:43:38 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:43:48 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 16:44:19 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:45:49 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 16:47:13 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:47:19 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 16:48:29 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:48:49 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 16:52:33 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:52:39 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 16:55:33 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:55:39 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 16:58:54 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 16:59:10 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:00:20 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:00:30 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:02:00 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:02:10 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:04:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:04:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:06:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:06:21 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:09:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:09:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:09:51 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:10:01 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:10:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:11:21 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:11:41 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:11:52 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:12:01 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:13:02 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:13:42 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:13:52 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:15:32 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:15:42 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:17:12 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:17:22 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:19:32 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:19:52 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:20:32 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:34:34 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:34:43 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:39:44 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 17:40:14 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 17:42:45 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 18:03:50 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 18:03:50 (16752): Status Report: Elapsed Time: '48002.073622' 2022-06-12 18:03:50 (16752): Status Report: CPU Time: '48358.125000' 2022-06-12 18:42:43 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 18:45:13 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 18:45:23 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 18:52:03 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 18:52:13 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:04:05 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:04:15 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:09:45 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:10:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:11:05 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:11:15 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:11:25 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:11:55 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:12:15 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:13:05 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:13:25 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:15:05 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:18:46 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:19:06 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:19:16 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:19:46 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:19:56 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:20:16 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:20:26 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:23:37 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:23:57 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:24:37 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:24:46 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:25:47 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:25:57 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:33:17 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:33:27 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:33:57 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:34:17 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:35:27 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:35:37 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:38:19 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:38:29 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 19:39:49 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 19:39:59 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 20:17:56 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 20:17:56 (16752): Status Report: Elapsed Time: '54002.073622' 2022-06-12 20:17:57 (16752): Status Report: CPU Time: '54386.312500' 2022-06-12 20:42:47 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 20:57:08 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 20:57:28 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 20:57:49 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 20:57:59 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 20:58:09 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 20:58:19 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 20:58:29 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 20:58:49 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 20:59:59 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:00:09 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:03:59 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:04:09 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:12:00 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:12:10 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:12:30 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:12:50 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:23:12 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:23:22 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:25:22 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:26:12 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:26:32 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:27:02 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:41:03 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:41:53 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:42:13 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:42:23 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:42:43 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:53:24 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:53:44 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:55:14 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:55:34 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:55:44 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:55:54 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:56:54 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:57:04 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:58:29 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:58:45 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 21:59:05 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 21:59:15 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 22:02:05 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 22:02:15 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 22:04:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 22:04:45 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 22:06:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 22:06:55 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 22:08:46 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 22:09:06 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 22:42:44 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 22:50:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 22:50:51 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:03:32 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:03:52 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:09:03 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:09:13 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:16:14 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:18:48 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:18:54 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:19:04 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:31:25 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:31:45 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:31:56 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:33:16 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:41:16 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:41:26 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-12 23:42:36 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-12 23:51:27 (16752): Status Report: Job Duration: '864000.000000' 2022-06-12 23:51:27 (16752): Status Report: Elapsed Time: '60002.073622' 2022-06-12 23:51:27 (16752): Status Report: CPU Time: '60435.843750' 2022-06-13 00:42:41 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 00:42:51 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 00:43:21 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 00:43:31 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 00:44:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 00:44:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 01:08:54 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 01:09:24 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 01:10:14 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 01:10:24 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 01:32:47 (16752): Status Report: Job Duration: '864000.000000' 2022-06-13 01:32:47 (16752): Status Report: Elapsed Time: '66002.073622' 2022-06-13 01:32:47 (16752): Status Report: CPU Time: '66449.515625' 2022-06-13 01:35:29 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 01:35:39 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 01:37:19 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 01:37:59 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 01:38:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 01:38:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 01:39:41 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 01:39:51 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 02:42:52 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 02:52:20 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 02:52:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:10:12 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:10:22 (16752): Guest Log: 19:41:53.962571 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 842 586 306 000ns (GuestNow=1 655 111 421 948 250 000 ns GuestLast=1 655 109 579 361 944 000 ns fSetTimeLastLoop=true ) 2022-06-13 03:10:22 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:14:03 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:14:23 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:25:13 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:25:23 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:26:03 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:27:33 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:27:43 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:28:33 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:28:54 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:35:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:35:45 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:35:55 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:36:05 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:37:05 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:37:15 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:38:59 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:39:25 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:40:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 03:40:45 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 03:58:23 (16752): Status Report: Job Duration: '864000.000000' 2022-06-13 03:58:23 (16752): Status Report: Elapsed Time: '72002.073622' 2022-06-13 03:58:23 (16752): Status Report: CPU Time: '72478.062500' 2022-06-13 05:06:21 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 05:06:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 05:07:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 05:07:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 05:14:12 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 05:14:22 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 05:20:43 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 05:20:53 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 05:38:35 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 05:38:45 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 05:39:34 (16752): Status Report: Job Duration: '864000.000000' 2022-06-13 05:39:34 (16752): Status Report: Elapsed Time: '78002.073622' 2022-06-13 05:39:34 (16752): Status Report: CPU Time: '78494.812500' 2022-06-13 05:41:55 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 05:42:05 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 06:45:03 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 06:45:13 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 06:55:25 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 06:55:35 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 06:58:56 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 06:59:05 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 07:05:42 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 07:06:00 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 07:10:11 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 07:10:30 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 07:11:20 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 07:11:30 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 07:14:31 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 07:14:41 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 07:15:21 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 07:15:51 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 07:21:59 (16752): Status Report: Job Duration: '864000.000000' 2022-06-13 07:21:59 (16752): Status Report: Elapsed Time: '84002.073622' 2022-06-13 07:21:59 (16752): Status Report: CPU Time: '84511.531250' 2022-06-13 07:36:53 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 07:37:03 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 08:42:43 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 08:50:53 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 08:53:04 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 08:53:14 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 08:53:44 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 08:53:54 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 08:55:04 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 08:55:14 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 08:57:34 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 08:57:44 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 08:58:44 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 08:58:54 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 08:59:14 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 08:59:34 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:03:04 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:03:14 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:09:37 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:09:57 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:10:17 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:10:27 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:11:38 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:11:47 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:12:07 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:13:07 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:13:38 (16752): Status Report: Job Duration: '864000.000000' 2022-06-13 09:13:38 (16752): Status Report: Elapsed Time: '90002.583285' 2022-06-13 09:13:38 (16752): Status Report: CPU Time: '90531.328125' 2022-06-13 09:15:07 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:15:37 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:19:08 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:26:28 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 09:26:58 (16752): VM state change detected. (old = 'Running', new = 'Paused') 2022-06-13 09:41:10 (16752): VM state change detected. (old = 'Paused', new = 'Running') 2022-06-13 10:07:00 (16752): Guest Log: job: run exitcode=0 2022-06-13 10:07:00 (16752): Guest Log: job: diskusage=2756 2022-06-13 10:07:00 (16752): Guest Log: job: logsize=80 k 2022-06-13 10:07:00 (16752): Guest Log: job: times= 2022-06-13 10:07:00 (16752): Guest Log: 0m0.011s 0m0.020s 2022-06-13 10:07:00 (16752): Guest Log: 1520m25.461s 7m1.421s 2022-06-13 10:07:00 (16752): Guest Log: job: cpuusage=91647 2022-06-13 10:07:00 (16752): Guest Log: 10:06:59 MDT -06:00 2022-06-13: cranky: [INFO] Container 'runc' finished with status code 0. 2022-06-13 10:07:00 (16752): Guest Log: 10:06:59 MDT -06:00 2022-06-13: cranky: [INFO] Preparing output. 2022-06-13 10:07:03 (16752): Guest Log: [INFO] Job Finished 2022-06-13 10:07:03 (16752): Guest Log: [INFO] Shutting Down. 2022-06-13 10:07:03 (16752): VM Completion File Detected. 2022-06-13 10:07:03 (16752): VM Completion Message: Job Finished . 2022-06-13 10:07:03 (16752): Powering off VM. 2022-06-13 10:12:04 (16752): VM did not power off when requested. 2022-06-13 10:12:04 (16752): VM was successfully terminated. 2022-06-13 10:12:04 (16752): Deregistering VM. (boinc_90f03cf5ab12d140, slot#13) 2022-06-13 10:12:09 (16752): Removing network bandwidth throttle group from VM. 2022-06-13 10:12:09 (16752): Removing VM from VirtualBox. 10:12:14 (16752): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN