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

Stderr output

<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