Name | CMS_1238621_1569051128.366926_0 |
Workunit | 1940101 |
Created | 21 Sep 2019, 7:32:11 UTC |
Sent | 22 Sep 2019, 1:54:57 UTC |
Report deadline | 29 Sep 2019, 1:54:57 UTC |
Received | 25 Sep 2019, 2:16:19 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 1031 |
Run time | 17 hours 48 min 44 sec |
CPU time | 15 hours 50 min 4 sec |
Validate state | Valid |
Credit | 2,450.14 |
Device peak FLOPS | 5.25 GFLOPS |
Application version | CMS Simulation v49.00 (vbox64_mt_mcore_cms) x86_64-pc-linux-gnu |
Peak working set size | 150.60 MB |
Peak swap size | 4.48 GB |
Peak disk usage | 3.89 GB |
<core_client_version>7.4.25</core_client_version> <![CDATA[ <stderr_txt> 2019-09-22 02:56:16 (28957): vboxwrapper (7.7.26196): starting 2019-09-22 02:56:18 (28957): Feature: Checkpoint interval offset (40 seconds) 2019-09-22 02:56:18 (28957): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-09-22 02:56:18 (28957): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-22 02:56:18 (28957): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-22 02:56:18 (28957): Successfully copied 'init_data.xml' to the shared directory. 2019-09-22 02:56:18 (28957): Create VM. (boinc_933354f9513bb39b, slot#0) 2019-09-22 02:56:18 (28957): Setting Memory Size for VM. (2792MB) 2019-09-22 02:56:18 (28957): Setting CPU Count for VM. (1) 2019-09-22 02:56:19 (28957): Setting Chipset Options for VM. 2019-09-22 02:56:19 (28957): Setting Boot Options for VM. 2019-09-22 02:56:19 (28957): Setting Network Configuration for NAT. 2019-09-22 02:56:19 (28957): Enabling VM Network Access. 2019-09-22 02:56:19 (28957): Disabling USB Support for VM. 2019-09-22 02:56:19 (28957): Disabling COM Port Support for VM. 2019-09-22 02:56:19 (28957): Disabling LPT Port Support for VM. 2019-09-22 02:56:19 (28957): Disabling Audio Support for VM. 2019-09-22 02:56:19 (28957): Disabling Clipboard Support for VM. 2019-09-22 02:56:20 (28957): Disabling Drag and Drop Support for VM. 2019-09-22 02:56:20 (28957): Adding storage controller(s) to VM. 2019-09-22 02:56:20 (28957): Adding virtual disk drive to VM. (vm_image.vdi) 2019-09-22 02:56:20 (28957): Adding VirtualBox Guest Additions to VM. 2019-09-22 02:56:20 (28957): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-09-22 02:56:20 (28957): forwarding host port 54402 to guest port 80 2019-09-22 02:56:20 (28957): Enabling remote desktop for VM. 2019-09-22 02:56:20 (28957): Enabling shared directory for VM. 2019-09-22 02:56:21 (28957): Starting VM. (boinc_933354f9513bb39b, slot#0) 2019-09-22 02:56:23 (28957): Successfully started VM. (PID = '29439') 2019-09-22 02:56:23 (28957): Reporting VM Process ID to BOINC. 2019-09-22 02:56:23 (28957): Guest Log: BIOS: VirtualBox 5.2.8 2019-09-22 02:56:23 (28957): Guest Log: CPUID EDX: 0x078bfbff 2019-09-22 02:56:23 (28957): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-22 02:56:23 (28957): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-22 02:56:23 (28957): Detected: Web Application Enabled (http://localhost:54402) 2019-09-22 02:56:23 (28957): Detected: Remote Desktop Enabled (localhost:33247) 2019-09-22 02:56:23 (28957): Preference change detected 2019-09-22 02:56:23 (28957): Setting CPU throttle for VM. (100%) 2019-09-22 02:56:23 (28957): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-22 02:56:25 (28957): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-22 02:56:25 (28957): Guest Log: BIOS: Booting from Hard Disk... 2019-09-22 02:56:30 (28957): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-22 02:56:30 (28957): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-22 02:56:57 (28957): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-22 02:56:57 (28957): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-22 02:57:46 (28957): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.001589 main Log opened 2019-09-22T01:57:44.840140000Z 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.003160 main OS Product: Linux 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.003381 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.003440 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.003493 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.003494 main Process ID: 2970 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.003495 main Package type: LINUX_64BITS_GENERIC 2019-09-22 02:57:46 (28957): Guest Log: 00:00:00.005909 main 5.2.6 r120293 started. Verbose level = 0 2019-09-22 02:59:27 (28957): Guest Log: [INFO] Mounting the shared directory 2019-09-22 02:59:27 (28957): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-22 02:59:27 (28957): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-22 02:59:28 (28957): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-22 02:59:28 (28957): Guest Log: [DEBUG] 0 2019-09-22 02:59:28 (28957): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-22 02:59:28 (28957): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-22 02:59:28 (28957): Guest Log: [DEBUG] 0 2019-09-22 02:59:28 (28957): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-22 02:59:30 (28957): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-22 02:59:30 (28957): Guest Log: [DEBUG] 0 2019-09-22 02:59:30 (28957): Guest Log: [DEBUG] Detected local proxy http://192.168.100.137:3128 in init_data.xml 2019-09-22 02:59:30 (28957): Guest Log: [DEBUG] Testing connection to 192.168.100.137 on port 3128 2019-09-22 02:59:30 (28957): Guest Log: [DEBUG] Connection to 192.168.100.137 3128 port [tcp/squid] succeeded! 2019-09-22 02:59:30 (28957): Guest Log: [DEBUG] 0 2019-09-22 03:01:03 (28957): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-22 03:01:22 (28957): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-22 03:01:30 (28957): 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 2019-09-22 03:01:30 (28957): Guest Log: 2.4.4.0 3711 2 25412 10299 3 1 1454385 10240001 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.168.100.137:3128 1 2019-09-22 03:01:34 (28957): Guest Log: [INFO] Reading volunteer information 2019-09-22 03:01:34 (28957): Guest Log: [INFO] Volunteer: m (178) 2019-09-22 03:01:34 (28957): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-22 03:01:34 (28957): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-22 03:01:35 (28957): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-22 03:01:37 (28957): Guest Log: [INFO] Running the fast benchmark. 2019-09-22 03:02:34 (28957): Guest Log: [INFO] Machine performance 9.01 HEPSPEC06 2019-09-22 03:02:34 (28957): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-22 03:02:36 (28957): Guest Log: [DEBUG] HTCondor ping 2019-09-22 03:02:38 (28957): Guest Log: [DEBUG] 0 2019-09-22 04:36:18 (28957): Status Report: Job Duration: '64800.000000' 2019-09-22 04:36:18 (28957): Status Report: Elapsed Time: '6002.873417' 2019-09-22 04:36:18 (28957): Status Report: CPU Time: '5308.440000' 2019-09-22 06:16:12 (28957): Status Report: Job Duration: '64800.000000' 2019-09-22 06:16:12 (28957): Status Report: Elapsed Time: '12003.084576' 2019-09-22 06:16:12 (28957): Status Report: CPU Time: '10669.180000' 2019-09-22 06:57:02 (28957): Stopping VM. 2019-09-23 01:04:04 (3097): vboxwrapper (7.7.26196): starting 2019-09-23 01:04:05 (3097): Feature: Checkpoint interval offset (31 seconds) 2019-09-23 01:04:05 (3097): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-09-23 01:04:05 (3097): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-23 01:04:05 (3097): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-23 01:04:06 (3097): Starting VM. (boinc_933354f9513bb39b, slot#0) 2019-09-23 01:04:08 (3097): Successfully started VM. (PID = '3205') 2019-09-23 01:04:08 (3097): Reporting VM Process ID to BOINC. 2019-09-23 01:04:08 (3097): Guest Log: BIOS: VirtualBox 5.2.8 2019-09-23 01:04:08 (3097): Guest Log: CPUID EDX: 0x078bfbff 2019-09-23 01:04:08 (3097): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-23 01:04:08 (3097): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-23 01:04:08 (3097): Detected: Web Application Enabled (http://localhost:54402) 2019-09-23 01:04:08 (3097): Detected: Remote Desktop Enabled (localhost:33247) 2019-09-23 01:04:08 (3097): Status Report: Job Duration: '64800.000000' 2019-09-23 01:04:08 (3097): Status Report: Elapsed Time: '14460.896039' 2019-09-23 01:04:08 (3097): Status Report: CPU Time: '12755.550000' 2019-09-23 01:04:08 (3097): Preference change detected 2019-09-23 01:04:08 (3097): Setting CPU throttle for VM. (100%) 2019-09-23 01:04:09 (3097): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-23 01:04:10 (3097): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-23 01:04:10 (3097): Guest Log: BIOS: Booting from Hard Disk... 2019-09-23 01:04:14 (3097): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-23 01:04:14 (3097): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-23 01:04:56 (3097): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-23 01:04:56 (3097): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-23 01:05:46 (3097): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.001461 main Log opened 2019-09-23T00:05:45.735659000Z 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.003176 main OS Product: Linux 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.003423 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.003485 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.003532 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.003533 main Process ID: 2904 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.003534 main Package type: LINUX_64BITS_GENERIC 2019-09-23 01:05:46 (3097): Guest Log: 00:00:00.005768 main 5.2.6 r120293 started. Verbose level = 0 2019-09-23 01:07:39 (3097): Guest Log: [INFO] Mounting the shared directory 2019-09-23 01:07:39 (3097): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-23 01:07:39 (3097): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-23 01:07:40 (3097): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-23 01:07:40 (3097): Guest Log: [DEBUG] 0 2019-09-23 01:07:40 (3097): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-23 01:07:40 (3097): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-23 01:07:40 (3097): Guest Log: [DEBUG] 0 2019-09-23 01:07:40 (3097): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-23 01:07:42 (3097): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-23 01:07:42 (3097): Guest Log: [DEBUG] 0 2019-09-23 01:07:42 (3097): Guest Log: [DEBUG] Detected local proxy http://192.168.100.137:3128 in init_data.xml 2019-09-23 01:07:42 (3097): Guest Log: [DEBUG] Testing connection to 192.168.100.137 on port 3128 2019-09-23 01:07:42 (3097): Guest Log: [DEBUG] Connection to 192.168.100.137 3128 port [tcp/squid] succeeded! 2019-09-23 01:07:42 (3097): Guest Log: [DEBUG] 0 2019-09-23 01:09:18 (3097): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-23 01:09:39 (3097): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-23 01:09:47 (3097): 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 2019-09-23 01:09:47 (3097): Guest Log: 2.4.4.0 3625 2 25376 10305 3 1 2429354 10240001 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.168.100.137:3128 1 2019-09-23 01:09:50 (3097): Guest Log: [INFO] Reading volunteer information 2019-09-23 01:09:50 (3097): Guest Log: [INFO] Volunteer: m (178) 2019-09-23 01:09:50 (3097): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-23 01:09:51 (3097): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-23 01:09:52 (3097): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-23 01:09:55 (3097): Guest Log: [INFO] Running the fast benchmark. 2019-09-23 01:10:55 (3097): Guest Log: [INFO] Machine performance 8.66 HEPSPEC06 2019-09-23 01:10:55 (3097): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-23 01:10:57 (3097): Guest Log: [DEBUG] HTCondor ping 2019-09-23 01:10:59 (3097): Guest Log: [DEBUG] 0 2019-09-23 02:44:04 (3097): Status Report: Job Duration: '64800.000000' 2019-09-23 02:44:04 (3097): Status Report: Elapsed Time: '20461.011928' 2019-09-23 02:44:04 (3097): Status Report: CPU Time: '18301.160000' 2019-09-23 04:23:58 (3097): Status Report: Job Duration: '64800.000000' 2019-09-23 04:23:58 (3097): Status Report: Elapsed Time: '26462.788341' 2019-09-23 04:23:58 (3097): Status Report: CPU Time: '23668.220000' 2019-09-23 06:03:52 (3097): Status Report: Job Duration: '64800.000000' 2019-09-23 06:03:52 (3097): Status Report: Elapsed Time: '32464.912055' 2019-09-23 06:03:52 (3097): Status Report: CPU Time: '29017.770000' 2019-09-23 06:57:01 (3097): Stopping VM. 2019-09-24 01:04:00 (3087): vboxwrapper (7.7.26196): starting 2019-09-24 01:04:06 (3087): Feature: Checkpoint interval offset (449 seconds) 2019-09-24 01:04:06 (3087): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-09-24 01:04:06 (3087): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-24 01:04:06 (3087): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-24 01:04:06 (3087): Starting VM. (boinc_933354f9513bb39b, slot#0) 2019-09-24 01:04:08 (3087): Successfully started VM. (PID = '3196') 2019-09-24 01:04:08 (3087): Reporting VM Process ID to BOINC. 2019-09-24 01:04:08 (3087): Guest Log: BIOS: VirtualBox 5.2.8 2019-09-24 01:04:08 (3087): Guest Log: CPUID EDX: 0x078bfbff 2019-09-24 01:04:08 (3087): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-24 01:04:08 (3087): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-24 01:04:08 (3087): Detected: Web Application Enabled (http://localhost:54402) 2019-09-24 01:04:08 (3087): Detected: Remote Desktop Enabled (localhost:33247) 2019-09-24 01:04:09 (3087): Status Report: Job Duration: '64800.000000' 2019-09-24 01:04:09 (3087): Status Report: Elapsed Time: '35663.384754' 2019-09-24 01:04:09 (3087): Status Report: CPU Time: '31561.240000' 2019-09-24 01:04:09 (3087): Preference change detected 2019-09-24 01:04:09 (3087): Setting CPU throttle for VM. (100%) 2019-09-24 01:04:09 (3087): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-24 01:04:11 (3087): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-24 01:04:11 (3087): Guest Log: BIOS: Booting from Hard Disk... 2019-09-24 01:04:14 (3087): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-24 01:04:14 (3087): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-24 01:04:44 (3087): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-24 01:04:44 (3087): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-24 01:05:36 (3087): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.001386 main Log opened 2019-09-24T00:05:34.701924000Z 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.002690 main OS Product: Linux 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.002857 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.002916 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.002963 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.002964 main Process ID: 2904 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.002964 main Package type: LINUX_64BITS_GENERIC 2019-09-24 01:05:36 (3087): Guest Log: 00:00:00.005266 main 5.2.6 r120293 started. Verbose level = 0 2019-09-24 01:07:21 (3087): Guest Log: [INFO] Mounting the shared directory 2019-09-24 01:07:21 (3087): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-24 01:07:22 (3087): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-24 01:07:23 (3087): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-24 01:07:23 (3087): Guest Log: [DEBUG] 0 2019-09-24 01:07:23 (3087): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-24 01:07:23 (3087): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-24 01:07:23 (3087): Guest Log: [DEBUG] 0 2019-09-24 01:07:24 (3087): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-24 01:07:24 (3087): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-24 01:07:24 (3087): Guest Log: [DEBUG] 0 2019-09-24 01:07:25 (3087): Guest Log: [DEBUG] Detected local proxy http://192.168.100.137:3128 in init_data.xml 2019-09-24 01:07:25 (3087): Guest Log: [DEBUG] Testing connection to 192.168.100.137 on port 3128 2019-09-24 01:07:25 (3087): Guest Log: [DEBUG] Connection to 192.168.100.137 3128 port [tcp/squid] succeeded! 2019-09-24 01:07:25 (3087): Guest Log: [DEBUG] 0 2019-09-24 01:08:57 (3087): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-24 01:09:15 (3087): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-24 01:09:22 (3087): 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 2019-09-24 01:09:22 (3087): Guest Log: 2.4.4.0 3627 2 25344 10313 3 1 2456361 10240001 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.168.100.137:3128 1 2019-09-24 01:09:25 (3087): Guest Log: [INFO] Reading volunteer information 2019-09-24 01:09:26 (3087): Guest Log: [INFO] Volunteer: m (178) 2019-09-24 01:09:26 (3087): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-24 01:09:27 (3087): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-24 01:09:28 (3087): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-24 01:09:30 (3087): Guest Log: [INFO] Running the fast benchmark. 2019-09-24 01:10:28 (3087): Guest Log: [INFO] Machine performance 8.91 HEPSPEC06 2019-09-24 01:10:28 (3087): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-24 01:10:30 (3087): Guest Log: [DEBUG] HTCondor ping 2019-09-24 01:10:32 (3087): Guest Log: [DEBUG] 0 2019-09-24 02:44:05 (3087): Status Report: Job Duration: '64800.000000' 2019-09-24 02:44:05 (3087): Status Report: Elapsed Time: '41665.698516' 2019-09-24 02:44:05 (3087): Status Report: CPU Time: '37136.310000' 2019-09-24 04:24:02 (3087): Status Report: Job Duration: '64800.000000' 2019-09-24 04:24:02 (3087): Status Report: Elapsed Time: '47667.942702' 2019-09-24 04:24:02 (3087): Status Report: CPU Time: '42465.120000' 2019-09-24 06:03:53 (3087): Status Report: Job Duration: '64800.000000' 2019-09-24 06:03:53 (3087): Status Report: Elapsed Time: '53668.972014' 2019-09-24 06:03:53 (3087): Status Report: CPU Time: '47846.150000' 2019-09-24 06:57:02 (3087): Stopping VM. 2019-09-25 01:03:56 (3077): vboxwrapper (7.7.26196): starting 2019-09-25 01:04:02 (3077): Feature: Checkpoint interval offset (462 seconds) 2019-09-25 01:04:02 (3077): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-09-25 01:04:02 (3077): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-25 01:04:02 (3077): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-25 01:04:03 (3077): Starting VM. (boinc_933354f9513bb39b, slot#0) 2019-09-25 01:04:04 (3077): Successfully started VM. (PID = '3186') 2019-09-25 01:04:04 (3077): Reporting VM Process ID to BOINC. 2019-09-25 01:04:05 (3077): Guest Log: BIOS: VirtualBox 5.2.8 2019-09-25 01:04:05 (3077): Guest Log: CPUID EDX: 0x078bfbff 2019-09-25 01:04:05 (3077): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-25 01:04:05 (3077): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-25 01:04:05 (3077): Detected: Web Application Enabled (http://localhost:54402) 2019-09-25 01:04:05 (3077): Detected: Remote Desktop Enabled (localhost:33247) 2019-09-25 01:04:05 (3077): Status Report: Job Duration: '64800.000000' 2019-09-25 01:04:05 (3077): Status Report: Elapsed Time: '56866.865899' 2019-09-25 01:04:05 (3077): Status Report: CPU Time: '50068.310000' 2019-09-25 01:04:05 (3077): Preference change detected 2019-09-25 01:04:05 (3077): Setting CPU throttle for VM. (100%) 2019-09-25 01:04:05 (3077): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-25 01:04:07 (3077): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-25 01:04:07 (3077): Guest Log: BIOS: Booting from Hard Disk... 2019-09-25 01:04:11 (3077): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-25 01:04:11 (3077): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-25 01:04:38 (3077): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-25 01:04:38 (3077): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-25 01:05:27 (3077): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.001405 main Log opened 2019-09-25T00:05:25.684536000Z 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.002830 main OS Product: Linux 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.003013 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.003180 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.003242 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.003243 main Process ID: 2904 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.003244 main Package type: LINUX_64BITS_GENERIC 2019-09-25 01:05:27 (3077): Guest Log: 00:00:00.005780 main 5.2.6 r120293 started. Verbose level = 0 2019-09-25 01:07:13 (3077): Guest Log: [INFO] Mounting the shared directory 2019-09-25 01:07:13 (3077): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-25 01:07:13 (3077): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-25 01:07:14 (3077): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-25 01:07:14 (3077): Guest Log: [DEBUG] 0 2019-09-25 01:07:14 (3077): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-25 01:07:15 (3077): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-25 01:07:15 (3077): Guest Log: [DEBUG] 0 2019-09-25 01:07:15 (3077): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-25 01:07:35 (3077): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-25 01:07:35 (3077): Guest Log: [DEBUG] 0 2019-09-25 01:07:36 (3077): Guest Log: [DEBUG] Detected local proxy http://192.168.100.137:3128 in init_data.xml 2019-09-25 01:07:36 (3077): Guest Log: [DEBUG] Testing connection to 192.168.100.137 on port 3128 2019-09-25 01:07:36 (3077): Guest Log: [DEBUG] Connection to 192.168.100.137 3128 port [tcp/squid] succeeded! 2019-09-25 01:07:36 (3077): Guest Log: [DEBUG] 0 2019-09-25 01:09:10 (3077): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-25 01:09:29 (3077): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-25 01:09:36 (3077): 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 2019-09-25 01:09:36 (3077): Guest Log: 2.4.4.0 3627 2 27840 10321 3 1 2491562 10240000 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.168.100.137:3128 1 2019-09-25 01:09:39 (3077): Guest Log: [INFO] Reading volunteer information 2019-09-25 01:09:40 (3077): Guest Log: [INFO] Volunteer: m (178) 2019-09-25 01:09:40 (3077): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-25 01:09:41 (3077): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-25 01:09:42 (3077): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-25 01:09:44 (3077): Guest Log: [INFO] Running the fast benchmark. 2019-09-25 01:10:40 (3077): Guest Log: [INFO] Machine performance 9.13 HEPSPEC06 2019-09-25 01:10:40 (3077): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-25 01:10:48 (3077): Guest Log: [DEBUG] HTCondor ping 2019-09-25 01:10:50 (3077): Guest Log: [DEBUG] 0 2019-09-25 02:44:02 (3077): Status Report: Job Duration: '64800.000000' 2019-09-25 02:44:02 (3077): Status Report: Elapsed Time: '62867.674631' 2019-09-25 02:44:02 (3077): Status Report: CPU Time: '55623.780000' 2019-09-25 03:16:06 (3077): Powering off VM. 2019-09-25 03:16:07 (3077): Successfully stopped VM. 2019-09-25 03:16:07 (3077): Deregistering VM. (boinc_933354f9513bb39b, slot#0) 2019-09-25 03:16:07 (3077): Removing network bandwidth throttle group from VM. 2019-09-25 03:16:07 (3077): Removing storage controller(s) from VM. 2019-09-25 03:16:08 (3077): Removing VM from VirtualBox. 2019-09-25 03:16:08 (3077): Removing virtual disk drive from VirtualBox. 03:16:13 (3077): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN