| Name | CMS_3082966_1627464931.258787_0 |
| Workunit | 2111946 |
| Created | 28 Jul 2021, 9:35:33 UTC |
| Sent | 28 Jul 2021, 17:07:13 UTC |
| Report deadline | 4 Aug 2021, 17:07:13 UTC |
| Received | 9 Aug 2021, 23:44:21 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 4441 |
| Run time | 18 hours 6 min 1 sec |
| CPU time | 10 hours 50 min 41 sec |
| Validate state | Valid |
| Credit | 1,308.08 |
| Device peak FLOPS | 3.90 GFLOPS |
| Application version | CMS Simulation v60.50 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 63.35 MB |
| Peak swap size | 85.80 MB |
| Peak disk usage | 4.55 GB |
Stderr output
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> ning', new = 'Paused') 2021-07-28 20:00:04 (17484): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-28 20:05:55 (17484): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-28 20:06:05 (17484): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-28 20:06:25 (17484): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-28 20:06:35 (17484): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-28 20:09:55 (17484): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-28 20:10:03 (17484): Stopping VM. 2021-07-28 20:10:03 (17484): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_cd3217c2614ed042" savestate Output: 2021-07-28 20:10:03 (17484): VM did not stop when requested. 2021-07-28 20:10:03 (17484): VM was successfully terminated. 2021-07-29 15:26:15 (13084): Detected: vboxwrapper 26197 2021-07-29 15:26:15 (13084): Detected: BOINC client v7.7 2021-07-29 15:26:17 (13084): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-29 15:26:17 (13084): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-29 15:26:17 (13084): Starting VM using VBoxManage interface. (boinc_cd3217c2614ed042, slot#1) 2021-07-29 15:26:23 (13084): Successfully started VM. (PID = '14596') 2021-07-29 15:26:23 (13084): Reporting VM Process ID to BOINC. 2021-07-29 15:26:23 (13084): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-29 15:26:23 (13084): Guest Log: CPUID EDX: 0x178bfbff 2021-07-29 15:26:23 (13084): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-29 15:26:23 (13084): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-29 15:26:23 (13084): Detected: Web Application Enabled (http://localhost:56984) 2021-07-29 15:26:23 (13084): Detected: Remote Desktop Enabled (localhost:56985) 2021-07-29 15:26:23 (13084): Preference change detected 2021-07-29 15:26:23 (13084): Setting CPU throttle for VM. (50%) 2021-07-29 15:26:23 (13084): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-29 15:26:25 (13084): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-29 15:26:25 (13084): Guest Log: BIOS: Booting from Hard Disk... 2021-07-29 15:26:26 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 15:26:36 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 15:26:37 (13084): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-29 15:26:37 (13084): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-29 15:27:09 (13084): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-29 15:27:09 (13084): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-29 15:27:11 (13084): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.000108 main Log opened 2021-07-29T13:27:09.861637000Z 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.000182 main OS Product: Linux 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.000224 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.000252 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.000287 main Executable: /usr/sbin/VBoxService 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.000288 main Process ID: 2160 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.000289 main Package type: LINUX_64BITS_GENERIC 2021-07-29 15:27:11 (13084): Guest Log: 00:00:00.003679 main 5.2.6 r120293 started. Verbose level = 0 2021-07-29 15:27:58 (13084): Guest Log: [INFO] Mounting the shared directory 2021-07-29 15:27:58 (13084): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-29 15:27:58 (13084): Guest Log: [INFO] Testing connection to cern.ch 2021-07-29 15:28:00 (13084): Guest Log: [INFO] Testing connection to VCCS 2021-07-29 15:28:00 (13084): Guest Log: [INFO] Testing connection to HTCondor 2021-07-29 15:28:00 (13084): Guest Log: [INFO] Testing connection to WMAgent 2021-07-29 15:28:00 (13084): Guest Log: [INFO] Testing connection to Frontier 2021-07-29 15:28:01 (13084): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-07-29 15:28:01 (13084): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-07-29 15:28:01 (13084): Guest Log: [INFO] This makes the application less efficient. 2021-07-29 15:28:02 (13084): Guest Log: [INFO] It also puts higher load on the project servers. 2021-07-29 15:28:02 (13084): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-07-29 15:28:02 (13084): Guest Log: [INFO] Advice can be found in the project forum. 2021-07-29 15:28:03 (13084): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-29 15:28:11 (13084): Guest Log: [INFO] Probing CVMFS ... 2021-07-29 15:28:15 (13084): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-29 15:28:16 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 15:28:36 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 15:28:40 (13084): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-29 15:28:53 (13084): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-29 15:29:05 (13084): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-29 15:29:17 (13084): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-07-29 15:29:31 (13084): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-07-29 15:29:33 (13084): 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 2021-07-29 15:29:33 (13084): Guest Log: 2.7.2.0 2876 1 28176 15835 2 1 2252089 10240000 2 65024 0 8 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-07-29 15:29:37 (13084): Guest Log: [INFO] Reading volunteer information 2021-07-29 15:29:39 (13084): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-07-29 15:29:40 (13084): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-07-29 15:29:42 (13084): Guest Log: [INFO] CMS application starting. Check log files. 2021-07-29 15:42:28 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 15:42:38 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 15:51:28 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 15:51:38 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 15:55:19 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 15:55:29 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 15:55:59 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 15:56:09 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 16:00:19 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 16:00:29 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 16:07:56 (13084): Status Report: Job Duration: '64800.000000' 2021-07-29 16:07:56 (13084): Status Report: Elapsed Time: '6000.000000' 2021-07-29 16:07:56 (13084): Status Report: CPU Time: '3577.437500' 2021-07-29 16:21:01 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 16:21:11 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 16:23:51 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 16:24:01 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 17:18:15 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 17:18:25 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 17:48:34 (13084): Status Report: Job Duration: '64800.000000' 2021-07-29 17:48:34 (13084): Status Report: Elapsed Time: '12000.000000' 2021-07-29 17:48:34 (13084): Status Report: CPU Time: '7205.609375' 2021-07-29 18:38:10 (13084): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-29 18:38:20 (13084): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-29 18:40:52 (13084): Stopping VM. 2021-07-29 18:40:52 (13084): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_cd3217c2614ed042" savestate Output: 2021-07-29 18:40:52 (13084): VM did not stop when requested. 2021-07-29 18:40:52 (13084): VM was successfully terminated. 2021-07-30 18:02:47 (12668): Detected: vboxwrapper 26197 2021-07-30 18:02:47 (12668): Detected: BOINC client v7.7 2021-07-30 18:02:48 (12668): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-30 18:02:49 (12668): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-30 18:02:49 (12668): Starting VM using VBoxManage interface. (boinc_cd3217c2614ed042, slot#1) 2021-07-30 18:02:56 (12668): Successfully started VM. (PID = '14400') 2021-07-30 18:02:56 (12668): Reporting VM Process ID to BOINC. 2021-07-30 18:02:56 (12668): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-30 18:02:56 (12668): Guest Log: CPUID EDX: 0x178bfbff 2021-07-30 18:02:56 (12668): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-30 18:02:56 (12668): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-30 18:02:56 (12668): Detected: Web Application Enabled (http://localhost:56984) 2021-07-30 18:02:56 (12668): Detected: Remote Desktop Enabled (localhost:56985) 2021-07-30 18:02:56 (12668): Status Report: Job Duration: '64800.000000' 2021-07-30 18:02:56 (12668): Status Report: Elapsed Time: '15124.000000' 2021-07-30 18:02:56 (12668): Status Report: CPU Time: '9090.890625' 2021-07-30 18:02:56 (12668): Preference change detected 2021-07-30 18:02:56 (12668): Setting CPU throttle for VM. (50%) 2021-07-30 18:02:56 (12668): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-30 18:02:58 (12668): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-30 18:02:58 (12668): Guest Log: BIOS: Booting from Hard Disk... 2021-07-30 18:02:59 (12668): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-30 18:03:09 (12668): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-30 18:03:10 (12668): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-30 18:03:10 (12668): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-30 18:03:41 (12668): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-30 18:03:41 (12668): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-30 18:03:43 (12668): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.000179 main Log opened 2021-07-30T16:03:42.823406000Z 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.001184 main OS Product: Linux 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.001236 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.001265 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.001295 main Executable: /usr/sbin/VBoxService 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.001296 main Process ID: 2156 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.001297 main Package type: LINUX_64BITS_GENERIC 2021-07-30 18:03:43 (12668): Guest Log: 00:00:00.013002 main 5.2.6 r120293 started. Verbose level = 0 2021-07-30 18:04:37 (12668): Guest Log: [INFO] Mounting the shared directory 2021-07-30 18:04:37 (12668): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-30 18:04:38 (12668): Guest Log: [INFO] Testing connection to cern.ch 2021-07-30 18:04:38 (12668): Guest Log: [INFO] Testing connection to VCCS 2021-07-30 18:04:38 (12668): Guest Log: [INFO] Testing connection to HTCondor 2021-07-30 18:04:39 (12668): Guest Log: [INFO] Testing connection to WMAgent 2021-07-30 18:04:39 (12668): Guest Log: [INFO] Testing connection to Frontier 2021-07-30 18:04:40 (12668): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-07-30 18:04:41 (12668): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-07-30 18:04:41 (12668): Guest Log: [INFO] This makes the application less efficient. 2021-07-30 18:04:41 (12668): Guest Log: [INFO] It also puts higher load on the project servers. 2021-07-30 18:04:41 (12668): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-07-30 18:04:42 (12668): Guest Log: [INFO] Advice can be found in the project forum. 2021-07-30 18:04:42 (12668): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-30 18:04:49 (12668): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-30 18:05:19 (12668): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-30 18:05:20 (12668): Guest Log: [INFO] Probing CVMFS ... 2021-07-30 18:05:25 (12668): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-30 18:05:29 (12668): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-30 18:05:39 (12668): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-30 18:05:39 (12668): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-30 18:05:54 (12668): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-30 18:06:07 (12668): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-30 18:06:20 (12668): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-07-30 18:06:35 (12668): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-07-30 18:06:37 (12668): 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 2021-07-30 18:06:37 (12668): Guest Log: 2.7.2.0 2887 1 28096 15843 2 1 2379435 10240001 2 65024 0 8 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-07-30 18:06:41 (12668): Guest Log: [INFO] Reading volunteer information 2021-07-30 18:06:43 (12668): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-07-30 18:06:44 (12668): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-07-30 18:06:46 (12668): Guest Log: [INFO] CMS application starting. Check log files. 2021-07-30 18:07:29 (12668): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-30 18:07:39 (12668): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-30 18:09:29 (12668): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-30 18:09:39 (12668): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-30 18:48:42 (12668): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-30 18:48:52 (12668): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-30 19:04:44 (12668): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-30 19:04:54 (12668): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-30 19:12:31 (12668): Stopping VM. 2021-07-30 19:12:32 (12668): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_cd3217c2614ed042" savestate Output: 2021-07-30 19:12:32 (12668): VM did not stop when requested. 2021-07-30 19:12:32 (12668): VM was successfully terminated. 2021-07-31 20:04:34 (13220): Detected: vboxwrapper 26197 2021-07-31 20:04:34 (13220): Detected: BOINC client v7.7 2021-07-31 20:04:36 (13220): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-31 20:04:37 (13220): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-31 20:04:37 (13220): Starting VM using VBoxManage interface. (boinc_cd3217c2614ed042, slot#1) 2021-07-31 20:04:43 (13220): Successfully started VM. (PID = '15316') 2021-07-31 20:04:43 (13220): Reporting VM Process ID to BOINC. 2021-07-31 20:04:43 (13220): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-31 20:04:43 (13220): Guest Log: CPUID EDX: 0x178bfbff 2021-07-31 20:04:43 (13220): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-31 20:04:43 (13220): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-31 20:04:43 (13220): Detected: Web Application Enabled (http://localhost:56984) 2021-07-31 20:04:43 (13220): Detected: Remote Desktop Enabled (localhost:56985) 2021-07-31 20:04:43 (13220): Status Report: Job Duration: '64800.000000' 2021-07-31 20:04:43 (13220): Status Report: Elapsed Time: '19199.000000' 2021-07-31 20:04:43 (13220): Status Report: CPU Time: '11524.531250' 2021-07-31 20:04:43 (13220): Preference change detected 2021-07-31 20:04:43 (13220): Setting CPU throttle for VM. (50%) 2021-07-31 20:04:44 (13220): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-31 20:04:45 (13220): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-31 20:04:55 (13220): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-31 20:04:55 (13220): Guest Log: BIOS: Booting from Hard Disk... 2021-07-31 20:04:55 (13220): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-31 20:04:57 (13220): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-31 20:04:57 (13220): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-31 20:05:29 (13220): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-31 20:05:29 (13220): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-31 20:05:31 (13220): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.000086 main Log opened 2021-07-31T18:05:31.386631000Z 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.000168 main OS Product: Linux 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.000199 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.000226 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.000255 main Executable: /usr/sbin/VBoxService 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.000256 main Process ID: 2164 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.000257 main Package type: LINUX_64BITS_GENERIC 2021-07-31 20:05:31 (13220): Guest Log: 00:00:00.001845 main 5.2.6 r120293 started. Verbose level = 0 2021-07-31 20:06:28 (13220): Guest Log: [INFO] Mounting the shared directory 2021-07-31 20:06:28 (13220): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-31 20:06:29 (13220): Guest Log: [INFO] Testing connection to cern.ch 2021-07-31 20:06:29 (13220): Guest Log: [INFO] Testing connection to VCCS 2021-07-31 20:06:29 (13220): Guest Log: [INFO] Testing connection to HTCondor 2021-07-31 20:06:30 (13220): Guest Log: [INFO] Testing connection to WMAgent 2021-07-31 20:06:31 (13220): Guest Log: [INFO] Testing connection to Frontier 2021-07-31 20:06:32 (13220): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-07-31 20:06:32 (13220): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-07-31 20:06:32 (13220): Guest Log: [INFO] This makes the application less efficient. 2021-07-31 20:06:32 (13220): Guest Log: [INFO] It also puts higher load on the project servers. 2021-07-31 20:06:32 (13220): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-07-31 20:06:33 (13220): Guest Log: [INFO] Advice can be found in the project forum. 2021-07-31 20:06:33 (13220): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-31 20:06:35 (13220): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-31 20:07:05 (13220): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-31 20:07:13 (13220): Guest Log: [INFO] Probing CVMFS ... 2021-07-31 20:07:18 (13220): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-31 20:07:23 (13220): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-31 20:07:38 (13220): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-31 20:07:52 (13220): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-31 20:07:52 (13220): Stopping VM. 2021-07-31 20:07:52 (13220): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_cd3217c2614ed042" savestate Output: 2021-07-31 20:07:52 (13220): VM did not stop when requested. 2021-07-31 20:07:52 (13220): VM was successfully terminated. 2021-08-06 09:32:43 (14316): Detected: vboxwrapper 26197 2021-08-06 09:32:43 (14316): Detected: BOINC client v7.7 2021-08-06 09:32:49 (14316): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-08-06 09:32:50 (14316): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-08-06 09:32:50 (14316): Starting VM using VBoxManage interface. (boinc_cd3217c2614ed042, slot#1) 2021-08-06 09:33:00 (14316): Successfully started VM. (PID = '10132') 2021-08-06 09:33:00 (14316): Reporting VM Process ID to BOINC. 2021-08-06 09:33:00 (14316): Guest Log: BIOS: VirtualBox 6.1.12 2021-08-06 09:33:00 (14316): Guest Log: CPUID EDX: 0x178bfbff 2021-08-06 09:33:00 (14316): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-08-06 09:33:00 (14316): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-08-06 09:33:00 (14316): Detected: Web Application Enabled (http://localhost:56984) 2021-08-06 09:33:00 (14316): Detected: Remote Desktop Enabled (localhost:56985) 2021-08-06 09:33:02 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 09:33:03 (14316): Status Report: Job Duration: '64800.000000' 2021-08-06 09:33:03 (14316): Status Report: Elapsed Time: '19345.000000' 2021-08-06 09:33:03 (14316): Status Report: CPU Time: '11594.375000' 2021-08-06 09:33:03 (14316): Preference change detected 2021-08-06 09:33:03 (14316): Setting CPU throttle for VM. (50%) 2021-08-06 09:33:03 (14316): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-08-06 09:33:04 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 09:33:05 (14316): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-08-06 09:33:05 (14316): Guest Log: BIOS: Booting from Hard Disk... 2021-08-06 09:33:07 (14316): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-08-06 09:33:07 (14316): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-08-06 09:33:14 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 09:33:33 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 09:33:43 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 09:34:03 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 09:34:32 (14316): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-08-06 09:34:32 (14316): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-08-06 09:34:36 (14316): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.000234 main Log opened 2021-08-06T07:34:37.290529000Z 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.000573 main OS Product: Linux 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.000701 main OS Release: 4.14.232-19.cernvm.x86_64 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.000775 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.000846 main Executable: /usr/sbin/VBoxService 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.000848 main Process ID: 2162 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.000850 main Package type: LINUX_64BITS_GENERIC 2021-08-06 09:34:36 (14316): Guest Log: 00:00:00.055052 main 5.2.6 r120293 started. Verbose level = 0 2021-08-06 09:35:24 (14316): Guest Log: [INFO] Mounting the shared directory 2021-08-06 09:35:24 (14316): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-08-06 09:35:24 (14316): Guest Log: [INFO] Testing connection to cern.ch 2021-08-06 09:35:25 (14316): Guest Log: [INFO] Testing connection to VCCS 2021-08-06 09:35:25 (14316): Guest Log: [INFO] Testing connection to HTCondor 2021-08-06 09:35:26 (14316): Guest Log: [INFO] Testing connection to WMAgent 2021-08-06 09:35:27 (14316): Guest Log: [INFO] Testing connection to Frontier 2021-08-06 09:35:29 (14316): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-08-06 09:35:29 (14316): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-08-06 09:35:29 (14316): Guest Log: [INFO] This makes the application less efficient. 2021-08-06 09:35:30 (14316): Guest Log: [INFO] It also puts higher load on the project servers. 2021-08-06 09:35:30 (14316): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-08-06 09:35:30 (14316): Guest Log: [INFO] Advice can be found in the project forum. 2021-08-06 09:35:30 (14316): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-08-06 09:35:41 (14316): Guest Log: [INFO] Probing CVMFS ... 2021-08-06 09:35:47 (14316): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-08-06 09:35:53 (14316): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-08-06 09:36:10 (14316): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-08-06 09:36:23 (14316): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-08-06 09:36:35 (14316): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-08-06 09:36:48 (14316): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-08-06 09:36:51 (14316): 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 2021-08-06 09:36:51 (14316): Guest Log: 2.7.2.0 2883 1 28124 15897 2 1 2520247 10240001 2 65024 0 8 100 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-08-06 09:37:07 (14316): Guest Log: [INFO] Reading volunteer information 2021-08-06 09:37:08 (14316): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-08-06 09:37:10 (14316): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-08-06 09:37:12 (14316): Guest Log: [INFO] CMS application starting. Check log files. 2021-08-06 09:43:35 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 09:43:44 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 09:44:55 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 09:45:05 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 09:53:45 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 09:53:55 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 09:54:55 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 09:55:05 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:00:25 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:00:36 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:01:27 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:01:37 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:06:47 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:06:57 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:08:07 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:08:17 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:10:37 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:10:47 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:14:17 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:14:27 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:14:57 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:15:07 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:19:28 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:19:38 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:43:50 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:44:00 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 10:52:11 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 10:52:21 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:16:23 (14316): Status Report: Job Duration: '64800.000000' 2021-08-06 11:16:23 (14316): Status Report: Elapsed Time: '25345.000000' 2021-08-06 11:16:23 (14316): Status Report: CPU Time: '15202.937500' 2021-08-06 11:19:33 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:19:43 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:22:54 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:23:04 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:23:43 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:23:54 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:29:25 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:29:35 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:30:25 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:30:35 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:32:55 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:33:05 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:37:45 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:37:55 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:39:15 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:39:25 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:39:45 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:39:55 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:41:15 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:41:25 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:51:17 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:51:27 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 11:52:57 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 11:53:07 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:03:47 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 12:03:57 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:04:47 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 12:04:57 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:15:19 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 12:15:29 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:16:19 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 12:16:29 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:20:49 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 12:20:59 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:48:42 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 12:48:52 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:53:02 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 12:53:12 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 12:59:59 (14316): Status Report: Job Duration: '64800.000000' 2021-08-06 12:59:59 (14316): Status Report: Elapsed Time: '31345.000000' 2021-08-06 12:59:59 (14316): Status Report: CPU Time: '18843.640625' 2021-08-06 14:40:04 (14316): Status Report: Job Duration: '64800.000000' 2021-08-06 14:40:04 (14316): Status Report: Elapsed Time: '37345.000000' 2021-08-06 14:40:04 (14316): Status Report: CPU Time: '22474.031250' 2021-08-06 14:41:14 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 14:41:24 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 14:50:34 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 14:50:44 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 14:55:05 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 14:55:15 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:02:16 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:02:26 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:02:46 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:02:56 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:11:36 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:11:46 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:16:07 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:16:17 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:17:17 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:17:27 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:19:38 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:19:48 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:20:18 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:20:28 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:21:28 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:21:38 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:29:08 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:29:18 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:34:59 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:35:09 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:35:29 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:35:39 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:39:59 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:40:09 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:55:20 (14316): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-06 15:55:30 (14316): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-06 15:56:10 (14316): Stopping VM. 2021-08-06 15:56:10 (14316): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_cd3217c2614ed042" savestate Output: 2021-08-06 15:56:10 (14316): VM did not stop when requested. 2021-08-06 15:56:10 (14316): VM was successfully terminated. 2021-08-08 16:48:06 (15052): Detected: vboxwrapper 26197 2021-08-08 16:48:06 (15052): Detected: BOINC client v7.7 2021-08-08 16:48:09 (15052): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-08-08 16:48:09 (15052): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-08-08 16:48:10 (15052): Starting VM using VBoxManage interface. (boinc_cd3217c2614ed042, slot#1) 2021-08-08 16:48:15 (15052): Successfully started VM. (PID = '5964') 2021-08-08 16:48:15 (15052): Reporting VM Process ID to BOINC. 2021-08-08 16:48:15 (15052): Guest Log: BIOS: VirtualBox 6.1.12 2021-08-08 16:48:15 (15052): Guest Log: CPUID EDX: 0x178bfbff 2021-08-08 16:48:15 (15052): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-08-08 16:48:15 (15052): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-08-08 16:48:15 (15052): Detected: Web Application Enabled (http://localhost:56984) 2021-08-08 16:48:15 (15052): Detected: Remote Desktop Enabled (localhost:56985) 2021-08-08 16:48:15 (15052): Status Report: Job Duration: '64800.000000' 2021-08-08 16:48:15 (15052): Status Report: Elapsed Time: '41731.000000' 2021-08-08 16:48:15 (15052): Status Report: CPU Time: '25132.859375' 2021-08-08 16:48:15 (15052): Preference change detected 2021-08-08 16:48:15 (15052): Setting CPU throttle for VM. (50%) 2021-08-08 16:48:15 (15052): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-08-08 16:48:17 (15052): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-08-08 16:48:17 (15052): Guest Log: BIOS: Booting from Hard Disk... 2021-08-08 16:48:18 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 16:48:28 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 16:48:29 (15052): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-08-08 16:48:29 (15052): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-08-08 16:49:01 (15052): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-08-08 16:49:01 (15052): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-08-08 16:49:04 (15052): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.000156 main Log opened 2021-08-08T14:49:04.370510000Z 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.000323 main OS Product: Linux 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.000497 main OS Release: 4.14.232-19.cernvm.x86_64 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.000588 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.000654 main Executable: /usr/sbin/VBoxService 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.000656 main Process ID: 2160 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.000657 main Package type: LINUX_64BITS_GENERIC 2021-08-08 16:49:04 (15052): Guest Log: 00:00:00.004791 main 5.2.6 r120293 started. Verbose level = 0 2021-08-08 16:49:08 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 16:49:18 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 16:50:02 (15052): Guest Log: [INFO] Mounting the shared directory 2021-08-08 16:50:03 (15052): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-08-08 16:50:03 (15052): Guest Log: [INFO] Testing connection to cern.ch 2021-08-08 16:50:04 (15052): Guest Log: [INFO] Testing connection to VCCS 2021-08-08 16:50:04 (15052): Guest Log: [INFO] Testing connection to HTCondor 2021-08-08 16:50:05 (15052): Guest Log: [INFO] Testing connection to WMAgent 2021-08-08 16:50:06 (15052): Guest Log: [INFO] Testing connection to Frontier 2021-08-08 16:50:07 (15052): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-08-08 16:50:07 (15052): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-08-08 16:50:08 (15052): Guest Log: [INFO] This makes the application less efficient. 2021-08-08 16:50:08 (15052): Guest Log: [INFO] It also puts higher load on the project servers. 2021-08-08 16:50:09 (15052): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-08-08 16:50:10 (15052): Guest Log: [INFO] Advice can be found in the project forum. 2021-08-08 16:50:10 (15052): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-08-08 16:50:24 (15052): Guest Log: [INFO] Probing CVMFS ... 2021-08-08 16:50:32 (15052): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-08-08 16:50:38 (15052): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-08-08 16:50:51 (15052): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-08-08 16:51:04 (15052): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-08-08 16:51:17 (15052): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-08-08 16:51:29 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 16:51:39 (15052): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-08-08 16:51:39 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 16:51:41 (15052): 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 2021-08-08 16:51:41 (15052): Guest Log: 2.7.2.0 2875 1 28100 15915 2 1 2704364 10240001 2 65024 0 8 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-08-08 16:51:44 (15052): Guest Log: [INFO] Reading volunteer information 2021-08-08 16:51:46 (15052): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-08-08 16:51:49 (15052): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-08-08 16:51:51 (15052): Guest Log: [INFO] CMS application starting. Check log files. 2021-08-08 17:05:19 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:05:29 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:07:59 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:08:09 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:11:50 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:12:00 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:15:31 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:15:41 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:18:31 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:18:41 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:28:42 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:28:52 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:29:02 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:29:12 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:31:02 (15052): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 17:31:12 (15052): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 17:33:13 (15052): Stopping VM. 2021-08-08 17:33:14 (15052): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_cd3217c2614ed042" savestate Output: 2021-08-08 17:33:14 (15052): VM did not stop when requested. 2021-08-08 17:33:14 (15052): VM was successfully terminated. 2021-08-08 23:03:45 (1144): Detected: vboxwrapper 26197 2021-08-08 23:03:45 (1144): Detected: BOINC client v7.7 2021-08-08 23:03:50 (1144): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-08-08 23:03:52 (1144): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-08-08 23:03:52 (1144): Starting VM using VBoxManage interface. (boinc_cd3217c2614ed042, slot#1) 2021-08-08 23:03:59 (1144): Successfully started VM. (PID = '13848') 2021-08-08 23:03:59 (1144): Reporting VM Process ID to BOINC. 2021-08-08 23:03:59 (1144): Guest Log: BIOS: VirtualBox 6.1.12 2021-08-08 23:03:59 (1144): Guest Log: CPUID EDX: 0x178bfbff 2021-08-08 23:03:59 (1144): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-08-08 23:03:59 (1144): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-08-08 23:03:59 (1144): Detected: Web Application Enabled (http://localhost:56984) 2021-08-08 23:03:59 (1144): Detected: Remote Desktop Enabled (localhost:56985) 2021-08-08 23:04:00 (1144): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 23:04:16 (1144): Status Report: Job Duration: '64800.000000' 2021-08-08 23:04:16 (1144): Status Report: Elapsed Time: '44307.000000' 2021-08-08 23:04:16 (1144): Status Report: CPU Time: '26667.750000' 2021-08-08 23:04:16 (1144): Preference change detected 2021-08-08 23:04:16 (1144): Setting CPU throttle for VM. (50%) 2021-08-08 23:04:16 (1144): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-08-08 23:04:17 (1144): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 23:04:18 (1144): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-08-08 23:04:18 (1144): Guest Log: BIOS: Booting from Hard Disk... 2021-08-08 23:04:20 (1144): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-08-08 23:04:20 (1144): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-08-08 23:04:53 (1144): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-08-08 23:04:53 (1144): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-08-08 23:04:56 (1144): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.000270 main Log opened 2021-08-08T21:04:58.024701000Z 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.000581 main OS Product: Linux 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.001976 main OS Release: 4.14.232-19.cernvm.x86_64 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.002102 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.002207 main Executable: /usr/sbin/VBoxService 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.002210 main Process ID: 2154 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.002213 main Package type: LINUX_64BITS_GENERIC 2021-08-08 23:04:56 (1144): Guest Log: 00:00:00.008215 main 5.2.6 r120293 started. Verbose level = 0 2021-08-08 23:04:57 (1144): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 23:05:07 (1144): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-08 23:06:32 (1144): Guest Log: [INFO] Mounting the shared directory 2021-08-08 23:06:33 (1144): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-08-08 23:06:34 (1144): Guest Log: [INFO] Testing connection to cern.ch 2021-08-08 23:06:35 (1144): Guest Log: [INFO] Testing connection to VCCS 2021-08-08 23:06:36 (1144): Guest Log: [INFO] Testing connection to HTCondor 2021-08-08 23:06:37 (1144): Guest Log: [INFO] Testing connection to WMAgent 2021-08-08 23:06:38 (1144): Guest Log: [INFO] Testing connection to Frontier 2021-08-08 23:06:41 (1144): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-08-08 23:06:41 (1144): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-08-08 23:06:42 (1144): Guest Log: [INFO] This makes the application less efficient. 2021-08-08 23:06:42 (1144): Guest Log: [INFO] It also puts higher load on the project servers. 2021-08-08 23:06:43 (1144): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-08-08 23:06:44 (1144): Guest Log: [INFO] Advice can be found in the project forum. 2021-08-08 23:06:44 (1144): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-08-08 23:07:04 (1144): Guest Log: [INFO] Probing CVMFS ... 2021-08-08 23:07:13 (1144): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-08-08 23:07:22 (1144): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-08-08 23:07:47 (1144): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-08-08 23:08:09 (1144): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-08-08 23:08:33 (1144): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-08-08 23:08:55 (1144): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-08-08 23:09:00 (1144): 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 2021-08-08 23:09:00 (1144): Guest Log: 2.7.2.0 2908 2 28120 15917 2 1 2753485 10240001 2 65024 0 8 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-08-08 23:09:08 (1144): Guest Log: [INFO] Reading volunteer information 2021-08-08 23:09:11 (1144): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-08-08 23:09:14 (1144): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-08-08 23:09:19 (1144): Guest Log: [INFO] CMS application starting. Check log files. 2021-08-08 23:15:07 (1144): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-08 23:15:17 (1144): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 00:05:53 (1144): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 00:06:13 (1144): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 00:45:03 (1144): Status Report: Job Duration: '64800.000000' 2021-08-09 00:45:03 (1144): Status Report: Elapsed Time: '50307.000000' 2021-08-09 00:45:03 (1144): Status Report: CPU Time: '30290.281250' 2021-08-09 01:08:00 (1144): Stopping VM. 2021-08-09 01:08:00 (1144): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_cd3217c2614ed042" savestate Output: 2021-08-09 01:08:00 (1144): VM did not stop when requested. 2021-08-09 01:08:00 (1144): VM was successfully terminated. 2021-08-09 21:51:44 (11816): Detected: vboxwrapper 26197 2021-08-09 21:51:44 (11816): Detected: BOINC client v7.7 2021-08-09 21:51:46 (11816): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-08-09 21:51:46 (11816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-08-09 21:51:46 (11816): Starting VM using VBoxManage interface. (boinc_cd3217c2614ed042, slot#1) 2021-08-09 21:51:51 (11816): Successfully started VM. (PID = '13180') 2021-08-09 21:51:51 (11816): Reporting VM Process ID to BOINC. 2021-08-09 21:51:51 (11816): Guest Log: BIOS: VirtualBox 6.1.12 2021-08-09 21:51:51 (11816): Guest Log: CPUID EDX: 0x178bfbff 2021-08-09 21:51:51 (11816): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-08-09 21:51:51 (11816): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-08-09 21:51:51 (11816): Detected: Web Application Enabled (http://localhost:56984) 2021-08-09 21:51:51 (11816): Detected: Remote Desktop Enabled (localhost:56985) 2021-08-09 21:51:51 (11816): Status Report: Job Duration: '64800.000000' 2021-08-09 21:51:51 (11816): Status Report: Elapsed Time: '51683.000000' 2021-08-09 21:51:51 (11816): Status Report: CPU Time: '31119.703125' 2021-08-09 21:51:51 (11816): Preference change detected 2021-08-09 21:51:51 (11816): Setting CPU throttle for VM. (50%) 2021-08-09 21:51:51 (11816): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-08-09 21:51:53 (11816): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-08-09 21:51:53 (11816): Guest Log: BIOS: Booting from Hard Disk... 2021-08-09 21:51:55 (11816): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-08-09 21:51:55 (11816): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-08-09 21:52:26 (11816): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-08-09 21:52:26 (11816): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-08-09 21:52:28 (11816): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.000089 main Log opened 2021-08-09T19:52:30.160012000Z 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.000189 main OS Product: Linux 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.000232 main OS Release: 4.14.232-19.cernvm.x86_64 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.000277 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.000307 main Executable: /usr/sbin/VBoxService 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.000307 main Process ID: 2159 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.000308 main Package type: LINUX_64BITS_GENERIC 2021-08-09 21:52:28 (11816): Guest Log: 00:00:00.003410 main 5.2.6 r120293 started. Verbose level = 0 2021-08-09 21:52:55 (11816): Guest Log: [INFO] Mounting the shared directory 2021-08-09 21:52:55 (11816): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-08-09 21:52:55 (11816): Guest Log: [INFO] Testing connection to cern.ch 2021-08-09 21:52:56 (11816): Guest Log: [INFO] Testing connection to VCCS 2021-08-09 21:52:56 (11816): Guest Log: [INFO] Testing connection to HTCondor 2021-08-09 21:52:56 (11816): Guest Log: [INFO] Testing connection to WMAgent 2021-08-09 21:52:57 (11816): Guest Log: [INFO] Testing connection to Frontier 2021-08-09 21:52:58 (11816): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-08-09 21:52:59 (11816): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-08-09 21:52:59 (11816): Guest Log: [INFO] This makes the application less efficient. 2021-08-09 21:52:59 (11816): Guest Log: [INFO] It also puts higher load on the project servers. 2021-08-09 21:53:00 (11816): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-08-09 21:53:00 (11816): Guest Log: [INFO] Advice can be found in the project forum. 2021-08-09 21:53:00 (11816): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-08-09 21:53:13 (11816): Guest Log: [INFO] Probing CVMFS ... 2021-08-09 21:53:18 (11816): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-08-09 21:53:25 (11816): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-08-09 21:53:39 (11816): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-08-09 21:53:46 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 21:54:16 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 21:54:18 (11816): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-08-09 21:54:26 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 21:54:36 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 21:54:38 (11816): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-08-09 21:54:46 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 21:54:56 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 21:55:02 (11816): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-08-09 21:55:04 (11816): 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 2021-08-09 21:55:04 (11816): Guest Log: 2.7.2.0 2853 1 28120 15925 2 1 2848116 10240001 2 65024 0 8 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-08-09 21:55:08 (11816): Guest Log: [INFO] Reading volunteer information 2021-08-09 21:55:09 (11816): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-08-09 21:55:11 (11816): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-08-09 21:55:13 (11816): Guest Log: [INFO] CMS application starting. Check log files. 2021-08-09 22:04:47 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:04:57 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 22:19:18 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:19:28 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 22:20:48 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:20:58 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 22:25:29 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:25:39 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 22:31:20 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:31:30 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 22:35:00 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:35:10 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 22:35:20 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:35:30 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 22:40:50 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 22:41:01 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:00:02 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:00:12 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:01:22 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:01:32 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:24:35 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:24:45 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:28:45 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:28:55 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:29:35 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:29:45 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:35:13 (11816): Status Report: Job Duration: '64800.000000' 2021-08-09 23:35:13 (11816): Status Report: Elapsed Time: '57683.000000' 2021-08-09 23:35:13 (11816): Status Report: CPU Time: '34732.515625' 2021-08-09 23:37:35 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:37:45 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:41:57 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:42:07 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-09 23:42:27 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-09 23:42:37 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:00:10 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:01:59 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:02:09 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:02:19 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:02:39 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:02:49 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:19:40 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:20:00 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:30:01 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:30:10 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:33:10 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:33:21 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:52:41 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:52:51 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:54:31 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:54:41 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:55:51 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:56:01 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:56:21 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:56:31 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:58:02 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:58:12 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 00:59:12 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 00:59:22 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 01:00:52 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 01:01:02 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 01:07:22 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 01:07:32 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 01:20:18 (11816): Status Report: Job Duration: '64800.000000' 2021-08-10 01:20:18 (11816): Status Report: Elapsed Time: '63683.000000' 2021-08-10 01:20:18 (11816): Status Report: CPU Time: '38364.640625' 2021-08-10 01:23:23 (11816): VM state change detected. (old = 'Running', new = 'Paused') 2021-08-10 01:23:33 (11816): VM state change detected. (old = 'Paused', new = 'Running') 2021-08-10 01:39:08 (11816): Powering off VM. 2021-08-10 01:44:09 (11816): VM did not power off when requested. 2021-08-10 01:44:09 (11816): VM was successfully terminated. 2021-08-10 01:44:09 (11816): Deregistering VM. (boinc_cd3217c2614ed042, sl
©2024 CERN