| Name | Theory_2390-1150160-286_0 |
| Workunit | 2203386 |
| Created | 10 Aug 2022, 17:00:11 UTC |
| Sent | 14 Aug 2022, 9:32:17 UTC |
| Report deadline | 24 Aug 2022, 9:32:17 UTC |
| Received | 24 Aug 2022, 12:59:28 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 0 (0x00000000) |
| Computer ID | 4604 |
| Run time | 10 days 0 hours 21 min 8 sec |
| CPU time | 2 hours 33 min 22 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 3.45 GFLOPS |
| Application version | Theory Simulation v5.40 (vbox64_theory) windows_x86_64 |
| Peak working set size | 84.54 MB |
| Peak swap size | 101.55 MB |
| Peak disk usage | 289.99 MB |
Stderr output
<core_client_version>7.20.2</core_client_version> <![CDATA[ <stderr_txt> 2022-08-14 11:32:25 (4000): Detected: vboxwrapper 26205 2022-08-14 11:32:25 (4000): Detected: BOINC client v7.20.2 2022-08-14 11:32:26 (4000): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2022-08-14 11:32:26 (4000): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-08-14 11:32:26 (4000): Successfully copied 'init_data.xml' to the shared directory. 2022-08-14 11:32:26 (4000): Successfully copied 'input' to the shared directory. 2022-08-14 11:32:27 (4000): Create VM. (boinc_308432694410c795, slot#3) 2022-08-14 11:32:27 (4000): Setting Memory Size for VM. (630MB) 2022-08-14 11:32:27 (4000): Setting CPU Count for VM. (1) 2022-08-14 11:32:28 (4000): Setting Chipset Options for VM. 2022-08-14 11:32:28 (4000): Setting Graphics Controller Options for VM. 2022-08-14 11:32:28 (4000): Setting Boot Options for VM. 2022-08-14 11:32:28 (4000): Setting Network Configuration for NAT. 2022-08-14 11:32:29 (4000): Enabling VM Network Access. 2022-08-14 11:32:29 (4000): Disabling USB Support for VM. 2022-08-14 11:32:29 (4000): Disabling COM Port Support for VM. 2022-08-14 11:32:30 (4000): Disabling LPT Port Support for VM. 2022-08-14 11:32:30 (4000): Disabling Audio Support for VM. 2022-08-14 11:32:30 (4000): Disabling Clipboard Support for VM. 2022-08-14 11:32:30 (4000): Disabling Drag and Drop Support for VM. 2022-08-14 11:32:31 (4000): Adding storage controller(s) to VM. 2022-08-14 11:32:31 (4000): Adding virtual disk drive to VM. (Theory_2022_07_28.vdi) 2022-08-14 11:32:31 (4000): Adding VirtualBox Guest Additions to VM. 2022-08-14 11:32:32 (4000): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2022-08-14 11:32:32 (4000): forwarding host port 55908 to guest port 80 2022-08-14 11:32:32 (4000): Enabling remote desktop for VM. 2022-08-14 11:32:33 (4000): Enabling shared directory for VM. 2022-08-14 11:32:34 (4000): Starting VM using VBoxManage interface. (boinc_308432694410c795, slot#3) 2022-08-14 11:32:41 (4000): Successfully started VM. (PID = '8096') 2022-08-14 11:32:41 (4000): Reporting VM Process ID to BOINC. 2022-08-14 11:32:41 (4000): Guest Log: BIOS: VirtualBox 6.1.36 2022-08-14 11:32:41 (4000): Guest Log: CPUID EDX: 0x178bfbff 2022-08-14 11:32:41 (4000): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-08-14 11:32:41 (4000): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-08-14 11:32:41 (4000): VM state change detected. (old = 'poweredoff', new = 'running') 2022-08-14 11:32:41 (4000): Detected: Web Application Enabled (http://localhost:55908) 2022-08-14 11:32:41 (4000): Detected: Remote Desktop Enabled (localhost:55914) 2022-08-14 11:32:41 (4000): Preference change detected 2022-08-14 11:32:41 (4000): Setting CPU throttle for VM. (100%) 2022-08-14 11:32:41 (4000): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-14 11:32:43 (4000): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-08-14 11:32:43 (4000): Guest Log: BIOS: Booting from Hard Disk... 2022-08-14 11:32:45 (4000): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-08-14 11:32:45 (4000): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-08-14 11:33:40 (4000): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-08-14 11:33:40 (4000): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-08-14 11:33:43 (4000): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.003304 main Log opened 2022-08-14T09:33:48.915970000Z 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.003897 main OS Product: Linux 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.004335 main OS Release: 4.14.76-13.cernvm.x86_64 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.004540 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.004756 main Executable: /usr/sbin/VBoxService 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.004757 main Process ID: 3216 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.004758 main Package type: LINUX_64BITS_GENERIC 2022-08-14 11:33:43 (4000): Guest Log: 00:00:00.009230 main 5.2.6 r120293 started. Verbose level = 0 2022-08-14 11:34:59 (4000): Guest Log: 11:35:04 CEST +02:00 2022-08-14: cranky: [INFO] Detected Theory App 2022-08-14 11:34:59 (4000): Guest Log: 11:35:04 CEST +02:00 2022-08-14: cranky: [INFO] Checking CVMFS. 2022-08-14 11:35:00 (4000): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-08-14 11:35:00 (4000): 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-08-14 11:35:00 (4000): Guest Log: 2.5.2.0 4053 1 28676 23573 2 1 265194 4096000 0 65024 0 0 n/a 5 1 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-08-14 11:35:01 (4000): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-08-14 11:35:02 (4000): 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-08-14 11:35:02 (4000): Guest Log: 2.5.2.0 4097 1 27464 18983 3 2 265194 4096000 0 65024 0 2 -100 7754 146 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-08-14 11:35:02 (4000): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-08-14 11:35:28 (4000): 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-08-14 11:35:28 (4000): Guest Log: 2.5.2.0 4149 1 28268 268 3 1 265194 4096000 0 65024 0 0 n/a 4 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 0 2022-08-14 11:35:28 (4000): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-08-14 11:35:49 (4000): 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-08-14 11:35:49 (4000): Guest Log: 2.5.2.0 4122 1 32220 13058 3 1 265194 4096000 0 65024 0 0 n/a 2929 110 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 0 2022-08-14 11:35:49 (4000): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Checking runc. 2022-08-14 11:35:49 (4000): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Creating the filesystem. 2022-08-14 11:35:49 (4000): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-08-14 11:35:49 (4000): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Updating config.json. 2022-08-14 11:35:49 (4000): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Running Container 'runc'. 2022-08-14 11:37:33 (4000): Guest Log: standard_init_linux.go:203: exec user process caused "input/output error" 2022-08-14 11:37:33 (4000): Guest Log: 11:37:38 CEST +02:00 2022-08-14: cranky: [INFO] Container 'runc' finished with status code 1. 2022-08-14 11:37:33 (4000): Guest Log: 11:37:38 CEST +02:00 2022-08-14: cranky: [INFO] Preparing output. 2022-08-14 11:37:33 (4000): Guest Log: 11:37:38 CEST +02:00 2022-08-14: cranky: [ERROR] No output found. 2022-08-14 13:12:49 (4000): Status Report: Job Duration: '864000.000000' 2022-08-14 13:12:49 (4000): Status Report: Elapsed Time: '6000.000000' 2022-08-14 13:12:49 (4000): Status Report: CPU Time: '46.640625' 2022-08-14 14:12:49 (4000): VM state change detected. (old = 'running', new = 'paused') 2022-08-14 14:44:16 (4000): VM state change detected. (old = 'paused', new = 'running') 2022-08-14 14:44:25 (4000): Guest Log: 02:39:10.527357 timesync vgsvcTimeSyncWorker: Radical host time change: 1 896 718 000 000ns (HostNow=1 660 481 065 073 000 000 ns HostLast=1 660 479 168 355 000 000 ns) 2022-08-14 14:44:35 (4000): Guest Log: 02:39:20.528236 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 895 637 078 000ns (GuestNow=1 660 481 075 075 434 000 ns GuestLast=1 660 479 179 438 356 000 ns fSetTimeLastLoop=true ) 2022-08-14 14:56:16 (4000): Preference change detected 2022-08-14 14:56:16 (4000): Setting CPU throttle for VM. (100%) 2022-08-14 14:56:16 (4000): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-14 15:24:35 (4000): Status Report: Job Duration: '864000.000000' 2022-08-14 15:24:35 (4000): Status Report: Elapsed Time: '12000.000000' 2022-08-14 15:24:35 (4000): Status Report: CPU Time: '71.218750' 2022-08-14 16:45:44 (4000): VM state change detected. (old = 'running', new = 'paused') 2022-08-14 16:47:13 (4000): VM state change detected. (old = 'paused', new = 'running') 2022-08-14 17:06:15 (4000): Status Report: Job Duration: '864000.000000' 2022-08-14 17:06:15 (4000): Status Report: Elapsed Time: '18000.000000' 2022-08-14 17:06:15 (4000): Status Report: CPU Time: '90.750000' 2022-08-14 17:20:07 (4000): VM state change detected. (old = 'running', new = 'paused') 2022-08-14 17:20:31 (4000): VM state change detected. (old = 'paused', new = 'running') 2022-08-14 18:46:46 (4000): Status Report: Job Duration: '864000.000000' 2022-08-14 18:46:46 (4000): Status Report: Elapsed Time: '24000.000000' 2022-08-14 18:46:46 (4000): Status Report: CPU Time: '116.328125' 2022-08-14 20:26:50 (4000): Status Report: Job Duration: '864000.000000' 2022-08-14 20:26:50 (4000): Status Report: Elapsed Time: '30000.000000' 2022-08-14 20:26:50 (4000): Status Report: CPU Time: '152.000000' 2022-08-14 22:06:55 (4000): Status Report: Job Duration: '864000.000000' 2022-08-14 22:06:55 (4000): Status Report: Elapsed Time: '36000.000000' 2022-08-14 22:06:55 (4000): Status Report: CPU Time: '190.750000' 2022-08-14 22:13:07 (4000): VM state change detected. (old = 'running', new = 'paused') 2022-08-14 22:13:14 (4000): Stopping VM. 2022-08-14 22:13:17 (4000): Successfully stopped VM. 2022-08-14 22:29:09 (9900): Detected: vboxwrapper 26205 2022-08-14 22:29:09 (9900): Detected: BOINC client v7.20.2 2022-08-14 22:29:10 (9900): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2022-08-14 22:29:10 (9900): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-08-14 22:29:12 (9900): Guest Log: BIOS: VirtualBox 6.1.36 2022-08-14 22:29:12 (9900): Guest Log: CPUID EDX: 0x178bfbff 2022-08-14 22:29:12 (9900): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-08-14 22:29:12 (9900): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-08-14 22:29:12 (9900): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-08-14 22:29:12 (9900): Guest Log: BIOS: Booting from Hard Disk... 2022-08-14 22:29:12 (9900): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-08-14 22:29:12 (9900): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-08-14 22:29:12 (9900): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-08-14 22:29:12 (9900): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-08-14 22:29:12 (9900): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.003304 main Log opened 2022-08-14T09:33:48.915970000Z 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.003897 main OS Product: Linux 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.004335 main OS Release: 4.14.76-13.cernvm.x86_64 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.004540 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.004756 main Executable: /usr/sbin/VBoxService 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.004757 main Process ID: 3216 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.004758 main Package type: LINUX_64BITS_GENERIC 2022-08-14 22:29:12 (9900): Guest Log: 00:00:00.009230 main 5.2.6 r120293 started. Verbose level = 0 2022-08-14 22:29:12 (9900): Guest Log: 11:35:04 CEST +02:00 2022-08-14: cranky: [INFO] Detected Theory App 2022-08-14 22:29:12 (9900): Guest Log: 11:35:04 CEST +02:00 2022-08-14: cranky: [INFO] Checking CVMFS. 2022-08-14 22:29:12 (9900): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-08-14 22:29:12 (9900): 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-08-14 22:29:12 (9900): Guest Log: 2.5.2.0 4053 1 28676 23573 2 1 265194 4096000 0 65024 0 0 n/a 5 1 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-08-14 22:29:12 (9900): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-08-14 22:29:12 (9900): 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-08-14 22:29:12 (9900): Guest Log: 2.5.2.0 4097 1 27464 18983 3 2 265194 4096000 0 65024 0 2 -100 7754 146 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-08-14 22:29:12 (9900): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-08-14 22:29:12 (9900): 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-08-14 22:29:12 (9900): Guest Log: 2.5.2.0 4149 1 28268 268 3 1 265194 4096000 0 65024 0 0 n/a 4 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 0 2022-08-14 22:29:12 (9900): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-08-14 22:29:12 (9900): 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-08-14 22:29:12 (9900): Guest Log: 2.5.2.0 4122 1 32220 13058 3 1 265194 4096000 0 65024 0 0 n/a 2929 110 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 0 2022-08-14 22:29:12 (9900): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Checking runc. 2022-08-14 22:29:12 (9900): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Creating the filesystem. 2022-08-14 22:29:12 (9900): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-08-14 22:29:12 (9900): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Updating config.json. 2022-08-14 22:29:12 (9900): Guest Log: 11:35:54 CEST +02:00 2022-08-14: cranky: [INFO] Running Container 'runc'. 2022-08-14 22:29:12 (9900): Guest Log: standard_init_linux.go:203: exec user process caused "input/output error" 2022-08-14 22:29:12 (9900): Guest Log: 11:37:38 CEST +02:00 2022-08-14: cranky: [INFO] Container 'runc' finished with status code 1. 2022-08-14 22:29:12 (9900): Guest Log: 11:37:38 CEST +02:00 2022-08-14: cranky: [INFO] Preparing output. 2022-08-14 22:29:12 (9900): Guest Log: 11:37:38 CEST +02:00 2022-08-14: cranky: [ERROR] No output found. 2022-08-14 22:29:12 (9900): Guest Log: 02:39:10.527357 timesync vgsvcTimeSyncWorker: Radical host time change: 1 896 718 000 000ns (HostNow=1 660 481 065 073 000 000 ns HostLast=1 660 479 168 355 000 000 ns) 2022-08-14 22:29:12 (9900): Guest Log: 02:39:20.528236 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 895 637 078 000ns (GuestNow=1 660 481 075 075 434 000 ns GuestLast=1 660 479 179 438 356 000 ns fSetTimeLastLoop=true ) 2022-08-14 22:29:12 (9900): Starting VM using VBoxManage interface. (boinc_308432694410c795, slot#3) 2022-08-14 22:29:22 (9900): Successfully started VM. (PID = '9876') 2022-08-14 22:29:22 (9900): Reporting VM Process ID to BOINC. 2022-08-14 22:29:22 (9900): VM state change detected. (old = 'poweredoff', new = 'running') 2022-08-14 22:29:22 (9900): Detected: Web Application Enabled (http://localhost:55908) 2022-08-14 22:29:22 (9900): Detected: Remote Desktop Enabled (localhost:55914) 2022-08-14 22:29:22 (9900): Status Report: Job Duration: '864000.000000' 2022-08-14 22:29:22 (9900): Status Report: Elapsed Time: '36370.000000' 2022-08-14 22:29:22 (9900): Status Report: CPU Time: '193.421875' 2022-08-14 22:29:22 (9900): Preference change detected 2022-08-14 22:29:22 (9900): Setting CPU throttle for VM. (100%) 2022-08-14 22:29:22 (9900): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-15 00:09:34 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 00:09:34 (9900): Status Report: Elapsed Time: '42370.000000' 2022-08-15 00:09:34 (9900): Status Report: CPU Time: '251.718750' 2022-08-15 01:49:43 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 01:49:43 (9900): Status Report: Elapsed Time: '48370.000000' 2022-08-15 01:49:43 (9900): Status Report: CPU Time: '298.703125' 2022-08-15 03:29:53 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 03:29:53 (9900): Status Report: Elapsed Time: '54370.000000' 2022-08-15 03:29:53 (9900): Status Report: CPU Time: '347.406250' 2022-08-15 05:10:02 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 05:10:02 (9900): Status Report: Elapsed Time: '60370.000000' 2022-08-15 05:10:02 (9900): Status Report: CPU Time: '397.968750' 2022-08-15 06:50:11 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 06:50:11 (9900): Status Report: Elapsed Time: '66370.000000' 2022-08-15 06:50:11 (9900): Status Report: CPU Time: '444.500000' 2022-08-15 08:30:22 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 08:30:22 (9900): Status Report: Elapsed Time: '72370.000000' 2022-08-15 08:30:22 (9900): Status Report: CPU Time: '490.687500' 2022-08-15 10:10:32 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 10:10:32 (9900): Status Report: Elapsed Time: '78370.000000' 2022-08-15 10:10:32 (9900): Status Report: CPU Time: '543.078125' 2022-08-15 11:50:45 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 11:50:45 (9900): Status Report: Elapsed Time: '84370.000000' 2022-08-15 11:50:45 (9900): Status Report: CPU Time: '619.625000' 2022-08-15 13:30:54 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 13:30:54 (9900): Status Report: Elapsed Time: '90370.000000' 2022-08-15 13:30:54 (9900): Status Report: CPU Time: '695.250000' 2022-08-15 15:11:03 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 15:11:03 (9900): Status Report: Elapsed Time: '96370.000000' 2022-08-15 15:11:03 (9900): Status Report: CPU Time: '753.593750' 2022-08-15 16:51:11 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 16:51:11 (9900): Status Report: Elapsed Time: '102370.000000' 2022-08-15 16:51:11 (9900): Status Report: CPU Time: '803.531250' 2022-08-15 18:31:19 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 18:31:19 (9900): Status Report: Elapsed Time: '108370.000000' 2022-08-15 18:31:19 (9900): Status Report: CPU Time: '850.234375' 2022-08-15 20:11:28 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 20:11:28 (9900): Status Report: Elapsed Time: '114370.000000' 2022-08-15 20:11:28 (9900): Status Report: CPU Time: '896.859375' 2022-08-15 21:51:39 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 21:51:39 (9900): Status Report: Elapsed Time: '120370.000000' 2022-08-15 21:51:39 (9900): Status Report: CPU Time: '942.937500' 2022-08-15 23:31:50 (9900): Status Report: Job Duration: '864000.000000' 2022-08-15 23:31:50 (9900): Status Report: Elapsed Time: '126370.000000' 2022-08-15 23:31:50 (9900): Status Report: CPU Time: '989.078125' 2022-08-16 01:11:59 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 01:11:59 (9900): Status Report: Elapsed Time: '132370.000000' 2022-08-16 01:11:59 (9900): Status Report: CPU Time: '1036.562500' 2022-08-16 02:52:09 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 02:52:09 (9900): Status Report: Elapsed Time: '138370.000000' 2022-08-16 02:52:09 (9900): Status Report: CPU Time: '1088.906250' 2022-08-16 04:32:19 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 04:32:19 (9900): Status Report: Elapsed Time: '144370.000000' 2022-08-16 04:32:19 (9900): Status Report: CPU Time: '1140.718750' 2022-08-16 06:12:29 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 06:12:29 (9900): Status Report: Elapsed Time: '150370.000000' 2022-08-16 06:12:29 (9900): Status Report: CPU Time: '1191.984375' 2022-08-16 07:52:40 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 07:52:40 (9900): Status Report: Elapsed Time: '156370.000000' 2022-08-16 07:52:40 (9900): Status Report: CPU Time: '1238.500000' 2022-08-16 09:32:51 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 09:32:51 (9900): Status Report: Elapsed Time: '162370.000000' 2022-08-16 09:32:51 (9900): Status Report: CPU Time: '1285.796875' 2022-08-16 11:13:05 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 11:13:05 (9900): Status Report: Elapsed Time: '168370.000000' 2022-08-16 11:13:05 (9900): Status Report: CPU Time: '1332.671875' 2022-08-16 12:53:16 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 12:53:16 (9900): Status Report: Elapsed Time: '174370.000000' 2022-08-16 12:53:16 (9900): Status Report: CPU Time: '1381.765625' 2022-08-16 14:33:27 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 14:33:27 (9900): Status Report: Elapsed Time: '180370.000000' 2022-08-16 14:33:27 (9900): Status Report: CPU Time: '1452.671875' 2022-08-16 16:13:37 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 16:13:37 (9900): Status Report: Elapsed Time: '186370.000000' 2022-08-16 16:13:37 (9900): Status Report: CPU Time: '1529.984375' 2022-08-16 17:53:46 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 17:53:46 (9900): Status Report: Elapsed Time: '192370.000000' 2022-08-16 17:53:46 (9900): Status Report: CPU Time: '1601.234375' 2022-08-16 19:33:57 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 19:33:57 (9900): Status Report: Elapsed Time: '198370.000000' 2022-08-16 19:33:57 (9900): Status Report: CPU Time: '1667.234375' 2022-08-16 21:14:07 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 21:14:07 (9900): Status Report: Elapsed Time: '204370.000000' 2022-08-16 21:14:07 (9900): Status Report: CPU Time: '1715.093750' 2022-08-16 22:54:23 (9900): Status Report: Job Duration: '864000.000000' 2022-08-16 22:54:23 (9900): Status Report: Elapsed Time: '210370.000000' 2022-08-16 22:54:23 (9900): Status Report: CPU Time: '1761.343750' 2022-08-17 00:34:32 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 00:34:32 (9900): Status Report: Elapsed Time: '216370.000000' 2022-08-17 00:34:32 (9900): Status Report: CPU Time: '1808.375000' 2022-08-17 02:14:41 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 02:14:41 (9900): Status Report: Elapsed Time: '222370.000000' 2022-08-17 02:14:41 (9900): Status Report: CPU Time: '1855.046875' 2022-08-17 03:54:51 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 03:54:51 (9900): Status Report: Elapsed Time: '228370.000000' 2022-08-17 03:54:51 (9900): Status Report: CPU Time: '1901.125000' 2022-08-17 05:35:01 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 05:35:01 (9900): Status Report: Elapsed Time: '234370.000000' 2022-08-17 05:35:01 (9900): Status Report: CPU Time: '1947.921875' 2022-08-17 07:15:14 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 07:15:14 (9900): Status Report: Elapsed Time: '240370.000000' 2022-08-17 07:15:14 (9900): Status Report: CPU Time: '2012.484375' 2022-08-17 08:55:25 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 08:55:25 (9900): Status Report: Elapsed Time: '246370.000000' 2022-08-17 08:55:25 (9900): Status Report: CPU Time: '2083.375000' 2022-08-17 10:35:36 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 10:35:36 (9900): Status Report: Elapsed Time: '252370.000000' 2022-08-17 10:35:36 (9900): Status Report: CPU Time: '2159.281250' 2022-08-17 12:15:46 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 12:15:46 (9900): Status Report: Elapsed Time: '258370.000000' 2022-08-17 12:15:46 (9900): Status Report: CPU Time: '2238.640625' 2022-08-17 13:55:56 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 13:55:56 (9900): Status Report: Elapsed Time: '264370.000000' 2022-08-17 13:55:56 (9900): Status Report: CPU Time: '2323.765625' 2022-08-17 15:36:06 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 15:36:06 (9900): Status Report: Elapsed Time: '270370.000000' 2022-08-17 15:36:06 (9900): Status Report: CPU Time: '2421.750000' 2022-08-17 17:16:16 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 17:16:16 (9900): Status Report: Elapsed Time: '276370.000000' 2022-08-17 17:16:16 (9900): Status Report: CPU Time: '2513.296875' 2022-08-17 18:56:26 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 18:56:26 (9900): Status Report: Elapsed Time: '282370.000000' 2022-08-17 18:56:26 (9900): Status Report: CPU Time: '2596.203125' 2022-08-17 20:36:37 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 20:36:37 (9900): Status Report: Elapsed Time: '288370.000000' 2022-08-17 20:36:37 (9900): Status Report: CPU Time: '2667.656250' 2022-08-17 22:16:47 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 22:16:47 (9900): Status Report: Elapsed Time: '294370.000000' 2022-08-17 22:16:47 (9900): Status Report: CPU Time: '2733.375000' 2022-08-17 23:56:57 (9900): Status Report: Job Duration: '864000.000000' 2022-08-17 23:56:57 (9900): Status Report: Elapsed Time: '300370.000000' 2022-08-17 23:56:57 (9900): Status Report: CPU Time: '2798.546875' 2022-08-18 01:37:07 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 01:37:07 (9900): Status Report: Elapsed Time: '306370.000000' 2022-08-18 01:37:07 (9900): Status Report: CPU Time: '2864.593750' 2022-08-18 03:17:17 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 03:17:17 (9900): Status Report: Elapsed Time: '312370.000000' 2022-08-18 03:17:17 (9900): Status Report: CPU Time: '2931.750000' 2022-08-18 04:57:27 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 04:57:27 (9900): Status Report: Elapsed Time: '318370.000000' 2022-08-18 04:57:27 (9900): Status Report: CPU Time: '2984.953125' 2022-08-18 06:37:39 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 06:37:39 (9900): Status Report: Elapsed Time: '324370.000000' 2022-08-18 06:37:39 (9900): Status Report: CPU Time: '3033.203125' 2022-08-18 08:17:48 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 08:17:48 (9900): Status Report: Elapsed Time: '330370.000000' 2022-08-18 08:17:48 (9900): Status Report: CPU Time: '3082.125000' 2022-08-18 09:57:58 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 09:57:58 (9900): Status Report: Elapsed Time: '336370.000000' 2022-08-18 09:57:58 (9900): Status Report: CPU Time: '3129.640625' 2022-08-18 11:38:21 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 11:38:21 (9900): Status Report: Elapsed Time: '342370.000000' 2022-08-18 11:38:21 (9900): Status Report: CPU Time: '3175.875000' 2022-08-18 13:18:31 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 13:18:31 (9900): Status Report: Elapsed Time: '348370.000000' 2022-08-18 13:18:31 (9900): Status Report: CPU Time: '3223.828125' 2022-08-18 14:58:40 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 14:58:40 (9900): Status Report: Elapsed Time: '354370.000000' 2022-08-18 14:58:40 (9900): Status Report: CPU Time: '3270.968750' 2022-08-18 16:38:50 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 16:38:50 (9900): Status Report: Elapsed Time: '360370.000000' 2022-08-18 16:38:50 (9900): Status Report: CPU Time: '3317.937500' 2022-08-18 17:44:22 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-18 17:46:24 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-18 17:51:23 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-18 17:55:24 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-18 18:25:03 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 18:25:03 (9900): Status Report: Elapsed Time: '366370.000000' 2022-08-18 18:25:03 (9900): Status Report: CPU Time: '3381.203125' 2022-08-18 20:05:15 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 20:05:15 (9900): Status Report: Elapsed Time: '372370.000000' 2022-08-18 20:05:15 (9900): Status Report: CPU Time: '3474.796875' 2022-08-18 21:45:28 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 21:45:28 (9900): Status Report: Elapsed Time: '378370.000000' 2022-08-18 21:45:28 (9900): Status Report: CPU Time: '3569.843750' 2022-08-18 21:53:54 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-18 21:58:55 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-18 21:59:55 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-18 22:00:55 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-18 22:05:56 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-18 22:07:56 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-18 22:08:56 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-18 22:10:57 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-18 23:35:45 (9900): Status Report: Job Duration: '864000.000000' 2022-08-18 23:35:45 (9900): Status Report: Elapsed Time: '384370.000000' 2022-08-18 23:35:45 (9900): Status Report: CPU Time: '3661.046875' 2022-08-19 01:15:57 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 01:15:57 (9900): Status Report: Elapsed Time: '390370.000000' 2022-08-19 01:15:57 (9900): Status Report: CPU Time: '3756.156250' 2022-08-19 02:56:09 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 02:56:09 (9900): Status Report: Elapsed Time: '396370.000000' 2022-08-19 02:56:09 (9900): Status Report: CPU Time: '3848.437500' 2022-08-19 04:36:21 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 04:36:21 (9900): Status Report: Elapsed Time: '402370.000000' 2022-08-19 04:36:21 (9900): Status Report: CPU Time: '3944.406250' 2022-08-19 06:08:08 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 06:09:08 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 06:17:34 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 06:17:34 (9900): Status Report: Elapsed Time: '408370.000000' 2022-08-19 06:17:34 (9900): Status Report: CPU Time: '4036.406250' 2022-08-19 07:57:46 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 07:57:46 (9900): Status Report: Elapsed Time: '414370.000000' 2022-08-19 07:57:46 (9900): Status Report: CPU Time: '4131.406250' 2022-08-19 09:38:01 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 09:38:01 (9900): Status Report: Elapsed Time: '420370.000000' 2022-08-19 09:38:01 (9900): Status Report: CPU Time: '4226.000000' 2022-08-19 10:17:06 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 10:19:06 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 10:21:06 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 10:23:06 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 10:24:06 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 10:26:07 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 10:27:07 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 10:59:09 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 10:59:12 (9900): Guest Log: 117:41:23.104493 timesync vgsvcTimeSyncWorker: Radical host time change: 1 932 006 000 000ns (HostNow=1 660 899 551 425 000 000 ns HostLast=1 660 897 619 419 000 000 ns) 2022-08-19 10:59:22 (9900): Guest Log: 117:41:33.107393 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 052 585 308 000ns (GuestNow=1 660 899 561 436 947 000 ns GuestLast=1 660 897 508 851 639 000 ns fSetTimeLastLoop=true ) 2022-08-19 11:00:09 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 11:03:09 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 11:07:10 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 11:08:10 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 11:09:10 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 11:11:10 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 12:02:25 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 12:02:25 (9900): Status Report: Elapsed Time: '426370.170137' 2022-08-19 12:02:25 (9900): Status Report: CPU Time: '4318.312500' 2022-08-19 13:42:39 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 13:42:39 (9900): Status Report: Elapsed Time: '432370.170137' 2022-08-19 13:42:39 (9900): Status Report: CPU Time: '4411.890625' 2022-08-19 14:23:17 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 14:25:17 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 15:24:53 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 15:24:53 (9900): Status Report: Elapsed Time: '438370.170137' 2022-08-19 15:24:53 (9900): Status Report: CPU Time: '4506.234375' 2022-08-19 17:05:05 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 17:05:06 (9900): Status Report: Elapsed Time: '444370.170137' 2022-08-19 17:05:06 (9900): Status Report: CPU Time: '4603.109375' 2022-08-19 18:30:28 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 18:31:28 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 18:36:29 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 18:37:29 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 18:47:19 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 18:47:19 (9900): Status Report: Elapsed Time: '450370.170137' 2022-08-19 18:47:19 (9900): Status Report: CPU Time: '4697.203125' 2022-08-19 20:27:34 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 20:27:34 (9900): Status Report: Elapsed Time: '456370.170137' 2022-08-19 20:27:34 (9900): Status Report: CPU Time: '4794.312500' 2022-08-19 22:07:45 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 22:07:45 (9900): Status Report: Elapsed Time: '462370.170137' 2022-08-19 22:07:45 (9900): Status Report: CPU Time: '4913.281250' 2022-08-19 22:39:00 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 22:40:00 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 22:42:01 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 22:43:01 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 22:50:05 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 22:52:06 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 22:58:10 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 22:59:10 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 23:10:15 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-19 23:12:49 (9900): VM state change detected. (old = 'paused', new = 'running') 2022-08-19 23:55:35 (9900): Status Report: Job Duration: '864000.000000' 2022-08-19 23:55:35 (9900): Status Report: Elapsed Time: '468370.170137' 2022-08-19 23:55:35 (9900): Status Report: CPU Time: '5009.265625' 2022-08-20 01:35:45 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 01:35:45 (9900): Status Report: Elapsed Time: '474370.170137' 2022-08-20 01:35:45 (9900): Status Report: CPU Time: '5083.484375' 2022-08-20 03:15:55 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 03:15:55 (9900): Status Report: Elapsed Time: '480370.170137' 2022-08-20 03:15:55 (9900): Status Report: CPU Time: '5158.281250' 2022-08-20 04:56:06 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 04:56:07 (9900): Status Report: Elapsed Time: '486370.170137' 2022-08-20 04:56:07 (9900): Status Report: CPU Time: '5231.015625' 2022-08-20 06:36:17 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 06:36:17 (9900): Status Report: Elapsed Time: '492370.170137' 2022-08-20 06:36:17 (9900): Status Report: CPU Time: '5302.343750' 2022-08-20 08:16:26 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 08:16:27 (9900): Status Report: Elapsed Time: '498370.170137' 2022-08-20 08:16:27 (9900): Status Report: CPU Time: '5374.281250' 2022-08-20 09:56:38 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 09:56:38 (9900): Status Report: Elapsed Time: '504370.170137' 2022-08-20 09:56:38 (9900): Status Report: CPU Time: '5448.531250' 2022-08-20 11:36:49 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 11:36:49 (9900): Status Report: Elapsed Time: '510370.170137' 2022-08-20 11:36:49 (9900): Status Report: CPU Time: '5519.281250' 2022-08-20 13:16:58 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 13:16:58 (9900): Status Report: Elapsed Time: '516370.170137' 2022-08-20 13:16:58 (9900): Status Report: CPU Time: '5590.656250' 2022-08-20 14:57:09 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 14:57:09 (9900): Status Report: Elapsed Time: '522370.170137' 2022-08-20 14:57:09 (9900): Status Report: CPU Time: '5662.781250' 2022-08-20 16:37:19 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 16:37:19 (9900): Status Report: Elapsed Time: '528370.170137' 2022-08-20 16:37:19 (9900): Status Report: CPU Time: '5736.062500' 2022-08-20 18:17:29 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 18:17:29 (9900): Status Report: Elapsed Time: '534370.170137' 2022-08-20 18:17:29 (9900): Status Report: CPU Time: '5806.984375' 2022-08-20 19:57:39 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 19:57:39 (9900): Status Report: Elapsed Time: '540370.170137' 2022-08-20 19:57:39 (9900): Status Report: CPU Time: '5879.687500' 2022-08-20 21:37:50 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 21:37:50 (9900): Status Report: Elapsed Time: '546370.170137' 2022-08-20 21:37:50 (9900): Status Report: CPU Time: '5950.921875' 2022-08-20 23:18:00 (9900): Status Report: Job Duration: '864000.000000' 2022-08-20 23:18:00 (9900): Status Report: Elapsed Time: '552370.170137' 2022-08-20 23:18:00 (9900): Status Report: CPU Time: '6023.656250' 2022-08-21 00:58:11 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 00:58:11 (9900): Status Report: Elapsed Time: '558370.170137' 2022-08-21 00:58:11 (9900): Status Report: CPU Time: '6099.421875' 2022-08-21 02:38:21 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 02:38:21 (9900): Status Report: Elapsed Time: '564370.170137' 2022-08-21 02:38:21 (9900): Status Report: CPU Time: '6170.562500' 2022-08-21 04:18:32 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 04:18:32 (9900): Status Report: Elapsed Time: '570370.170137' 2022-08-21 04:18:32 (9900): Status Report: CPU Time: '6245.875000' 2022-08-21 05:58:44 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 05:58:44 (9900): Status Report: Elapsed Time: '576370.170137' 2022-08-21 05:58:44 (9900): Status Report: CPU Time: '6340.671875' 2022-08-21 07:38:55 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 07:38:55 (9900): Status Report: Elapsed Time: '582370.170137' 2022-08-21 07:38:55 (9900): Status Report: CPU Time: '6437.359375' 2022-08-21 09:19:08 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 09:19:08 (9900): Status Report: Elapsed Time: '588370.170137' 2022-08-21 09:19:08 (9900): Status Report: CPU Time: '6533.453125' 2022-08-21 10:59:20 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 10:59:20 (9900): Status Report: Elapsed Time: '594370.170137' 2022-08-21 10:59:20 (9900): Status Report: CPU Time: '6628.187500' 2022-08-21 12:39:31 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 12:39:31 (9900): Status Report: Elapsed Time: '600370.170137' 2022-08-21 12:39:31 (9900): Status Report: CPU Time: '6720.937500' 2022-08-21 14:19:42 (9900): Status Report: Job Duration: '864000.000000' 2022-08-21 14:19:42 (9900): Status Report: Elapsed Time: '606370.170137' 2022-08-21 14:19:42 (9900): Status Report: CPU Time: '6809.578125' 2022-08-21 15:45:06 (9900): Preference change detected 2022-08-21 15:45:06 (9900): Setting CPU throttle for VM. (100%) 2022-08-21 15:45:06 (9900): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-21 15:49:40 (9900): VM state change detected. (old = 'running', new = 'paused') 2022-08-21 15:49:47 (9900): Stopping VM. 2022-08-21 15:49:50 (9900): Successfully stopped VM. 2022-08-21 16:00:37 (16604): Detected: vboxwrapper 26205 2022-08-21 16:00:37 (16604): Detected: BOINC client v7.20.2 2022-08-21 16:00:46 (16604): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2022-08-21 16:00:47 (16604): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-08-21 16:00:48 (16604): Guest Log: 117:41:23.104493 timesync vgsvcTimeSyncWorker: Radical host time change: 1 932 006 000 000ns (HostNow=1 660 899 551 425 000 000 ns HostLast=1 660 897 619 419 000 000 ns) 2022-08-21 16:00:48 (16604): Guest Log: 117:41:33.107393 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 052 585 308 000ns (GuestNow=1 660 899 561 436 947 000 ns GuestLast=1 660 897 508 851 639 000 ns fSetTimeLastLoop=true ) 2022-08-21 16:00:48 (16604): Starting VM using VBoxManage interface. (boinc_308432694410c795, slot#3) 2022-08-21 16:01:04 (16604): Successfully started VM. (PID = '17380') 2022-08-21 16:01:04 (16604): Reporting VM Process ID to BOINC. 2022-08-21 16:01:04 (16604): VM state change detected. (old = 'poweredoff', new = 'running') 2022-08-21 16:01:04 (16604): Detected: Web Application Enabled (http://localhost:55908) 2022-08-21 16:01:04 (16604): Detected: Remote Desktop Enabled (localhost:55914) 2022-08-21 16:01:04 (16604): Status Report: Job Duration: '864000.000000' 2022-08-21 16:01:04 (16604): Status Report: Elapsed Time: '611747.170137' 2022-08-21 16:01:04 (16604): Status Report: CPU Time: '6890.937500' 2022-08-21 16:01:04 (16604): Preference change detected 2022-08-21 16:01:04 (16604): Setting CPU throttle for VM. (100%) 2022-08-21 16:01:04 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-21 16:01:33 (16604): Preference change detected 2022-08-21 16:01:33 (16604): Setting CPU throttle for VM. (100%) 2022-08-21 16:01:33 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-21 17:41:13 (16604): Status Report: Job Duration: '864000.000000' 2022-08-21 17:41:13 (16604): Status Report: Elapsed Time: '617747.170137' 2022-08-21 17:41:13 (16604): Status Report: CPU Time: '6960.562500' 2022-08-21 19:21:24 (16604): Status Report: Job Duration: '864000.000000' 2022-08-21 19:21:24 (16604): Status Report: Elapsed Time: '623747.170137' 2022-08-21 19:21:24 (16604): Status Report: CPU Time: '7010.750000' 2022-08-21 20:56:36 (16604): Preference change detected 2022-08-21 20:56:36 (16604): Setting CPU throttle for VM. (100%) 2022-08-21 20:56:36 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-21 21:01:36 (16604): Status Report: Job Duration: '864000.000000' 2022-08-21 21:01:36 (16604): Status Report: Elapsed Time: '629747.170137' 2022-08-21 21:01:36 (16604): Status Report: CPU Time: '7057.625000' 2022-08-21 22:41:44 (16604): Status Report: Job Duration: '864000.000000' 2022-08-21 22:41:44 (16604): Status Report: Elapsed Time: '635747.170137' 2022-08-21 22:41:44 (16604): Status Report: CPU Time: '7104.968750' 2022-08-22 00:21:54 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 00:21:54 (16604): Status Report: Elapsed Time: '641747.170137' 2022-08-22 00:21:54 (16604): Status Report: CPU Time: '7152.703125' 2022-08-22 02:02:04 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 02:02:04 (16604): Status Report: Elapsed Time: '647747.170137' 2022-08-22 02:02:04 (16604): Status Report: CPU Time: '7200.890625' 2022-08-22 03:42:14 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 03:42:14 (16604): Status Report: Elapsed Time: '653747.170137' 2022-08-22 03:42:14 (16604): Status Report: CPU Time: '7247.296875' 2022-08-22 05:22:23 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 05:22:23 (16604): Status Report: Elapsed Time: '659747.170137' 2022-08-22 05:22:23 (16604): Status Report: CPU Time: '7296.984375' 2022-08-22 07:02:30 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 07:02:30 (16604): Status Report: Elapsed Time: '665747.170137' 2022-08-22 07:02:30 (16604): Status Report: CPU Time: '7343.781250' 2022-08-22 08:42:40 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 08:42:40 (16604): Status Report: Elapsed Time: '671747.170137' 2022-08-22 08:42:40 (16604): Status Report: CPU Time: '7390.687500' 2022-08-22 10:22:52 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 10:22:52 (16604): Status Report: Elapsed Time: '677747.170137' 2022-08-22 10:22:52 (16604): Status Report: CPU Time: '7441.421875' 2022-08-22 12:03:00 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 12:03:00 (16604): Status Report: Elapsed Time: '683747.170137' 2022-08-22 12:03:00 (16604): Status Report: CPU Time: '7500.218750' 2022-08-22 13:43:08 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 13:43:08 (16604): Status Report: Elapsed Time: '689747.170137' 2022-08-22 13:43:08 (16604): Status Report: CPU Time: '7562.109375' 2022-08-22 14:48:31 (16604): VM state change detected. (old = 'running', new = 'paused') 2022-08-22 14:50:59 (16604): VM state change detected. (old = 'paused', new = 'running') 2022-08-22 15:03:09 (16604): Preference change detected 2022-08-22 15:03:09 (16604): Setting CPU throttle for VM. (100%) 2022-08-22 15:03:09 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-22 15:25:47 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 15:25:47 (16604): Status Report: Elapsed Time: '695747.170137' 2022-08-22 15:25:47 (16604): Status Report: CPU Time: '7609.375000' 2022-08-22 17:05:56 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 17:05:56 (16604): Status Report: Elapsed Time: '701747.170137' 2022-08-22 17:05:56 (16604): Status Report: CPU Time: '7654.000000' 2022-08-22 18:46:05 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 18:46:05 (16604): Status Report: Elapsed Time: '707747.170137' 2022-08-22 18:46:05 (16604): Status Report: CPU Time: '7703.765625' 2022-08-22 20:26:15 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 20:26:15 (16604): Status Report: Elapsed Time: '713747.170137' 2022-08-22 20:26:15 (16604): Status Report: CPU Time: '7755.375000' 2022-08-22 22:06:24 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 22:06:24 (16604): Status Report: Elapsed Time: '719747.170137' 2022-08-22 22:06:24 (16604): Status Report: CPU Time: '7806.562500' 2022-08-22 23:46:33 (16604): Status Report: Job Duration: '864000.000000' 2022-08-22 23:46:33 (16604): Status Report: Elapsed Time: '725747.170137' 2022-08-22 23:46:33 (16604): Status Report: CPU Time: '7858.390625' 2022-08-23 01:26:43 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 01:26:43 (16604): Status Report: Elapsed Time: '731747.170137' 2022-08-23 01:26:43 (16604): Status Report: CPU Time: '7908.796875' 2022-08-23 03:06:52 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 03:06:52 (16604): Status Report: Elapsed Time: '737747.170137' 2022-08-23 03:06:52 (16604): Status Report: CPU Time: '7958.593750' 2022-08-23 04:47:03 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 04:47:03 (16604): Status Report: Elapsed Time: '743747.170137' 2022-08-23 04:47:03 (16604): Status Report: CPU Time: '8009.156250' 2022-08-23 06:27:12 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 06:27:12 (16604): Status Report: Elapsed Time: '749747.170137' 2022-08-23 06:27:12 (16604): Status Report: CPU Time: '8063.171875' 2022-08-23 08:07:21 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 08:07:21 (16604): Status Report: Elapsed Time: '755747.170137' 2022-08-23 08:07:21 (16604): Status Report: CPU Time: '8116.515625' 2022-08-23 09:47:31 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 09:47:31 (16604): Status Report: Elapsed Time: '761747.170137' 2022-08-23 09:47:31 (16604): Status Report: CPU Time: '8168.640625' 2022-08-23 10:31:50 (16604): Preference change detected 2022-08-23 10:31:50 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 10:31:51 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 10:36:18 (16604): Preference change detected 2022-08-23 10:36:18 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 10:36:19 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 10:50:32 (16604): Preference change detected 2022-08-23 10:50:32 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 10:50:33 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 11:06:05 (16604): Preference change detected 2022-08-23 11:06:05 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 11:06:05 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 11:27:41 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 11:27:41 (16604): Status Report: Elapsed Time: '767747.170137' 2022-08-23 11:27:41 (16604): Status Report: CPU Time: '8212.328125' 2022-08-23 12:06:19 (16604): Preference change detected 2022-08-23 12:06:19 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 12:06:19 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 12:24:27 (16604): Preference change detected 2022-08-23 12:24:27 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 12:24:27 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 12:26:33 (16604): Preference change detected 2022-08-23 12:26:33 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 12:26:34 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 13:07:50 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 13:07:50 (16604): Status Report: Elapsed Time: '773747.170137' 2022-08-23 13:07:50 (16604): Status Report: CPU Time: '8253.875000' 2022-08-23 14:48:01 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 14:48:01 (16604): Status Report: Elapsed Time: '779747.170137' 2022-08-23 14:48:01 (16604): Status Report: CPU Time: '8310.062500' 2022-08-23 15:19:47 (16604): Preference change detected 2022-08-23 15:19:47 (16604): Setting CPU throttle for VM. (100%) 2022-08-23 15:19:48 (16604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 240 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-23 16:28:12 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 16:28:12 (16604): Status Report: Elapsed Time: '785747.170137' 2022-08-23 16:28:12 (16604): Status Report: CPU Time: '8361.015625' 2022-08-23 18:08:24 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 18:08:24 (16604): Status Report: Elapsed Time: '791747.170137' 2022-08-23 18:08:24 (16604): Status Report: CPU Time: '8415.906250' 2022-08-23 19:48:34 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 19:48:34 (16604): Status Report: Elapsed Time: '797747.170137' 2022-08-23 19:48:34 (16604): Status Report: CPU Time: '8489.640625' 2022-08-23 21:28:44 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 21:28:44 (16604): Status Report: Elapsed Time: '803747.170137' 2022-08-23 21:28:44 (16604): Status Report: CPU Time: '8564.515625' 2022-08-23 23:08:53 (16604): Status Report: Job Duration: '864000.000000' 2022-08-23 23:08:53 (16604): Status Report: Elapsed Time: '809747.170137' 2022-08-23 23:08:53 (16604): Status Report: CPU Time: '8617.750000' 2022-08-24 00:49:02 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 00:49:02 (16604): Status Report: Elapsed Time: '815747.170137' 2022-08-24 00:49:02 (16604): Status Report: CPU Time: '8669.953125' 2022-08-24 02:29:12 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 02:29:12 (16604): Status Report: Elapsed Time: '821747.170137' 2022-08-24 02:29:12 (16604): Status Report: CPU Time: '8744.718750' 2022-08-24 04:09:23 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 04:09:23 (16604): Status Report: Elapsed Time: '827747.170137' 2022-08-24 04:09:23 (16604): Status Report: CPU Time: '8812.734375' 2022-08-24 05:49:33 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 05:49:33 (16604): Status Report: Elapsed Time: '833747.170137' 2022-08-24 05:49:33 (16604): Status Report: CPU Time: '8887.796875' 2022-08-24 07:29:42 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 07:29:42 (16604): Status Report: Elapsed Time: '839747.170137' 2022-08-24 07:29:42 (16604): Status Report: CPU Time: '8964.328125' 2022-08-24 09:09:52 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 09:09:52 (16604): Status Report: Elapsed Time: '845747.170137' 2022-08-24 09:09:52 (16604): Status Report: CPU Time: '9034.687500' 2022-08-24 10:49:59 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 10:49:59 (16604): Status Report: Elapsed Time: '851747.170137' 2022-08-24 10:49:59 (16604): Status Report: CPU Time: '9092.546875' 2022-08-24 12:30:06 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 12:30:06 (16604): Status Report: Elapsed Time: '857747.170137' 2022-08-24 12:30:06 (16604): Status Report: CPU Time: '9148.890625' 2022-08-24 14:10:13 (16604): Status Report: Job Duration: '864000.000000' 2022-08-24 14:10:13 (16604): Status Report: Elapsed Time: '863747.170137' 2022-08-24 14:10:13 (16604): Status Report: CPU Time: '9200.156250' 2022-08-24 14:14:26 (16604): Powering off VM. 2022-08-24 14:14:27 (16604): Successfully stopped VM. 2022-08-24 14:14:27 (16604): Deregistering VM. (boinc_308432694410c795, slot#3) 2022-08-24 14:14:27 (16604): Removing network bandwidth throttle group from VM. 2022-08-24 14:14:27 (16604): Removing VM from VirtualBox. 14:14:33 (16604): called boinc_finish(0) </stderr_txt> <message> upload failure: <file_xfer_error> <file_name>Theory_2390-1150160-286_0_r646181752_result</file_name> <error_code>-240 (stat() failed)</error_code> </file_xfer_error> </message> ]]>
©2024 CERN