Task 3210873

Name	CMS_2990776_1682846068.734374_0
Workunit	2303714
Created	30 Apr 2023, 9:14:30 UTC
Sent	1 May 2023, 6:31:49 UTC
Report deadline	8 May 2023, 6:31:49 UTC
Received	3 May 2023, 3:58:12 UTC
Server state	Over
Outcome	Computation error
Client state	Aborted by user
Exit status	203 (0x000000CB) EXIT_ABORTED_VIA_GUI
Computer ID	4890
Run time	2 hours 31 min 58 sec
CPU time	3 hours 26 min 4 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	2.00 GFLOPS
Application version	CMS Simulation v60.70 (vbox64_mt_mcore_cms) windows_x86_64
Peak working set size	78.81 MB
Peak swap size	83.92 MB
Peak disk usage	1.01 GB
Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<message>
aborted by user</message>
<stderr_txt>
2023-05-01 16:31:49 (3516): Detected: vboxwrapper 26206
2023-05-01 16:31:49 (3516): Detected: BOINC client v7.20.2
2023-05-01 16:31:52 (3516): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-01 16:31:53 (3516): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-01 16:31:53 (3516): Successfully copied 'init_data.xml' to the shared directory.
2023-05-01 16:31:53 (3516): Create VM. (boinc_512721856aa840c6, slot#12)
2023-05-01 16:31:54 (3516): Setting Memory Size for VM. (2792MB)
2023-05-01 16:31:54 (3516): Setting CPU Count for VM. (2)
2023-05-01 16:31:55 (3516): Setting Chipset Options for VM.
2023-05-01 16:31:55 (3516): Setting Graphics Controller Options for VM.
2023-05-01 16:31:55 (3516): Setting Boot Options for VM.
2023-05-01 16:31:56 (3516): Setting Network Configuration for NAT.
2023-05-01 16:31:56 (3516): Enabling VM Network Access.
2023-05-01 16:31:56 (3516): Disabling USB Support for VM.
2023-05-01 16:31:56 (3516): Disabling COM Port Support for VM.
2023-05-01 16:31:57 (3516): Disabling LPT Port Support for VM.
2023-05-01 16:31:57 (3516): Disabling Audio Support for VM.
2023-05-01 16:31:57 (3516): Disabling Clipboard Support for VM.
2023-05-01 16:31:58 (3516): Disabling Drag and Drop Support for VM.
2023-05-01 16:31:58 (3516): Adding storage controller(s) to VM.
2023-05-01 16:31:58 (3516): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi)
2023-05-01 16:31:59 (3516): Adding VirtualBox Guest Additions to VM.
2023-05-01 16:32:00 (3516): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-05-01 16:32:00 (3516): forwarding host port 50511 to guest port 80
2023-05-01 16:32:00 (3516): Enabling remote desktop for VM.
2023-05-01 16:32:00 (3516): Required extension pack not installed, remote desktop not enabled.
2023-05-01 16:32:00 (3516): Enabling shared directory for VM.
2023-05-01 16:32:01 (3516): Starting VM using VBoxManage interface. (boinc_512721856aa840c6, slot#12)
2023-05-01 16:32:14 (3516): Successfully started VM. (PID = '16488')
2023-05-01 16:32:14 (3516): Reporting VM Process ID to BOINC.
2023-05-01 16:32:14 (3516): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-01 16:32:14 (3516): Guest Log: CPUID EDX: 0x178bfbff
2023-05-01 16:32:14 (3516): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-01 16:32:14 (3516): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-01 16:32:14 (3516): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-01 16:32:14 (3516): Detected: Web Application Enabled (http://localhost:50511)
2023-05-01 16:32:14 (3516): Preference change detected
2023-05-01 16:32:14 (3516): Setting CPU throttle for VM. (100%)
2023-05-01 16:32:15 (3516): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-01 16:32:16 (3516): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-01 16:32:16 (3516): Guest Log: BIOS: Booting from Hard Disk...
2023-05-01 16:32:19 (3516): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-01 16:32:19 (3516): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-01 16:32:59 (3516): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-01 16:32:59 (3516): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-01 16:33:01 (3516): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-01 16:33:01 (3516): Guest Log: 00:00:00.000596 main     Log opened 2023-05-01T06:33:04.650327000Z
2023-05-01 16:33:02 (3516): Guest Log: 00:00:00.000912 main     OS Product: Linux
2023-05-01 16:33:02 (3516): Guest Log: 00:00:00.001024 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-01 16:33:02 (3516): Guest Log: 00:00:00.001138 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-01 16:33:02 (3516): Guest Log: 00:00:00.001284 main     Executable: /usr/sbin/VBoxService
2023-05-01 16:33:02 (3516): Guest Log: 00:00:00.001287 main     Process ID: 2206
2023-05-01 16:33:02 (3516): Guest Log: 00:00:00.001289 main     Package type: LINUX_64BITS_GENERIC
2023-05-01 16:33:02 (3516): Guest Log: 00:00:00.003436 main     5.2.6 r120293 started. Verbose level = 0
2023-05-01 16:33:41 (3516): Guest Log: [INFO] Mounting the shared directory
2023-05-01 16:33:41 (3516): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-01 16:33:42 (3516): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-01 16:33:42 (3516): Guest Log: [INFO] Testing connection to cern.ch
2023-05-01 16:33:44 (3516): Guest Log: [INFO] Testing connection to VCCS
2023-05-01 16:33:44 (3516): Guest Log: [INFO] Testing connection to HTCondor
2023-05-01 16:33:45 (3516): Guest Log: [INFO] Testing connection to WMAgent
2023-05-01 16:33:46 (3516): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-01 16:33:47 (3516): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-01 16:33:48 (3516): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-01 16:33:50 (3516): Guest Log: [INFO] Testing connection to Frontier
2023-05-01 16:33:51 (3516): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-01 16:33:52 (3516): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-01 16:33:52 (3516): Guest Log: [INFO] This makes the application less efficient
2023-05-01 16:33:52 (3516): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-01 16:33:52 (3516): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-01 16:33:53 (3516): Guest Log: [INFO] Advice can be found in the project forum
2023-05-01 16:33:55 (3516): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-01 16:34:14 (3516): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-01 16:34:24 (3516): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-01 16:34:25 (3516): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-01 16:34:25 (3516): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-01 16:34:28 (3516): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-01 16:34:30 (3516): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-01 16:34:30 (3516): Guest Log: [INFO] 2.7.2.0 http://s1swinburne-cvmfs.openhtc.io:8080 DIRECT
2023-05-01 16:34:30 (3516): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-01 16:34:31 (3516): Guest Log: [INFO] Reading volunteer information
2023-05-01 16:35:30 (3516): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-01 16:35:34 (3516): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-01 16:35:37 (3516): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-01 16:35:38 (3516): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-01 16:35:41 (3516): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-02 11:38:10 (8184): Detected: vboxwrapper 26206
2023-05-02 11:38:10 (8184): Detected: BOINC client v7.20.2
2023-05-02 11:39:55 (8184): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-02 11:39:55 (8184): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-02 11:39:58 (8184): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-02 11:39:58 (8184): Guest Log: CPUID EDX: 0x178bfbff
2023-05-02 11:39:58 (8184): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-02 11:39:58 (8184): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-02 11:39:58 (8184): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-02 11:39:58 (8184): Guest Log: BIOS: Booting from Hard Disk...
2023-05-02 11:39:58 (8184): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-02 11:39:58 (8184): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-02 11:39:58 (8184): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-02 11:39:58 (8184): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-02 11:39:58 (8184): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.000596 main     Log opened 2023-05-01T06:33:04.650327000Z
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.000912 main     OS Product: Linux
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.001024 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.001138 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.001284 main     Executable: /usr/sbin/VBoxService
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.001287 main     Process ID: 2206
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.001289 main     Package type: LINUX_64BITS_GENERIC
2023-05-02 11:39:58 (8184): Guest Log: 00:00:00.003436 main     5.2.6 r120293 started. Verbose level = 0
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Mounting the shared directory
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to cern.ch
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to VCCS
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to HTCondor
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to WMAgent
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Testing connection to Frontier
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-02 11:39:58 (8184): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-02 11:39:58 (8184): Guest Log: [INFO] This makes the application less efficient
2023-05-02 11:39:58 (8184): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Advice can be found in the project forum
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-02 11:39:58 (8184): Guest Log: [INFO] 2.7.2.0 http://s1swinburne-cvmfs.openhtc.io:8080 DIRECT
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Reading volunteer information
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-02 11:39:58 (8184): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-02 11:39:58 (8184): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-02 11:39:58 (8184): Starting VM using VBoxManage interface. (boinc_512721856aa840c6, slot#12)
2023-05-02 11:40:17 (8184): Successfully started VM. (PID = '13740')
2023-05-02 11:40:17 (8184): Reporting VM Process ID to BOINC.
2023-05-02 11:40:17 (8184): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-02 11:40:17 (8184): Guest Log: CPUID EDX: 0x178bfbff
2023-05-02 11:40:17 (8184): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-02 11:40:17 (8184): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-02 11:40:17 (8184): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-02 11:40:17 (8184): Detected: Web Application Enabled (http://localhost:50511)
2023-05-02 11:40:17 (8184): Preference change detected
2023-05-02 11:40:17 (8184): Setting CPU throttle for VM. (100%)
2023-05-02 11:40:18 (8184): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-02 11:40:19 (8184): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-02 11:40:19 (8184): Guest Log: BIOS: Booting from Hard Disk...
2023-05-02 11:40:25 (8184): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-02 11:40:25 (8184): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-02 11:41:32 (8184): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-02 11:41:32 (8184): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-02 11:41:40 (8184): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.000306 main     Log opened 2023-05-02T01:41:43.701771000Z
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.000558 main     OS Product: Linux
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.000640 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.000720 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.000799 main     Executable: /usr/sbin/VBoxService
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.000802 main     Process ID: 2225
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.000804 main     Package type: LINUX_64BITS_GENERIC
2023-05-02 11:41:40 (8184): Guest Log: 00:00:00.007976 main     5.2.6 r120293 started. Verbose level = 0
2023-05-02 11:42:41 (8184): Guest Log: [INFO] Mounting the shared directory
2023-05-02 11:42:42 (8184): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-02 11:42:42 (8184): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-02 11:42:43 (8184): Guest Log: [INFO] Testing connection to cern.ch
2023-05-02 11:42:44 (8184): Guest Log: [INFO] Testing connection to VCCS
2023-05-02 11:42:45 (8184): Guest Log: [INFO] Testing connection to HTCondor
2023-05-02 11:42:46 (8184): Guest Log: [INFO] Testing connection to WMAgent
2023-05-02 11:42:46 (8184): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-02 11:42:47 (8184): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-02 11:42:48 (8184): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-02 11:42:49 (8184): Guest Log: [INFO] Testing connection to Frontier
2023-05-02 11:42:50 (8184): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-02 11:42:51 (8184): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-02 11:42:51 (8184): Guest Log: [INFO] This makes the application less efficient
2023-05-02 11:42:51 (8184): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-02 11:42:51 (8184): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-02 11:42:52 (8184): Guest Log: [INFO] Advice can be found in the project forum
2023-05-02 11:42:52 (8184): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-02 11:43:06 (8184): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-02 11:43:15 (8184): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-02 11:43:15 (8184): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-02 11:43:16 (8184): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-02 11:43:16 (8184): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-02 11:43:17 (8184): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-02 11:43:18 (8184): Guest Log: [INFO] 2.7.2.0 http://s1swinburne-cvmfs.openhtc.io:8080 DIRECT
2023-05-02 11:43:18 (8184): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-02 11:43:19 (8184): Guest Log: [INFO] Reading volunteer information
2023-05-02 11:43:34 (8184): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-02 11:43:37 (8184): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-02 11:43:44 (8184): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-02 11:43:49 (8184): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-02 11:43:53 (8184): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-02 15:11:27 (14128): Detected: vboxwrapper 26206
2023-05-02 15:11:27 (14128): Detected: BOINC client v7.20.2
2023-05-02 15:12:48 (14128): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-02 15:12:50 (14128): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-02 15:12:57 (14128): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-02 15:12:57 (14128): Guest Log: CPUID EDX: 0x178bfbff
2023-05-02 15:12:57 (14128): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-02 15:12:57 (14128): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-02 15:12:57 (14128): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-02 15:12:57 (14128): Guest Log: BIOS: Booting from Hard Disk...
2023-05-02 15:12:57 (14128): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-02 15:12:57 (14128): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-02 15:12:57 (14128): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-02 15:12:57 (14128): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-02 15:12:57 (14128): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.000306 main     Log opened 2023-05-02T01:41:43.701771000Z
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.000558 main     OS Product: Linux
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.000640 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.000720 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.000799 main     Executable: /usr/sbin/VBoxService
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.000802 main     Process ID: 2225
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.000804 main     Package type: LINUX_64BITS_GENERIC
2023-05-02 15:12:57 (14128): Guest Log: 00:00:00.007976 main     5.2.6 r120293 started. Verbose level = 0
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Mounting the shared directory
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to cern.ch
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to VCCS
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to HTCondor
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to WMAgent
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Testing connection to Frontier
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-02 15:12:57 (14128): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-02 15:12:57 (14128): Guest Log: [INFO] This makes the application less efficient
2023-05-02 15:12:57 (14128): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Advice can be found in the project forum
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-02 15:12:57 (14128): Guest Log: [INFO] 2.7.2.0 http://s1swinburne-cvmfs.openhtc.io:8080 DIRECT
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Reading volunteer information
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-02 15:12:57 (14128): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-02 15:12:57 (14128): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-02 15:12:57 (14128): Starting VM using VBoxManage interface. (boinc_512721856aa840c6, slot#12)
2023-05-02 15:13:39 (14128): Successfully started VM. (PID = '8132')
2023-05-02 15:13:39 (14128): Reporting VM Process ID to BOINC.
2023-05-02 15:13:39 (14128): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-02 15:13:39 (14128): Guest Log: CPUID EDX: 0x178bfbff
2023-05-02 15:13:39 (14128): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-02 15:13:39 (14128): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-02 15:13:39 (14128): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-02 15:13:39 (14128): Detected: Web Application Enabled (http://localhost:50511)
2023-05-02 15:13:39 (14128): Preference change detected
2023-05-02 15:13:39 (14128): Setting CPU throttle for VM. (100%)
2023-05-02 15:13:40 (14128): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-02 15:13:41 (14128): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-02 15:13:41 (14128): Guest Log: BIOS: Booting from Hard Disk...
2023-05-02 15:13:47 (14128): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-02 15:13:47 (14128): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-02 15:15:02 (14128): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-02 15:15:02 (14128): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-02 15:15:22 (14128): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.000732 main     Log opened 2023-05-02T05:15:22.631338000Z
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.001423 main     OS Product: Linux
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.001562 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.001690 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.001831 main     Executable: /usr/sbin/VBoxService
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.001834 main     Process ID: 2209
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.001836 main     Package type: LINUX_64BITS_GENERIC
2023-05-02 15:15:22 (14128): Guest Log: 00:00:00.012728 main     5.2.6 r120293 started. Verbose level = 0
2023-05-02 15:17:07 (14128): Guest Log: [INFO] Mounting the shared directory
2023-05-02 15:17:11 (14128): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-02 15:17:11 (14128): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-02 15:17:11 (14128): Guest Log: [INFO] Testing connection to cern.ch
2023-05-02 15:17:11 (14128): Guest Log: [INFO] Testing connection to VCCS
2023-05-02 15:17:11 (14128): Guest Log: [INFO] Testing connection to HTCondor
2023-05-02 15:17:13 (14128): Guest Log: [INFO] Testing connection to WMAgent
2023-05-02 15:17:15 (14128): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-02 15:17:15 (14128): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-02 15:17:15 (14128): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-02 15:17:17 (14128): Guest Log: [INFO] Testing connection to Frontier
2023-05-02 15:17:19 (14128): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-02 15:17:19 (14128): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-02 15:17:19 (14128): Guest Log: [INFO] This makes the application less efficient
2023-05-02 15:17:20 (14128): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-02 15:17:20 (14128): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-02 15:17:20 (14128): Guest Log: [INFO] Advice can be found in the project forum
2023-05-02 15:17:21 (14128): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-02 15:17:40 (14128): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-02 15:17:55 (14128): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-02 15:17:55 (14128): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-02 15:17:55 (14128): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-02 15:17:57 (14128): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-02 15:18:00 (14128): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-02 15:18:00 (14128): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2023-05-02 15:18:01 (14128): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-02 15:18:03 (14128): Guest Log: [INFO] Reading volunteer information
2023-05-02 15:18:16 (14128): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-02 15:18:20 (14128): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-02 15:18:23 (14128): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-02 15:18:25 (14128): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-02 15:18:28 (14128): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-02 15:59:36 (14128): Status Report: Job Duration: '64800.000000'
2023-05-02 15:59:36 (14128): Status Report: Elapsed Time: '6000.291494'
2023-05-02 15:59:36 (14128): Status Report: CPU Time: '4691.218750'
2023-05-03 11:55:08 (2888): Detected: vboxwrapper 26206
2023-05-03 11:55:08 (2888): Detected: BOINC client v7.20.2
2023-05-03 11:55:17 (2888): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-05-03 11:55:18 (2888): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-05-03 11:55:18 (2888): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-03 11:55:18 (2888): Guest Log: CPUID EDX: 0x178bfbff
2023-05-03 11:55:18 (2888): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-03 11:55:18 (2888): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-03 11:55:18 (2888): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-03 11:55:18 (2888): Guest Log: BIOS: Booting from Hard Disk...
2023-05-03 11:55:18 (2888): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-03 11:55:18 (2888): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-03 11:55:18 (2888): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-03 11:55:18 (2888): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-03 11:55:18 (2888): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.000732 main     Log opened 2023-05-02T05:15:22.631338000Z
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.001423 main     OS Product: Linux
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.001562 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.001690 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.001831 main     Executable: /usr/sbin/VBoxService
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.001834 main     Process ID: 2209
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.001836 main     Package type: LINUX_64BITS_GENERIC
2023-05-03 11:55:18 (2888): Guest Log: 00:00:00.012728 main     5.2.6 r120293 started. Verbose level = 0
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Mounting the shared directory
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to cern.ch
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to VCCS
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to HTCondor
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to WMAgent
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Testing connection to Frontier
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-03 11:55:18 (2888): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-03 11:55:18 (2888): Guest Log: [INFO] This makes the application less efficient
2023-05-03 11:55:18 (2888): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Advice can be found in the project forum
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-03 11:55:18 (2888): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Reading volunteer information
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-03 11:55:18 (2888): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-03 11:55:18 (2888): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-03 11:55:18 (2888): Starting VM using VBoxManage interface. (boinc_512721856aa840c6, slot#12)
2023-05-03 11:55:42 (2888): Successfully started VM. (PID = '17004')
2023-05-03 11:55:42 (2888): Reporting VM Process ID to BOINC.
2023-05-03 11:55:42 (2888): Guest Log: BIOS: VirtualBox 6.1.34
2023-05-03 11:55:42 (2888): Guest Log: CPUID EDX: 0x178bfbff
2023-05-03 11:55:42 (2888): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-05-03 11:55:42 (2888): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-05-03 11:55:42 (2888): VM state change detected. (old = 'poweredoff', new = 'running')
2023-05-03 11:55:42 (2888): Detected: Web Application Enabled (http://localhost:50511)
2023-05-03 11:55:42 (2888): Status Report: Job Duration: '64800.000000'
2023-05-03 11:55:42 (2888): Status Report: Elapsed Time: '6343.291494'
2023-05-03 11:55:42 (2888): Status Report: CPU Time: '5077.328125'
2023-05-03 11:55:42 (2888): Preference change detected
2023-05-03 11:55:42 (2888): Setting CPU throttle for VM. (100%)
2023-05-03 11:55:42 (2888): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-05-03 11:55:44 (2888): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-05-03 11:55:44 (2888): Guest Log: BIOS: Booting from Hard Disk...
2023-05-03 11:55:53 (2888): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-05-03 11:55:53 (2888): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-05-03 11:56:57 (2888): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-05-03 11:56:57 (2888): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-05-03 11:57:02 (2888): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.000313 main     Log opened 2023-05-03T01:57:01.841026000Z
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.000471 main     OS Product: Linux
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.000539 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.000602 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.000663 main     Executable: /usr/sbin/VBoxService
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.000665 main     Process ID: 2201
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.000667 main     Package type: LINUX_64BITS_GENERIC
2023-05-03 11:57:02 (2888): Guest Log: 00:00:00.004837 main     5.2.6 r120293 started. Verbose level = 0
2023-05-03 11:58:02 (2888): Guest Log: [INFO] Mounting the shared directory
2023-05-03 11:58:02 (2888): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-05-03 11:58:03 (2888): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-05-03 11:58:03 (2888): Guest Log: [INFO] Testing connection to cern.ch
2023-05-03 11:58:04 (2888): Guest Log: [INFO] Testing connection to VCCS
2023-05-03 11:58:05 (2888): Guest Log: [INFO] Testing connection to HTCondor
2023-05-03 11:58:05 (2888): Guest Log: [INFO] Testing connection to WMAgent
2023-05-03 11:58:06 (2888): Guest Log: [INFO] Testing connection to EOSCMS
2023-05-03 11:58:07 (2888): Guest Log: [INFO] Testing connection to CMS-Factory
2023-05-03 11:58:07 (2888): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-05-03 11:58:08 (2888): Guest Log: [INFO] Testing connection to Frontier
2023-05-03 11:58:10 (2888): Guest Log: [INFO] Could not find a local HTTP proxy
2023-05-03 11:58:10 (2888): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-05-03 11:58:10 (2888): Guest Log: [INFO] This makes the application less efficient
2023-05-03 11:58:10 (2888): Guest Log: [INFO] It also puts higher load on the project servers
2023-05-03 11:58:11 (2888): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-05-03 11:58:11 (2888): Guest Log: [INFO] Advice can be found in the project forum
2023-05-03 11:58:11 (2888): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-05-03 11:58:39 (2888): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-05-03 11:58:51 (2888): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-05-03 11:58:51 (2888): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-05-03 11:58:51 (2888): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-05-03 11:58:52 (2888): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-05-03 11:58:54 (2888): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-05-03 11:58:54 (2888): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2023-05-03 11:58:54 (2888): Guest Log: [INFO] Environment HTTP proxy: not set
2023-05-03 11:58:55 (2888): Guest Log: [INFO] Reading volunteer information
2023-05-03 11:59:23 (2888): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-05-03 11:59:29 (2888): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-05-03 11:59:32 (2888): Guest Log: [INFO] CMS application starting. Check log files.
2023-05-03 11:59:33 (2888): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-05-03 11:59:35 (2888): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-05-03 13:36:15 (2888): Status Report: Job Duration: '64800.000000'
2023-05-03 13:36:15 (2888): Status Report: Elapsed Time: '12343.605926'
2023-05-03 13:36:16 (2888): Status Report: CPU Time: '11108.031250'
2023-05-03 13:55:03 (2888): Powering off VM.
2023-05-03 13:55:05 (2888): Successfully stopped VM.
2023-05-03 13:55:05 (2888): Deregistering VM. (boinc_512721856aa840c6, slot#12)
2023-05-03 13:55:05 (2888): Removing network bandwidth throttle group from VM.
2023-05-03 13:55:05 (2888): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:04.251323          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:04.351078          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.351287          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.351488          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.351735          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.362225          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.362450          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.364609          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:04.365608          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:04.375955          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:04.714962          Launched VM: 69487856 pid: 16608 (0x40e0) frontend: headless name: boinc_512721856aa840c6
00:00:04.714995          Launched VM: 69436464 pid: 16680 (0x4128) frontend: headless name: boinc_624db6186527e212
00:00:04.719338          Launched VM: 69436656 pid: 16624 (0x40f0) frontend: headless name: boinc_2665f283180059e6
00:00:04.733437          Launched VM: 69492800 pid: 16816 (0x41b0) frontend: headless name: boinc_137d1ba36d1d3b38
00:00:27.970698          Saving settings file "C:\ProgramData\BOINC\slots\17\boinc_624db6186527e212\boinc_624db6186527e212.vbox" with version "1.16-windows"
00:00:27.970734          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_2665f283180059e6\boinc_2665f283180059e6.vbox" with version "1.16-windows"
00:00:27.997042          Saving settings file "C:\ProgramData\BOINC\slots\12\boinc_512721856aa840c6\boinc_512721856aa840c6.vbox" with version "1.16-windows"
00:00:28.191409          Saving settings file "C:\ProgramData\BOINC\slots\22\boinc_137d1ba36d1d3b38\boinc_137d1ba36d1d3b38.vbox" with version "1.16-windows"
00:06:38.277181 USBPROXY usbLibGetDevices: Starting USB device enumeration
00:06:38.431095 USBPROXY usbLibGetDevices: Found 1 USB devices, 0 captured
00:06:39.559773 USBPROXY usbLibGetDevices: Starting USB device enumeration
00:06:39.720936 USBPROXY usbLibGetDevices: Found 3 USB devices, 0 captured
00:06:43.226469 USBPROXY usbLibGetDevices: Starting USB device enumeration
00:06:43.380172 USBPROXY usbLibGetDevices: Found 1 USB devices, 0 captured
01:53:03.994749 USBPROXY usbLibGetDevices: Starting USB device enumeration
01:53:04.173314 USBPROXY usbLibGetDevices: Found 3 USB devices, 0 captured
01:58:42.298014          Saving settings file "C:\ProgramData\BOINC\slots\17\boinc_624db6186527e212\boinc_624db6186527e212.vbox" with version "1.16-windows"
01:58:42.406282          Saving settings file "C:\ProgramData\BOINC\slots\22\boinc_137d1ba36d1d3b38\boinc_137d1ba36d1d3b38.vbox" with version "1.16-windows"
01:58:42.708807          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_2665f283180059e6\boinc_2665f283180059e6.vbox" with version "1.16-windows"
01:58:43.759195          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
01:58:44.125223          Saving settings file "C:\ProgramData\BOINC\slots\17\boinc_624db6186527e212\boinc_624db6186527e212.vbox" with version "1.16-windows"
01:58:44.239396          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={The object is not ready}, preserve=false aResultDetail=0
01:58:44.539405          Saving settings file "C:\Users\peter\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
01:58:44.568822          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
01:58:44.581865          Saving settings file "C:\ProgramData\BOINC\slots\22\boinc_137d1ba36d1d3b38\boinc_137d1ba36d1d3b38.vbox" with version "1.16-windows"
01:58:44.653565 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\22\boinc_137d1ba36d1d3b38\boinc_137d1ba36d1d3b38.vbox" with version "1.16-windows"
01:58:45.066012          Saving settings file "C:\ProgramData\BOINC\slots\22\boinc_137d1ba36d1d3b38\boinc_137d1ba36d1d3b38.vbox" with version "1.16-windows"
01:58:45.156847          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
01:58:45.436639          Saving settings file "C:\Users\peter\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
01:58:45.462503          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_2665f283180059e6\boinc_2665f283180059e6.vbox" with version "1.16-windows"
01:58:45.487698 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_2665f283180059e6\boinc_2665f283180059e6.vbox" with version "1.16-windows"
01:58:45.548250          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_2665f283180059e6\boinc_2665f283180059e6.vbox" with version "1.16-windows"
01:58:46.156593          Saving settings file "C:\Users\peter\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
01:59:49.925430          Saving settings file "C:\ProgramData\BOINC\slots\12\boinc_512721856aa840c6\boinc_512721856aa840c6.vbox" with version "1.16-windows"
01:59:51.082352          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
01:59:51.188877          Saving settings file "C:\ProgramData\BOINC\slots\12\boinc_512721856aa840c6\boinc_512721856aa840c6.vbox" with version "1.16-windows"
01:59:51.454438          Saving settings file "C:\Users\peter\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
01:59:56.533374 main     VirtualBox: object deletion starts
01:59:56.534493 main     HostDnsMonitor: shutting down ...
01:59:56.534579 main     HostDnsMonitor: shut down
01:59:56.540741 Watcher  ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={d0a0163f-e254-4e5b-a1f2-011cf991c38d} aComponent={VirtualBoxWrap} aText={The object is not ready}, preserve=false aResultDetail=0
01:59:56.541062 main     VirtualBox: object deleted

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

R) CPU E5-2699 v3 @ 2.30GHz
Processor#35 speed: unknown
Processor#35 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#36 speed: unknown
Processor#36 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#37 speed: unknown
Processor#37 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#38 speed: unknown
Processor#38 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#39 speed: unknown
Processor#39 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#40 speed: unknown
Processor#40 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#41 speed: unknown
Processor#41 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#42 speed: unknown
Processor#42 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#43 speed: unknown
Processor#43 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#44 speed: unknown
Processor#44 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#45 speed: unknown
Processor#45 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#46 speed: unknown
Processor#46 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#47 speed: unknown
Processor#47 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#48 speed: unknown
Processor#48 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#49 speed: unknown
Processor#49 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#50 speed: unknown
Processor#50 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#51 speed: unknown
Processor#51 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#52 speed: unknown
Processor#52 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#53 speed: unknown
Processor#53 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#54 speed: unknown
Processor#54 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#55 speed: unknown
Processor#55 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#56 speed: unknown
Processor#56 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#57 speed: unknown
Processor#57 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#58 speed: unknown
Processor#58 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#59 speed: unknown
Processor#59 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#60 speed: unknown
Processor#60 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#61 speed: unknown
Processor#61 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#62 speed: unknown
Processor#62 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#63 speed: unknown
Processor#63 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#64 speed: unknown
Processor#64 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#65 speed: unknown
Processor#65 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#66 speed: unknown
Processor#66 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#67 speed: unknown
Processor#67 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#68 speed: unknown
Processor#68 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#69 speed: unknown
Processor#69 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#70 speed: unknown
Processor#70 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Processor#71 speed: unknown
Processor#71 description: Intel(R) Xeon(R) CPU E5-2699 v3 @ 2.30GHz
Memory size: 32670 MByte
Memory available: 27511 MByte
Operating system: Windows 10
Operating system version: 10.0.19045

2023-05-03 11:55:18 (2888): 
Command: VBoxManage -q showvminfo "boinc_512721856aa840c6" --machinereadable 
Exit Code: 0
Output:
name="boinc_512721856aa840c6"
groups="/"
ostype="Linux 2.6 / 3.x / 4.x (64-bit)"
UUID="419fb05b-c82b-4782-85cd-6e5c68e1e7c4"
CfgFile="C:\\ProgramData\\BOINC\\slots\\12\\boinc_512721856aa840c6\\boinc_512721856aa840c6.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\12\\boinc_512721856aa840c6\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\12\\boinc_512721856aa840c6\\Logs"
hardwareuuid="419fb05b-c82b-4782-85cd-6e5c68e1e7c4"
memory=2792
pagefusion="off"
vram=16
cpuexecutioncap=100
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=2
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="poweroff"
VMStateChangeTime="2023-05-02T05:13:38.000000000"
graphicscontroller="vboxvga"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
vmprocpriority="default"
storagecontrollername0="Hard Disk Controller"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="3"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="C:\ProgramData\BOINC\slots\12\boinc_512721856aa840c6\Snapshots/{9ae69b86-f825-4a0e-b08f-81f404ebc762}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="9ae69b86-f825-4a0e-b08f-81f404ebc762"
"Hard Disk Controller-1-0"="C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="5a602f79-476e-4326-8f71-ee3b9aa4edd7"
"Hard Disk Controller-tempeject"="off"
"Hard Disk Controller-IsEjected"="off"
"Hard Disk Controller-2-0"="none"
natnet1="nat"
macaddress1="0800279B8804"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_50511_80,tcp,127.0.0.1,50511,,80"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
audio_out="off"
audio_in="off"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
xhci="off"
BandwidthGroup0=boinc_512721856aa840c6_net,Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\12\\shared"
videocap="off"
videocapaudio="off"
capturescreens="0"
capturefilename="C:\\ProgramData\\BOINC\\slots\\12\\boinc_512721856aa840c6\\boinc_512721856aa840c6.webm"
captureres="1024x768"
capturevideorate=512
capturevideofps=25
captureopts=""
description="CMS_2990776_1682846068.734374_0"
GuestMemoryBalloon=0

2023-05-03 11:55:41 (2888): 
Command: VBoxManage -q startvm "boinc_512721856aa840c6" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_512721856aa840c6" to power on...
VM "boinc_512721856aa840c6" has been successfully started.

2023-05-03 11:55:42 (2888): 
Command: VBoxManage -q controlvm "boinc_512721856aa840c6" cpuexecutioncap 100 
Exit Code: 0
Output:

2023-05-03 13:55:05 (2888): 
Command: VBoxManage -q controlvm "boinc_512721856aa840c6" poweroff
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2023-05-03 13:55:05 (2888): 
Command: VBoxManage -q snapshot "boinc_512721856aa840c6" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2023-05-03 13:55:05 (2888): 
Command: VBoxManage -q bandwidthctl "boinc_512721856aa840c6" remove "boinc_512721856aa840c6_net" 
Exit Code: 0
Output:

2023-05-03 13:55:05 (2888): 
Command: VBoxManage -q unregistervm "boinc_512721856aa840c6" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

13:55:11 (2888): called boinc_finish(194)

</stderr_txt>
]]>
Development for LHC@home

Stderr output
