| Name | CMS_1961450_1741022198.371339_0 |
| Workunit | 230681703 |
| Created | 3 Mar 2025, 17:16:42 UTC |
| Sent | 3 Mar 2025, 17:29:39 UTC |
| Report deadline | 3 Apr 2025, 17:29:39 UTC |
| Received | 13 Mar 2025, 3:06:47 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10870675 |
| Run time | 10 hours 35 min 31 sec |
| CPU time | 1 days 4 hours 39 min 20 sec |
| Validate state | Valid |
| Credit | 457.56 |
| Device peak FLOPS | 4.00 GFLOPS |
| Application version | CMS Simulation v70.60 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 82.18 MB |
| Peak swap size | 89.55 MB |
| Peak disk usage | 5.93 GB |
Stderr output
<core_client_version>8.0.4</core_client_version> <![CDATA[ <stderr_txt> 19:24 (22084): Guest Log: 00:00:00.000406 main Log opened 2025-03-08T09:58:57.302864000Z 2025-03-10 09:19:24 (22084): Guest Log: 00:00:00.000546 main OS Product: Linux 2025-03-10 09:19:24 (22084): Guest Log: 00:00:00.000571 main OS Release: 4.14.232-19.cernvm.x86_64 2025-03-10 09:19:24 (22084): Guest Log: 00:00:00.000606 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-03-10 09:19:24 (22084): Guest Log: 00:00:00.000624 main Executable: /usr/sbin/VBoxService 2025-03-10 09:19:24 (22084): Guest Log: 00:00:00.000625 main Process ID: 2290 2025-03-10 09:19:24 (22084): Guest Log: 00:00:00.000625 main Package type: LINUX_64BITS_GENERIC 2025-03-10 09:19:24 (22084): Guest Log: 00:00:00.001259 main 5.2.6 r120293 started. Verbose level = 0 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Mounting the shared directory 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to cern.ch 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to VCCS 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to HTCondor 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to WMAgent 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to EOSCMS 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to CMS-Factory 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Testing connection to Frontier 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Could not find a local HTTP proxy 2025-03-10 09:19:24 (22084): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-03-10 09:19:24 (22084): Guest Log: [INFO] This makes the application less efficient 2025-03-10 09:19:24 (22084): Guest Log: [INFO] It also puts higher load on the project servers 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Advice can be found in the project forum 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-03-10 09:19:24 (22084): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Environment HTTP proxy: not set 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Reading volunteer information 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Using weak account key. 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Using weak account key. 2025-03-10 09:19:24 (22084): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-03-10 09:19:24 (22084): Guest Log: [INFO] CMS application starting. Check log files. 2025-03-10 09:19:24 (22084): Guest Log: 00:00:30.009711 timesync vgsvcTimeSyncWorker: Radical host time change: 3 609 704 000 000ns (HostNow=1 741 431 567 091 000 000 ns HostLast=1 741 427 957 387 000 000 ns) 2025-03-10 09:19:24 (22084): Guest Log: 00:00:40.009977 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 609 780 027 000ns (GuestNow=1 741 431 577 091 620 000 ns GuestLast=1 741 427 967 311 593 000 ns fSetTimeLastLoop=true ) 2025-03-10 09:19:24 (22084): Starting VM using VBoxManage interface. (boinc_c267cd06b66cf459, slot#1) 2025-03-10 09:19:28 (22084): Successfully started VM. (PID = '17396') 2025-03-10 09:19:28 (22084): Reporting VM Process ID to BOINC. 2025-03-10 09:19:28 (22084): Guest Log: BIOS: VirtualBox 6.1.22 2025-03-10 09:19:28 (22084): Guest Log: CPUID EDX: 0x178bfbff 2025-03-10 09:19:28 (22084): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-03-10 09:19:28 (22084): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-03-10 09:19:28 (22084): VM state change detected. (old = 'poweredoff', new = 'running') 2025-03-10 09:19:28 (22084): Detected: Web Application Enabled (http://localhost:59212) 2025-03-10 09:19:28 (22084): Status Report: Job Duration: '64800.000000' 2025-03-10 09:19:28 (22084): Status Report: Elapsed Time: '7385.000000' 2025-03-10 09:19:28 (22084): Status Report: CPU Time: '15735.125000' 2025-03-10 09:19:28 (22084): Preference change detected 2025-03-10 09:19:28 (22084): Setting CPU throttle for VM. (50%) 2025-03-10 09:19:28 (22084): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2025-03-10 09:19:30 (22084): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-03-10 09:19:30 (22084): Guest Log: BIOS: Booting from Hard Disk... 2025-03-10 09:19:33 (22084): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-03-10 09:19:33 (22084): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-03-10 09:19:50 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 09:20:10 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 09:20:24 (22084): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-03-10 09:20:24 (22084): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-03-10 09:20:25 (22084): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.000607 main Log opened 2025-03-10T09:20:25.040609000Z 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.001293 main OS Product: Linux 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.001361 main OS Release: 4.14.232-19.cernvm.x86_64 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.001384 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.001412 main Executable: /usr/sbin/VBoxService 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.001412 main Process ID: 2287 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.001413 main Package type: LINUX_64BITS_GENERIC 2025-03-10 09:20:25 (22084): Guest Log: 00:00:00.002672 main 5.2.6 r120293 started. Verbose level = 0 2025-03-10 09:20:37 (22084): Guest Log: [INFO] Mounting the shared directory 2025-03-10 09:20:37 (22084): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-03-10 09:20:37 (22084): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-03-10 09:20:37 (22084): Guest Log: [INFO] Testing connection to cern.ch 2025-03-10 09:20:38 (22084): Guest Log: [INFO] Testing connection to VCCS 2025-03-10 09:20:38 (22084): Guest Log: [INFO] Testing connection to HTCondor 2025-03-10 09:20:38 (22084): Guest Log: [INFO] Testing connection to WMAgent 2025-03-10 09:20:38 (22084): Guest Log: [INFO] Testing connection to EOSCMS 2025-03-10 09:20:38 (22084): Guest Log: [INFO] Testing connection to CMS-Factory 2025-03-10 09:20:38 (22084): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-03-10 09:20:39 (22084): Guest Log: [INFO] Testing connection to Frontier 2025-03-10 09:20:39 (22084): Guest Log: [INFO] Could not find a local HTTP proxy 2025-03-10 09:20:39 (22084): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-03-10 09:20:39 (22084): Guest Log: [INFO] This makes the application less efficient 2025-03-10 09:20:39 (22084): Guest Log: [INFO] It also puts higher load on the project servers 2025-03-10 09:20:39 (22084): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-03-10 09:20:39 (22084): Guest Log: [INFO] Advice can be found in the project forum 2025-03-10 09:20:40 (22084): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-03-10 09:20:44 (22084): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-03-10 09:20:45 (22084): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-03-10 09:20:45 (22084): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-03-10 09:20:45 (22084): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-03-10 09:20:46 (22084): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-03-10 09:20:47 (22084): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-03-10 09:20:47 (22084): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-03-10 09:20:47 (22084): Guest Log: [INFO] Environment HTTP proxy: not set 2025-03-10 09:20:47 (22084): Guest Log: [INFO] Reading volunteer information 2025-03-10 09:20:48 (22084): Guest Log: [INFO] Using weak account key. 2025-03-10 09:20:48 (22084): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-03-10 09:20:49 (22084): Guest Log: [INFO] Using weak account key. 2025-03-10 09:20:49 (22084): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-03-10 09:20:50 (22084): Guest Log: [INFO] CMS application starting. Check log files. 2025-03-10 09:39:17 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 09:39:57 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 09:54:32 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 09:55:13 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:00:04 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:00:24 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:04:55 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:05:15 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:14:59 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:15:40 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:16:20 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:16:40 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:17:50 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:18:10 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:19:51 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:20:11 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:24:02 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:24:22 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:30:53 (22084): VM state change detected. (old = 'running', new = 'paused') 2025-03-10 10:31:13 (22084): VM state change detected. (old = 'paused', new = 'running') 2025-03-10 10:37:49 (22084): Stopping VM. 2025-03-10 10:38:35 (22084): Error in stop VM for VM: -182 Command: VBoxManage -q controlvm "boinc_c267cd06b66cf459" savestate Output: 0%...10%...20%...30%...40%... 2025-03-10 10:38:35 (22084): VM did not stop when requested. 2025-03-10 10:38:35 (22084): VM was NOT successfully terminated. 2025-03-11 13:50:34 (13664): vboxwrapper version 26208 2025-03-11 13:50:34 (13664): BOINC client version: 8.0.4 2025-03-11 13:50:35 (13664): Detected: VirtualBox VboxManage Interface (Version: 6.1.22) 2025-03-11 13:50:36 (13664): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-03-11 13:50:36 (13664): Guest Log: BIOS: VirtualBox 6.1.22 2025-03-11 13:50:36 (13664): Guest Log: CPUID EDX: 0x178bfbff 2025-03-11 13:50:36 (13664): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-03-11 13:50:36 (13664): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-03-11 13:50:36 (13664): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-03-11 13:50:36 (13664): Guest Log: BIOS: Booting from Hard Disk... 2025-03-11 13:50:36 (13664): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-03-11 13:50:36 (13664): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-03-11 13:50:36 (13664): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-03-11 13:50:36 (13664): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-03-11 13:50:36 (13664): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.000607 main Log opened 2025-03-10T09:20:25.040609000Z 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.001293 main OS Product: Linux 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.001361 main OS Release: 4.14.232-19.cernvm.x86_64 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.001384 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.001412 main Executable: /usr/sbin/VBoxService 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.001412 main Process ID: 2287 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.001413 main Package type: LINUX_64BITS_GENERIC 2025-03-11 13:50:36 (13664): Guest Log: 00:00:00.002672 main 5.2.6 r120293 started. Verbose level = 0 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Mounting the shared directory 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to cern.ch 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to VCCS 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to HTCondor 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to WMAgent 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to EOSCMS 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to CMS-Factory 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Testing connection to Frontier 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Could not find a local HTTP proxy 2025-03-11 13:50:36 (13664): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-03-11 13:50:36 (13664): Guest Log: [INFO] This makes the application less efficient 2025-03-11 13:50:36 (13664): Guest Log: [INFO] It also puts higher load on the project servers 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Advice can be found in the project forum 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-03-11 13:50:36 (13664): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Environment HTTP proxy: not set 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Reading volunteer information 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Using weak account key. 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Using weak account key. 2025-03-11 13:50:36 (13664): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-03-11 13:50:36 (13664): Guest Log: [INFO] CMS application starting. Check log files. 2025-03-11 13:50:36 (13664): Starting VM using VBoxManage interface. (boinc_c267cd06b66cf459, slot#1) 2025-03-11 13:50:40 (13664): Successfully started VM. (PID = '19192') 2025-03-11 13:50:40 (13664): Reporting VM Process ID to BOINC. 2025-03-11 13:50:40 (13664): Guest Log: BIOS: VirtualBox 6.1.22 2025-03-11 13:50:40 (13664): Guest Log: CPUID EDX: 0x178bfbff 2025-03-11 13:50:40 (13664): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-03-11 13:50:40 (13664): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-03-11 13:50:40 (13664): VM state change detected. (old = 'poweredoff', new = 'running') 2025-03-11 13:50:40 (13664): Detected: Web Application Enabled (http://localhost:59212) 2025-03-11 13:50:40 (13664): Status Report: Job Duration: '64800.000000' 2025-03-11 13:50:40 (13664): Status Report: Elapsed Time: '11789.000000' 2025-03-11 13:50:40 (13664): Status Report: CPU Time: '25611.250000' 2025-03-11 13:50:40 (13664): Preference change detected 2025-03-11 13:50:40 (13664): Setting CPU throttle for VM. (50%) 2025-03-11 13:50:41 (13664): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2025-03-11 13:50:42 (13664): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-03-11 13:50:42 (13664): Guest Log: BIOS: Booting from Hard Disk... 2025-03-11 13:50:46 (13664): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-03-11 13:50:46 (13664): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-03-11 13:51:20 (13664): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-03-11 13:51:20 (13664): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-03-11 13:51:21 (13664): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000051 main Log opened 2025-03-11T13:51:22.454985000Z 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000134 main OS Product: Linux 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000176 main OS Release: 4.14.232-19.cernvm.x86_64 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000195 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000242 main Executable: /usr/sbin/VBoxService 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000242 main Process ID: 2284 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000243 main Package type: LINUX_64BITS_GENERIC 2025-03-11 13:51:21 (13664): Guest Log: 00:00:00.000725 main 5.2.6 r120293 started. Verbose level = 0 2025-03-11 13:51:32 (13664): Guest Log: [INFO] Mounting the shared directory 2025-03-11 13:51:33 (13664): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-03-11 13:51:33 (13664): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-03-11 13:51:33 (13664): Guest Log: [INFO] Testing connection to cern.ch 2025-03-11 13:51:33 (13664): Guest Log: [INFO] Testing connection to VCCS 2025-03-11 13:51:33 (13664): Guest Log: [INFO] Testing connection to HTCondor 2025-03-11 13:51:33 (13664): Guest Log: [INFO] Testing connection to WMAgent 2025-03-11 13:51:33 (13664): Guest Log: [INFO] Testing connection to EOSCMS 2025-03-11 13:51:34 (13664): Guest Log: [INFO] Testing connection to CMS-Factory 2025-03-11 13:51:34 (13664): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-03-11 13:51:34 (13664): Guest Log: [INFO] Testing connection to Frontier 2025-03-11 13:51:35 (13664): Guest Log: [INFO] Could not find a local HTTP proxy 2025-03-11 13:51:35 (13664): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-03-11 13:51:35 (13664): Guest Log: [INFO] This makes the application less efficient 2025-03-11 13:51:35 (13664): Guest Log: [INFO] It also puts higher load on the project servers 2025-03-11 13:51:35 (13664): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-03-11 13:51:35 (13664): Guest Log: [INFO] Advice can be found in the project forum 2025-03-11 13:51:35 (13664): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-03-11 13:51:39 (13664): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-03-11 13:51:41 (13664): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-03-11 13:51:41 (13664): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-03-11 13:51:41 (13664): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-03-11 13:52:05 (13664): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-03-11 13:52:07 (13664): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-03-11 13:52:07 (13664): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-03-11 13:52:07 (13664): Guest Log: [INFO] Environment HTTP proxy: not set 2025-03-11 13:52:07 (13664): Guest Log: [INFO] Reading volunteer information 2025-03-11 13:52:08 (13664): Guest Log: [INFO] Using weak account key. 2025-03-11 13:52:08 (13664): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-03-11 13:52:09 (13664): Guest Log: [INFO] Using weak account key. 2025-03-11 13:52:09 (13664): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-03-11 13:52:10 (13664): Guest Log: [INFO] CMS application starting. Check log files. 2025-03-11 13:59:18 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 13:59:38 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:04:39 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:04:59 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:10:20 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:10:40 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:11:00 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:11:21 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:11:41 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:12:01 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:12:21 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:12:41 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:13:01 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:13:21 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:13:41 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:14:02 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:25:54 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:26:14 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:47:08 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:47:28 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:49:08 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:49:28 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:52:48 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:53:08 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 14:54:59 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 14:55:20 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 15:08:22 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 15:08:42 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 15:22:05 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 15:22:25 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 15:36:02 (13664): Status Report: Job Duration: '64800.000000' 2025-03-11 15:36:02 (13664): Status Report: Elapsed Time: '17789.000000' 2025-03-11 15:36:02 (13664): Status Report: CPU Time: '39237.765625' 2025-03-11 15:45:09 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 15:45:29 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 15:47:09 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 15:47:29 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 15:57:52 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 15:58:12 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 16:01:02 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 16:01:22 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 16:10:54 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 16:11:14 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 16:20:16 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 16:20:17 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 16:36:29 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 16:36:50 (13664): VM state change detected. (old = 'paused', new = 'running') 2025-03-11 16:44:01 (13664): VM state change detected. (old = 'running', new = 'paused') 2025-03-11 16:44:06 (13664): Stopping VM. 2025-03-11 16:44:52 (13664): Error in stop VM for VM: -182 Command: VBoxManage -q controlvm "boinc_c267cd06b66cf459" savestate Output: 0%...10%...20%...30%...40%... 2025-03-11 16:44:52 (13664): VM did not stop when requested. 2025-03-11 16:44:52 (13664): VM was NOT successfully terminated. 2025-03-11 17:13:44 (296): vboxwrapper version 26208 2025-03-11 17:13:44 (296): BOINC client version: 8.0.4 2025-03-11 17:13:45 (296): Detected: VirtualBox VboxManage Interface (Version: 6.1.22) 2025-03-11 17:13:45 (296): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-03-11 17:13:46 (296): Guest Log: BIOS: VirtualBox 6.1.22 2025-03-11 17:13:46 (296): Guest Log: CPUID EDX: 0x178bfbff 2025-03-11 17:13:46 (296): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-03-11 17:13:46 (296): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-03-11 17:13:46 (296): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-03-11 17:13:46 (296): Guest Log: BIOS: Booting from Hard Disk... 2025-03-11 17:13:46 (296): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-03-11 17:13:46 (296): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-03-11 17:13:46 (296): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-03-11 17:13:46 (296): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-03-11 17:13:46 (296): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000051 main Log opened 2025-03-11T13:51:22.454985000Z 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000134 main OS Product: Linux 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000176 main OS Release: 4.14.232-19.cernvm.x86_64 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000195 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000242 main Executable: /usr/sbin/VBoxService 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000242 main Process ID: 2284 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000243 main Package type: LINUX_64BITS_GENERIC 2025-03-11 17:13:46 (296): Guest Log: 00:00:00.000725 main 5.2.6 r120293 started. Verbose level = 0 2025-03-11 17:13:46 (296): Guest Log: [INFO] Mounting the shared directory 2025-03-11 17:13:46 (296): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-03-11 17:13:46 (296): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to cern.ch 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to VCCS 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to HTCondor 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to WMAgent 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to EOSCMS 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to CMS-Factory 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-03-11 17:13:46 (296): Guest Log: [INFO] Testing connection to Frontier 2025-03-11 17:13:46 (296): Guest Log: [INFO] Could not find a local HTTP proxy 2025-03-11 17:13:46 (296): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-03-11 17:13:46 (296): Guest Log: [INFO] This makes the application less efficient 2025-03-11 17:13:46 (296): Guest Log: [INFO] It also puts higher load on the project servers 2025-03-11 17:13:46 (296): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-03-11 17:13:46 (296): Guest Log: [INFO] Advice can be found in the project forum 2025-03-11 17:13:46 (296): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-03-11 17:13:46 (296): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-03-11 17:13:46 (296): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-03-11 17:13:46 (296): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-03-11 17:13:46 (296): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-03-11 17:13:46 (296): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-03-11 17:13:46 (296): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-03-11 17:13:46 (296): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2025-03-11 17:13:46 (296): Guest Log: [INFO] Environment HTTP proxy: not set 2025-03-11 17:13:46 (296): Guest Log: [INFO] Reading volunteer information 2025-03-11 17:13:46 (296): Guest Log: [INFO] Using weak account key. 2025-03-11 17:13:46 (296): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-03-11 17:13:46 (296): Guest Log: [INFO] Using weak account key. 2025-03-11 17:13:46 (296): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-03-11 17:13:46 (296): Guest Log: [INFO] CMS application starting. Check log files. 2025-03-11 17:13:46 (296): Starting VM using VBoxManage interface. (boinc_c267cd06b66cf459, slot#1) 2025-03-11 17:13:50 (296): Successfully started VM. (PID = '6968') 2025-03-11 17:13:50 (296): Reporting VM Process ID to BOINC. 2025-03-11 17:13:50 (296): Guest Log: BIOS: VirtualBox 6.1.22 2025-03-11 17:13:50 (296): Guest Log: CPUID EDX: 0x178bfbff 2025-03-11 17:13:50 (296): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-03-11 17:13:50 (296): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-03-11 17:13:50 (296): VM state change detected. (old = 'poweredoff', new = 'running') 2025-03-11 17:13:50 (296): Detected: Web Application Enabled (http://localhost:59212) 2025-03-11 17:13:50 (296): Status Report: Job Duration: '64800.000000' 2025-03-11 17:13:50 (296): Status Report: Elapsed Time: '21734.000000' 2025-03-11 17:13:50 (296): Status Report: CPU Time: '48302.046875' 2025-03-11 17:13:50 (296): Preference change detected 2025-03-11 17:13:50 (296): Setting CPU throttle for VM. (50%) 2025-03-11 17:13:50 (296): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2025-03-11 17:13:52 (296): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-03-11 17:13:52 (296): Guest Log: BIOS: Booting from Hard Disk... 2025-03-11 17:13:56 (296): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-03-11 17:13:56 (296): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-03-11 17:14:25 (296): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-03-11 17:14:25 (296): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-03-11 17:14:27 (296): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.000211 main Log opened 2025-03-11T17:14:27.650657000Z 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.000296 main OS Product: Linux 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.000320 main OS Release: 4.14.232-19.cernvm.x86_64 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.000341 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.000363 main Executable: /usr/sbin/VBoxService 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.000363 main Process ID: 2298 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.000364 main Package type: LINUX_64BITS_GENERIC 2025-03-11 17:14:27 (296): Guest Log: 00:00:00.001022 main 5.2.6 r120293 started. Verbose level = 0 2025-03-11 17:14:38 (296): Guest Log: [INFO] Mounting the shared directory 2025-03-11 17:14:38 (296): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-03-11 17:14:38 (296): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-03-11 17:14:38 (296): Guest Log: [INFO] Testing connection to cern.ch 2025-03-11 17:14:38 (296): Guest Log: [INFO] Testing connection to VCCS 2025-03-11 17:14:38 (296): Guest Log: [INFO] Testing connection to HTCondor 2025-03-11 17:14:38 (296): Guest Log: [INFO] Testing connection to WMAgent 2025-03-11 17:14:39 (296): Guest Log: [INFO] Testing connection to EOSCMS 2025-03-11 17:14:39 (296): Guest Log: [INFO] Testing connection to CMS-Factory 2025-03-11 17:14:39 (296): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-03-11 17:14:39 (296): Guest Log: [INFO] Testing connection to Frontier 2025-03-11 17:14:40 (296): Guest Log: [INFO] Could not find a local HTTP proxy 2025-03-11 17:14:40 (296): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-03-11 17:14:40 (296): Guest Log: [INFO] This makes the application less efficient 2025-03-11 17:14:40 (296): Guest Log: [INFO] It also puts higher load on the project servers 2025-03-11 17:14:40 (296): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-03-11 17:14:40 (296): Guest Log: [INFO] Advice can be found in the project forum 2025-03-11 17:14:40 (296): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-03-11 17:14:44 (296): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-03-11 17:14:45 (296): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-03-11 17:14:46 (296): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-03-11 17:14:46 (296): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-03-11 17:14:52 (296): Stopping VM. 2025-03-11 17:15:21 (296): Successfully stopped VM. 2025-03-12 13:36:09 (19048): vboxwrapper version 26208 2025-03-12 13:36:09 (19048): BOINC client version: 8.0.4 2025-03-12 13:36:10 (19048): Detected: VirtualBox VboxManage Interface (Version: 6.1.22) 2025-03-12 13:36:11 (19048): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-03-12 13:36:11 (19048): Guest Log: BIOS: VirtualBox 6.1.22 2025-03-12 13:36:11 (19048): Guest Log: CPUID EDX: 0x178bfbff 2025-03-12 13:36:11 (19048): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-03-12 13:36:11 (19048): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-03-12 13:36:11 (19048): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-03-12 13:36:11 (19048): Guest Log: BIOS: Booting from Hard Disk... 2025-03-12 13:36:11 (19048): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-03-12 13:36:11 (19048): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-03-12 13:36:11 (19048): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-03-12 13:36:11 (19048): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-03-12 13:36:11 (19048): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.000211 main Log opened 2025-03-11T17:14:27.650657000Z 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.000296 main OS Product: Linux 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.000320 main OS Release: 4.14.232-19.cernvm.x86_64 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.000341 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.000363 main Executable: /usr/sbin/VBoxService 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.000363 main Process ID: 2298 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.000364 main Package type: LINUX_64BITS_GENERIC 2025-03-12 13:36:11 (19048): Guest Log: 00:00:00.001022 main 5.2.6 r120293 started. Verbose level = 0 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Mounting the shared directory 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to cern.ch 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to VCCS 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to HTCondor 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to WMAgent 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to EOSCMS 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to CMS-Factory 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to CMS-Frontier 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Testing connection to Frontier 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Could not find a local HTTP proxy 2025-03-12 13:36:11 (19048): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2025-03-12 13:36:11 (19048): Guest Log: [INFO] This makes the application less efficient 2025-03-12 13:36:11 (19048): Guest Log: [INFO] It also puts higher load on the project servers 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Advice can be found in the project forum 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2025-03-12 13:36:11 (19048): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2025-03-12 13:36:11 (19048): Starting VM using VBoxManage interface. (boinc_c267cd06b66cf459, slot#1) 2025-03-12 13:36:30 (19048): Successfully started VM. (PID = '17688') 2025-03-12 13:36:30 (19048): Reporting VM Process ID to BOINC. 2025-03-12 13:36:30 (19048): VM state change detected. (old = 'poweredoff', new = 'running') 2025-03-12 13:36:30 (19048): Detected: Web Application Enabled (http://localhost:59212) 2025-03-12 13:36:30 (19048): Status Report: Job Duration: '64800.000000' 2025-03-12 13:36:30 (19048): Status Report: Elapsed Time: '21796.000000' 2025-03-12 13:36:30 (19048): Status Report: CPU Time: '48308.546875' 2025-03-12 13:36:30 (19048): Preference change detected 2025-03-12 13:36:30 (19048): Setting CPU throttle for VM. (50%) 2025-03-12 13:36:30 (19048): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2025-03-12 13:36:35 (19048): Guest Log: 00:00:31.552328 timesync vgsvcTimeSyncWorker: Radical host time change: 73 308 608 000 000ns (HostNow=1 741 786 595 165 000 000 ns HostLast=1 741 713 286 557 000 000 ns) 2025-03-12 13:36:39 (19048): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2025-03-12 13:36:39 (19048): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2025-03-12 13:36:39 (19048): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT 2025-03-12 13:36:39 (19048): Guest Log: [INFO] Environment HTTP proxy: not set 2025-03-12 13:36:40 (19048): Guest Log: [INFO] Reading volunteer information 2025-03-12 13:36:41 (19048): Guest Log: [INFO] Using weak account key. 2025-03-12 13:36:41 (19048): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2025-03-12 13:36:42 (19048): Guest Log: [INFO] Using weak account key. 2025-03-12 13:36:42 (19048): Guest Log: [INFO] Requesting an idtoken from LHC@home 2025-03-12 13:36:43 (19048): Guest Log: [INFO] CMS application starting. Check log files. 2025-03-12 13:36:45 (19048): Guest Log: 00:00:41.552530 timesync vgsvcTimeSyncWorker: Radical guest time change: 73 305 962 691 000ns (GuestNow=1 741 786 605 165 311 000 ns GuestLast=1 741 713 299 202 620 000 ns fSetTimeLastLoop=true ) 2025-03-12 13:52:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 13:52:55 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 14:16:48 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 14:17:08 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 14:17:28 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 14:17:50 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 14:26:30 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 14:26:51 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 14:37:42 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 14:38:02 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 14:53:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 14:54:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 15:18:44 (19048): Status Report: Job Duration: '64800.000000' 2025-03-12 15:18:44 (19048): Status Report: Elapsed Time: '27796.000000' 2025-03-12 15:18:44 (19048): Status Report: CPU Time: '62037.640625' 2025-03-12 15:33:42 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 15:34:03 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 15:34:33 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 15:34:53 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 15:49:25 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 15:49:46 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:02:37 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 16:02:58 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:06:18 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 16:06:38 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:21:41 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 16:22:01 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:27:32 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 16:27:53 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:36:14 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 16:36:35 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:41:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 16:41:56 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:52:08 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 16:52:29 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 16:59:49 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 17:00:09 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 17:02:00 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 17:02:20 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 17:03:08 (19048): Status Report: Job Duration: '64800.000000' 2025-03-12 17:03:08 (19048): Status Report: Elapsed Time: '33796.000000' 2025-03-12 17:03:08 (19048): Status Report: CPU Time: '76245.281250' 2025-03-12 17:11:31 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 17:11:52 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 17:24:45 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 17:25:05 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 17:27:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 17:27:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 17:46:09 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-12 17:46:29 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-12 18:01:32 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:21:10 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:21:13 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:21:34 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:21:37 (19048): Guest Log: 04:18:10.839559 timesync vgsvcTimeSyncWorker: Radical host time change: 22 805 899 000 000ns (HostNow=1 741 825 265 059 000 000 ns HostLast=1 741 802 459 160 000 000 ns) 2025-03-13 00:21:47 (19048): Guest Log: 04:18:20.842669 timesync vgsvcTimeSyncWorker: Radical guest time change: 23 220 763 667 000ns (GuestNow=1 741 825 275 139 062 000 ns GuestLast=1 741 802 054 375 395 000 ns fSetTimeLastLoop=true ) 2025-03-13 00:25:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:25:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:29:24 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:29:44 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:29:54 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:30:14 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:30:24 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:30:44 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:30:54 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:31:14 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:31:24 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:31:45 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:31:55 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:32:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:32:25 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:32:45 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:32:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:33:15 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:33:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:33:46 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:33:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:34:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:34:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:34:46 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:34:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:35:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:35:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:35:46 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:35:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:36:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:36:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:36:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:36:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:37:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:37:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:37:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:37:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:38:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:38:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:38:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:38:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:39:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:39:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:39:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:39:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:40:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:40:26 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:40:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:40:56 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:41:16 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:41:27 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:41:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:41:57 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:42:17 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 00:42:27 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 00:42:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:14:33 (19048): Status Report: Job Duration: '64800.000000' 2025-03-13 01:14:33 (19048): Status Report: Elapsed Time: '39796.000000' 2025-03-13 01:14:33 (19048): Status Report: CPU Time: '90507.546875' 2025-03-13 01:46:02 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:46:22 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:46:32 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:46:52 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:47:02 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:47:22 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:47:32 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:47:52 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:48:02 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:48:22 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:48:32 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:48:52 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:49:02 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:49:22 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:49:32 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:49:52 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:50:02 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:50:22 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:50:33 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:50:52 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:51:03 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:51:23 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:51:33 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:51:53 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:52:03 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:52:23 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:52:33 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:52:53 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:53:03 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:53:23 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:53:33 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:53:53 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:54:03 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:54:23 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:54:33 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:54:53 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:55:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:55:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:55:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:55:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:56:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:56:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:56:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:56:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:57:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:57:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:57:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:57:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:58:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:58:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:58:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:58:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:59:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:59:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 01:59:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 01:59:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:00:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:00:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:00:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:00:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:01:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:01:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:01:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:01:54 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:02:04 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:02:24 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:02:34 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:02:55 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:03:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:03:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:03:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:03:55 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:04:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:04:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:04:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:04:55 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:05:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:05:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:05:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:05:55 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:06:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:06:26 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:06:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:06:55 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:07:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:07:26 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:07:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:07:55 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:08:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:08:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:08:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:08:56 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:09:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:09:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:09:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:09:56 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:10:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:10:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:10:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:10:56 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:11:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:11:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:11:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:11:56 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:12:05 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:12:25 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:12:35 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:12:56 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:13:06 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:13:26 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:13:36 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:13:56 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:14:06 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:14:26 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 02:14:36 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 02:14:37 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 03:02:27 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 03:02:47 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 03:05:38 (19048): VM state change detected. (old = 'running', new = 'paused') 2025-03-13 03:05:59 (19048): VM state change detected. (old = 'paused', new = 'running') 2025-03-13 03:06:33 (19048): Guest Log: [INFO] glidein exited with return value 0. 2025-03-13 03:06:34 (19048): Guest Log: [INFO] Shutting Down. 2025-03-13 03:06:34 (19048): VM Completion File Detected. 2025-03-13 03:06:34 (19048): VM Completion Message: glidein exited with return value 0. . 2025-03-13 03:06:34 (19048): Powering off VM. 2025-03-13 03:06:35 (19048): Succes
©2025 CERN