Name | CMS_2156648_1626005420.826330_0 |
Workunit | 2102753 |
Created | 11 Jul 2021, 12:10:21 UTC |
Sent | 11 Jul 2021, 23:39:35 UTC |
Report deadline | 18 Jul 2021, 23:39:35 UTC |
Received | 15 Jul 2021, 8:43:01 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 4446 |
Run time | 5 hours 39 min 18 sec |
CPU time | 6 hours 8 min 24 sec |
Validate state | Valid |
Credit | 256.13 |
Device peak FLOPS | 6.00 GFLOPS |
Application version | CMS Simulation v60.50 (vbox64_mt_mcore_cms) windows_x86_64 |
Peak working set size | 68.36 MB |
Peak swap size | 68.67 MB |
Peak disk usage | 7.38 GB |
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> 2021-07-12 15:11:44 (4840): Detected: vboxwrapper 26197 2021-07-12 15:11:44 (4840): Detected: BOINC client v7.7 2021-07-12 15:11:51 (4840): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-12 15:11:51 (4840): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-12 15:11:51 (4840): Successfully copied 'init_data.xml' to the shared directory. 2021-07-12 15:11:52 (4840): Create VM. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-12 15:11:53 (4840): Setting Memory Size for VM. (6376MB) 2021-07-12 15:11:53 (4840): Setting CPU Count for VM. (6) 2021-07-12 15:11:53 (4840): Setting Chipset Options for VM. 2021-07-12 15:11:54 (4840): Setting Boot Options for VM. 2021-07-12 15:11:54 (4840): Setting Network Configuration for NAT. 2021-07-12 15:11:54 (4840): Enabling VM Network Access. 2021-07-12 15:11:54 (4840): Disabling USB Support for VM. 2021-07-12 15:11:55 (4840): Disabling COM Port Support for VM. 2021-07-12 15:11:55 (4840): Disabling LPT Port Support for VM. 2021-07-12 15:11:55 (4840): Disabling Audio Support for VM. 2021-07-12 15:11:55 (4840): Disabling Clipboard Support for VM. 2021-07-12 15:11:56 (4840): Disabling Drag and Drop Support for VM. 2021-07-12 15:11:56 (4840): Adding storage controller(s) to VM. 2021-07-12 15:11:56 (4840): Adding virtual disk drive to VM. (vm_image.vdi) 2021-07-12 15:11:57 (4840): Adding VirtualBox Guest Additions to VM. 2021-07-12 15:11:57 (4840): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2021-07-12 15:11:58 (4840): forwarding host port 57742 to guest port 80 2021-07-12 15:11:58 (4840): Enabling remote desktop for VM. 2021-07-12 15:11:58 (4840): Required extension pack not installed, remote desktop not enabled. 2021-07-12 15:11:58 (4840): Enabling shared directory for VM. 2021-07-12 15:11:58 (4840): Starting VM using VBoxManage interface. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-12 15:12:08 (4840): Successfully started VM. (PID = '3356') 2021-07-12 15:12:08 (4840): Reporting VM Process ID to BOINC. 2021-07-12 15:12:08 (4840): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-12 15:12:08 (4840): Guest Log: CPUID EDX: 0x178bfbff 2021-07-12 15:12:08 (4840): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-12 15:12:08 (4840): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-12 15:12:08 (4840): Detected: Web Application Enabled (http://localhost:57742) 2021-07-12 15:12:08 (4840): Preference change detected 2021-07-12 15:12:08 (4840): Setting CPU throttle for VM. (90%) 2021-07-12 15:12:08 (4840): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-12 15:12:10 (4840): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-12 15:12:10 (4840): Guest Log: BIOS: Booting from Hard Disk... 2021-07-12 15:12:14 (4840): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-12 15:12:14 (4840): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-12 15:13:12 (4840): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-12 15:13:12 (4840): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-12 15:13:18 (4840): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.000366 main Log opened 2021-07-12T05:13:55.014387000Z 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.000523 main OS Product: Linux 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.000588 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.000647 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.000702 main Executable: /usr/sbin/VBoxService 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.000704 main Process ID: 2372 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.000705 main Package type: LINUX_64BITS_GENERIC 2021-07-12 15:13:18 (4840): Guest Log: 00:00:00.002591 main 5.2.6 r120293 started. Verbose level = 0 2021-07-12 15:13:55 (4840): Guest Log: [INFO] Mounting the shared directory 2021-07-12 15:13:55 (4840): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-12 15:13:55 (4840): Guest Log: [INFO] Testing connection to cern.ch 2021-07-12 15:13:56 (4840): Guest Log: [INFO] Testing connection to VCCS 2021-07-12 15:13:57 (4840): Guest Log: [INFO] Testing connection to HTCondor 2021-07-12 15:13:58 (4840): Guest Log: [INFO] Testing connection to WMAgent 2021-07-12 15:14:00 (4840): Guest Log: [INFO] CVMFS and Frontier will use DIRECT instead of an HTTP proxy. 2021-07-12 15:14:00 (4840): Guest Log: [INFO] A local HTTP proxy could help making the network usage 2021-07-12 15:14:00 (4840): Guest Log: [INFO] of this application more efficient. It would also help to 2021-07-12 15:14:00 (4840): Guest Log: [INFO] offload the project servers. 2021-07-12 15:14:01 (4840): Guest Log: [INFO] Details can be found in the project forum. 2021-07-12 15:14:01 (4840): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-12 15:14:09 (4840): Guest Log: [INFO] Probing CVMFS ... 2021-07-12 15:14:12 (4840): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-12 15:14:15 (4840): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-12 15:14:27 (4840): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-12 15:14:39 (4840): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-12 15:14:49 (4840): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-07-12 15:14:58 (4840): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-07-12 15:15:00 (4840): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2021-07-12 15:15:00 (4840): Guest Log: 2.7.2.0 3075 1 28148 15683 3 1 2079748 10240000 2 65024 0 8 100 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-07-12 15:15:20 (4840): Guest Log: [INFO] Reading volunteer information 2021-07-12 15:15:20 (4840): Guest Log: [INFO] Volunteer: Bunteck (302) 2021-07-12 15:15:21 (4840): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-07-12 15:15:24 (4840): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-07-12 15:15:27 (4840): Guest Log: [INFO] CMS application starting. Check log files. 2021-07-12 15:38:55 (4840): Stopping VM. 2021-07-12 15:41:41 (4840): 2021-07-13 23:26:20 (3492): Detected: vboxwrapper 26197 2021-07-13 23:26:20 (3492): Detected: BOINC client v7.7 2021-07-13 23:26:29 (3492): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-13 23:26:31 (3492): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-13 23:26:32 (3492): Register VM. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-13 23:26:37 (3492): Starting VM using VBoxManage interface. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-13 23:27:20 (3492): Successfully started VM. (PID = '5012') 2021-07-13 23:27:20 (3492): Reporting VM Process ID to BOINC. 2021-07-13 23:27:20 (3492): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-13 23:27:20 (3492): Guest Log: CPUID EDX: 0x178bfbff 2021-07-13 23:27:20 (3492): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-13 23:27:20 (3492): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-13 23:27:20 (3492): Detected: Web Application Enabled (http://localhost:57742) 2021-07-13 23:27:20 (3492): Preference change detected 2021-07-13 23:27:20 (3492): Setting CPU throttle for VM. (90%) 2021-07-13 23:27:21 (3492): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-13 23:27:22 (3492): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-13 23:27:22 (3492): Guest Log: BIOS: Booting from Hard Disk... 2021-07-13 23:27:29 (3492): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-13 23:27:29 (3492): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-13 23:28:39 (3492): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-13 23:28:39 (3492): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-13 23:28:48 (3492): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.000659 main Log opened 2021-07-13T13:29:29.397152000Z 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.001354 main OS Product: Linux 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.001437 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.001494 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.001547 main Executable: /usr/sbin/VBoxService 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.001548 main Process ID: 2341 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.001549 main Package type: LINUX_64BITS_GENERIC 2021-07-13 23:28:48 (3492): Guest Log: 00:00:00.003271 main 5.2.6 r120293 started. Verbose level = 0 2021-07-13 23:29:43 (3492): Guest Log: [INFO] Mounting the shared directory 2021-07-13 23:29:44 (3492): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-13 23:29:44 (3492): Guest Log: [INFO] Testing connection to cern.ch 2021-07-13 23:29:45 (3492): Guest Log: [INFO] Testing connection to VCCS 2021-07-13 23:29:46 (3492): Guest Log: [INFO] Testing connection to HTCondor 2021-07-13 23:29:47 (3492): Guest Log: [INFO] Testing connection to WMAgent 2021-07-13 23:29:50 (3492): Guest Log: [INFO] CVMFS and Frontier will use DIRECT instead of an HTTP proxy. 2021-07-13 23:29:50 (3492): Guest Log: [INFO] A local HTTP proxy could help making the network usage 2021-07-13 23:29:50 (3492): Guest Log: [INFO] of this application more efficient. It would also help to 2021-07-13 23:29:50 (3492): Guest Log: [INFO] offload the project servers. 2021-07-13 23:29:50 (3492): Guest Log: [INFO] Details can be found in the project forum. 2021-07-13 23:29:51 (3492): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-13 23:29:58 (3492): Guest Log: [INFO] Probing CVMFS ... 2021-07-13 23:30:00 (3492): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-13 23:30:03 (3492): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-13 23:30:15 (3492): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-13 23:30:27 (3492): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-13 23:30:38 (3492): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-07-13 23:30:49 (3492): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-07-13 23:30:51 (3492): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2021-07-13 23:30:51 (3492): Guest Log: 2.7.2.0 3098 1 28176 15697 3 1 2239054 10240001 2 65024 0 8 100 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2021-07-13 23:31:15 (3492): Guest Log: [INFO] Reading volunteer information 2021-07-13 23:31:17 (3492): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-07-13 23:31:22 (3492): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-07-13 23:31:25 (3492): Guest Log: [INFO] CMS application starting. Check log files. 2021-07-14 00:40:34 (3492): Status Report: Job Duration: '64800.000000' 2021-07-14 00:40:34 (3492): Status Report: Elapsed Time: '6000.061144' 2021-07-14 00:40:34 (3492): Status Report: CPU Time: '6566.986896' 2021-07-14 01:44:01 (3492): Stopping VM. 2021-07-14 01:44:48 (3492): Error in stop VM for VM: -182 Command: VBoxManage -q controlvm "boinc_cd52d4227e16c4fb" savestate Output: 0%...10%...20%...30%...40%... 2021-07-14 01:44:48 (3492): VM did not stop when requested. 2021-07-14 01:44:48 (3492): VM was successfully terminated. 2021-07-14 03:42:08 (4932): Detected: vboxwrapper 26197 2021-07-14 03:42:08 (4932): Detected: BOINC client v7.7 2021-07-14 03:42:08 (4932): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-14 03:42:09 (4932): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-14 03:42:09 (4932): Starting VM using VBoxManage interface. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-14 03:42:13 (4932): Successfully started VM. (PID = '1028') 2021-07-14 03:42:13 (4932): Reporting VM Process ID to BOINC. 2021-07-14 03:42:13 (4932): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-14 03:42:13 (4932): Guest Log: CPUID EDX: 0x178bfbff 2021-07-14 03:42:13 (4932): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-14 03:42:13 (4932): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-14 03:42:13 (4932): Detected: Web Application Enabled (http://localhost:57742) 2021-07-14 03:42:13 (4932): Status Report: Job Duration: '64800.000000' 2021-07-14 03:42:13 (4932): Status Report: Elapsed Time: '9806.061144' 2021-07-14 03:42:13 (4932): Status Report: CPU Time: '10948.118980' 2021-07-14 03:42:13 (4932): Preference change detected 2021-07-14 03:42:13 (4932): Setting CPU throttle for VM. (90%) 2021-07-14 03:42:13 (4932): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-14 03:42:15 (4932): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-14 03:42:15 (4932): Guest Log: BIOS: Booting from Hard Disk... 2021-07-14 03:42:18 (4932): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-14 03:42:18 (4932): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-14 03:43:01 (4932): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-14 03:43:01 (4932): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-14 03:43:03 (4932): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.000964 main Log opened 2021-07-13T17:43:41.654410000Z 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.001298 main OS Product: Linux 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.001556 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.001626 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.001690 main Executable: /usr/sbin/VBoxService 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.001692 main Process ID: 2354 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.001694 main Package type: LINUX_64BITS_GENERIC 2021-07-14 03:43:03 (4932): Guest Log: 00:00:00.006424 main 5.2.6 r120293 started. Verbose level = 0 2021-07-14 03:43:43 (4932): Guest Log: [INFO] Mounting the shared directory 2021-07-14 03:43:43 (4932): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-14 03:43:43 (4932): Guest Log: [INFO] Testing connection to cern.ch 2021-07-14 03:43:44 (4932): Guest Log: [INFO] Testing connection to VCCS 2021-07-14 03:43:45 (4932): Guest Log: [INFO] Testing connection to HTCondor 2021-07-14 03:43:46 (4932): Guest Log: [INFO] Testing connection to WMAgent 2021-07-14 03:43:47 (4932): Guest Log: [INFO] Testing connection to Frontier 2021-07-14 03:43:48 (4932): Guest Log: [INFO] CVMFS and Frontier will use DIRECT instead of an HTTP proxy. 2021-07-14 03:43:49 (4932): Guest Log: [INFO] A local HTTP proxy could help making the network usage 2021-07-14 03:43:49 (4932): Guest Log: [INFO] of this application more efficient. It would also help to 2021-07-14 03:43:49 (4932): Guest Log: [INFO] offload the project servers. 2021-07-14 03:43:49 (4932): Guest Log: [INFO] Details can be found in the project forum. 2021-07-14 03:43:49 (4932): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-14 03:43:57 (4932): Guest Log: [INFO] Probing CVMFS ... 2021-07-14 03:44:00 (4932): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-14 03:44:03 (4932): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-14 03:44:15 (4932): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-14 03:44:28 (4932): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-14 03:44:36 (4932): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-07-14 03:44:47 (4932): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-07-14 03:44:49 (4932): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2021-07-14 03:44:49 (4932): Guest Log: 2.7.2.0 3066 1 28176 15701 3 1 2370026 10240001 2 65024 0 8 100 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-07-14 03:44:55 (4932): Guest Log: [INFO] Reading volunteer information 2021-07-14 03:44:56 (4932): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-07-14 03:44:58 (4932): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-07-14 03:45:01 (4932): Guest Log: [INFO] CMS application starting. Check log files. 2021-07-14 04:42:46 (4932): Stopping VM. 2021-07-14 04:45:03 (4932): Error in stop VM for VM: -182 Command: VBoxManage -q controlvm "boinc_cd52d4227e16c4fb" savestate Output: 0%...10%...20%...30%...40%... 2021-07-14 04:45:06 (4932): VM did not stop when requested. 2021-07-14 04:45:10 (4932): VM was successfully terminated. 2021-07-14 13:23:58 (6400): Detected: vboxwrapper 26197 2021-07-14 13:23:58 (6400): Detected: BOINC client v7.7 2021-07-14 13:23:59 (6400): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-14 13:24:00 (6400): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-14 13:24:00 (6400): Starting VM using VBoxManage interface. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-14 13:24:10 (6400): Successfully started VM. (PID = '4664') 2021-07-14 13:24:10 (6400): Reporting VM Process ID to BOINC. 2021-07-14 13:24:10 (6400): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-14 13:24:10 (6400): Guest Log: CPUID EDX: 0x178bfbff 2021-07-14 13:24:10 (6400): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-14 13:24:10 (6400): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-14 13:24:10 (6400): Detected: Web Application Enabled (http://localhost:57742) 2021-07-14 13:24:10 (6400): Status Report: Job Duration: '64800.000000' 2021-07-14 13:24:10 (6400): Status Report: Elapsed Time: '13439.061144' 2021-07-14 13:24:10 (6400): Status Report: CPU Time: '14598.901182' 2021-07-14 13:24:10 (6400): Preference change detected 2021-07-14 13:24:10 (6400): Setting CPU throttle for VM. (90%) 2021-07-14 13:24:11 (6400): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-14 13:24:12 (6400): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-14 13:24:12 (6400): Guest Log: BIOS: Booting from Hard Disk... 2021-07-14 13:24:15 (6400): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-14 13:24:15 (6400): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-14 13:25:07 (6400): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-14 13:25:07 (6400): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-14 13:25:10 (6400): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.000313 main Log opened 2021-07-14T03:25:10.854122000Z 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.000553 main OS Product: Linux 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.000638 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.000716 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.000790 main Executable: /usr/sbin/VBoxService 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.000792 main Process ID: 2369 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.000794 main Package type: LINUX_64BITS_GENERIC 2021-07-14 13:25:10 (6400): Guest Log: 00:00:00.002308 main 5.2.6 r120293 started. Verbose level = 0 2021-07-14 13:25:50 (6400): Guest Log: [INFO] Mounting the shared directory 2021-07-14 13:25:50 (6400): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-14 13:25:51 (6400): Guest Log: [INFO] Testing connection to cern.ch 2021-07-14 13:25:52 (6400): Guest Log: [INFO] Testing connection to VCCS 2021-07-14 13:25:53 (6400): Guest Log: [INFO] Testing connection to HTCondor 2021-07-14 13:25:54 (6400): Guest Log: [INFO] Testing connection to WMAgent 2021-07-14 13:25:54 (6400): Guest Log: [INFO] Testing connection to Frontier 2021-07-14 13:25:57 (6400): Guest Log: [INFO] CVMFS and Frontier will use DIRECT instead of an HTTP proxy. 2021-07-14 13:25:57 (6400): Guest Log: [INFO] A local HTTP proxy could help making the network usage 2021-07-14 13:25:57 (6400): Guest Log: [INFO] of this application more efficient. It would also help to 2021-07-14 13:25:57 (6400): Guest Log: [INFO] offload the project servers. 2021-07-14 13:25:57 (6400): Guest Log: [INFO] Details can be found in the project forum. 2021-07-14 13:25:58 (6400): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-14 13:26:05 (6400): Guest Log: [INFO] Probing CVMFS ... 2021-07-14 13:26:08 (6400): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-14 13:26:11 (6400): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-14 13:26:23 (6400): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-14 13:26:34 (6400): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-14 13:26:45 (6400): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-07-14 13:26:56 (6400): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-07-14 13:26:58 (6400): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2021-07-14 13:26:58 (6400): Guest Log: 2.7.2.0 3072 1 28128 15705 3 1 2393581 10240001 2 65024 0 8 100 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-07-14 13:27:13 (6400): Guest Log: [INFO] Reading volunteer information 2021-07-14 13:27:15 (6400): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-07-14 13:27:18 (6400): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-07-14 13:27:21 (6400): Guest Log: [INFO] CMS application starting. Check log files. 2021-07-14 14:24:33 (6400): Stopping VM. 2021-07-15 16:42:55 (3976): Detected: vboxwrapper 26197 2021-07-15 16:42:55 (3976): Detected: BOINC client v7.7 2021-07-15 16:42:56 (3976): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-15 16:42:57 (3976): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-15 16:42:57 (3976): Starting VM using VBoxManage interface. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-15 16:43:07 (3976): Successfully started VM. (PID = '4796') 2021-07-15 16:43:07 (3976): Reporting VM Process ID to BOINC. 2021-07-15 16:43:07 (3976): Guest Log: BIOS: VirtualBox 6.1.12 2021-07-15 16:43:07 (3976): Guest Log: CPUID EDX: 0x178bfbff 2021-07-15 16:43:07 (3976): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2021-07-15 16:43:07 (3976): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-15 16:43:07 (3976): Detected: Web Application Enabled (http://localhost:57742) 2021-07-15 16:43:07 (3976): Status Report: Job Duration: '64800.000000' 2021-07-15 16:43:07 (3976): Status Report: Elapsed Time: '17061.061144' 2021-07-15 16:43:07 (3976): Status Report: CPU Time: '19111.604509' 2021-07-15 16:43:07 (3976): Preference change detected 2021-07-15 16:43:07 (3976): Setting CPU throttle for VM. (90%) 2021-07-15 16:43:07 (3976): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-15 16:43:09 (3976): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2021-07-15 16:43:09 (3976): Guest Log: BIOS: Booting from Hard Disk... 2021-07-15 16:43:13 (3976): Guest Log: BIOS: KBD: unsupported int 16h function 03 2021-07-15 16:43:13 (3976): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2021-07-15 16:44:01 (3976): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2021-07-15 16:44:01 (3976): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2021-07-15 16:44:03 (3976): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.001102 main Log opened 2021-07-15T06:45:41.644682000Z 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.001296 main OS Product: Linux 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.001365 main OS Release: 4.14.232-19.cernvm.x86_64 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.001422 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.001474 main Executable: /usr/sbin/VBoxService 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.001476 main Process ID: 2361 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.001477 main Package type: LINUX_64BITS_GENERIC 2021-07-15 16:44:03 (3976): Guest Log: 00:00:00.002775 main 5.2.6 r120293 started. Verbose level = 0 2021-07-15 16:46:16 (3976): Guest Log: [INFO] Mounting the shared directory 2021-07-15 16:46:16 (3976): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2021-07-15 16:46:16 (3976): Guest Log: [INFO] Testing connection to cern.ch 2021-07-15 16:46:17 (3976): Guest Log: [INFO] Testing connection to VCCS 2021-07-15 16:46:18 (3976): Guest Log: [INFO] Testing connection to HTCondor 2021-07-15 16:46:19 (3976): Guest Log: [INFO] Testing connection to WMAgent 2021-07-15 16:46:20 (3976): Guest Log: [INFO] Testing connection to Frontier 2021-07-15 16:46:22 (3976): Guest Log: [INFO] Could not find a local HTTP proxy. 2021-07-15 16:46:22 (3976): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections. 2021-07-15 16:46:23 (3976): Guest Log: [INFO] This makes the application less efficient. 2021-07-15 16:46:23 (3976): Guest Log: [INFO] It also puts higher load on the project servers. 2021-07-15 16:46:23 (3976): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended. 2021-07-15 16:46:23 (3976): Guest Log: [INFO] Advice can be found in the project forum. 2021-07-15 16:46:23 (3976): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ... 2021-07-15 16:46:32 (3976): Guest Log: [INFO] Probing CVMFS ... 2021-07-15 16:46:36 (3976): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2021-07-15 16:46:39 (3976): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2021-07-15 16:46:51 (3976): Guest Log: Probing /cvmfs/cms.cern.ch... OK 2021-07-15 16:47:04 (3976): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK 2021-07-15 16:47:14 (3976): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK 2021-07-15 16:47:24 (3976): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK 2021-07-15 16:47:27 (3976): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2021-07-15 16:47:27 (3976): Guest Log: 2.7.2.0 3075 1 30184 15717 3 1 2422323 10240000 2 65024 0 8 100 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2021-07-15 16:47:52 (3976): Guest Log: [INFO] Reading volunteer information 2021-07-15 16:47:53 (3976): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2021-07-15 16:47:56 (3976): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2021-07-15 16:48:00 (3976): Guest Log: [INFO] CMS application starting. Check log files. 2021-07-15 17:00:22 (3976): Stopping VM. 2021-07-15 18:01:25 (3316): Detected: vboxwrapper 26197 2021-07-15 18:01:25 (3316): Detected: BOINC client v7.7 2021-07-15 18:01:26 (3316): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2021-07-15 18:01:26 (3316): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2021-07-15 18:01:26 (3316): Starting VM using VBoxManage interface. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-15 18:01:45 (3316): Successfully started VM. (PID = '2928') 2021-07-15 18:01:45 (3316): Reporting VM Process ID to BOINC. 2021-07-15 18:01:45 (3316): VM state change detected. (old = 'PoweredOff', new = 'Running') 2021-07-15 18:01:45 (3316): Detected: Web Application Enabled (http://localhost:57742) 2021-07-15 18:01:46 (3316): VM state change detected. (old = 'Running', new = 'Paused') 2021-07-15 18:01:50 (3316): Status Report: Job Duration: '64800.000000' 2021-07-15 18:01:50 (3316): Status Report: Elapsed Time: '17997.061144' 2021-07-15 18:01:50 (3316): Status Report: CPU Time: '20172.676511' 2021-07-15 18:01:50 (3316): Preference change detected 2021-07-15 18:01:50 (3316): Setting CPU throttle for VM. (90%) 2021-07-15 18:01:51 (3316): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2021-07-15 18:01:51 (3316): VM state change detected. (old = 'Paused', new = 'Running') 2021-07-15 18:01:57 (3316): Guest Log: 00:14:50.302515 timesync vgsvcTimeSyncWorker: Radical host time change: 3 695 498 000 000ns (HostNow=1 626 336 117 445 000 000 ns HostLast=1 626 332 421 947 000 000 ns) 2021-07-15 18:02:07 (3316): Guest Log: 00:15:00.302844 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 695 499 674 000ns (GuestNow=1 626 336 127 445 534 000 ns GuestLast=1 626 332 431 945 860 000 ns fSetTimeLastLoop=true ) 2021-07-15 18:37:29 (3316): Guest Log: [INFO] glidein exited with return value 0. 2021-07-15 18:37:29 (3316): Guest Log: [INFO] Shutting Down. 2021-07-15 18:37:29 (3316): VM Completion File Detected. 2021-07-15 18:37:29 (3316): VM Completion Message: glidein exited with return value 0. . 2021-07-15 18:37:29 (3316): Powering off VM. 2021-07-15 18:42:30 (3316): VM did not power off when requested. 2021-07-15 18:42:30 (3316): VM was successfully terminated. 2021-07-15 18:42:30 (3316): Deregistering VM. (boinc_cd52d4227e16c4fb, slot#5) 2021-07-15 18:42:30 (3316): Removing network bandwidth throttle group from VM. 2021-07-15 18:42:30 (3316): Removing VM from VirtualBox. 18:42:36 (3316): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN