Name | CMS_1135195_1568906504.275420_0 |
Workunit | 1939852 |
Created | 19 Sep 2019, 15:21:49 UTC |
Sent | 20 Sep 2019, 16:50:46 UTC |
Report deadline | 27 Sep 2019, 16:50:46 UTC |
Received | 22 Sep 2019, 7:20:41 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 3943 |
Run time | 17 hours 54 min 4 sec |
CPU time | 16 hours 30 min 4 sec |
Validate state | Valid |
Credit | 2,294.41 |
Device peak FLOPS | 4.50 GFLOPS |
Application version | CMS Simulation v49.00 (vbox64_mt_mcore_cms) x86_64-pc-linux-gnu |
Peak working set size | 1.96 GB |
Peak swap size | 3.93 GB |
Peak disk usage | 4.01 GB |
<core_client_version>7.6.31</core_client_version> <![CDATA[ <stderr_txt> 2019-09-20 20:29:10 (31948): vboxwrapper (7.7.26196): starting 2019-09-20 20:29:10 (31948): Feature: Checkpoint interval offset (572 seconds) 2019-09-20 20:29:10 (31948): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-20 20:29:10 (31948): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-20 20:29:10 (31948): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-20 20:29:10 (31948): Successfully copied 'init_data.xml' to the shared directory. 2019-09-20 20:29:10 (31948): Create VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-20 20:29:10 (31948): Setting Memory Size for VM. (1896MB) 2019-09-20 20:29:10 (31948): Setting CPU Count for VM. (1) 2019-09-20 20:29:10 (31948): Setting Chipset Options for VM. 2019-09-20 20:29:10 (31948): Setting Boot Options for VM. 2019-09-20 20:29:10 (31948): Setting Network Configuration for NAT. 2019-09-20 20:29:10 (31948): Enabling VM Network Access. 2019-09-20 20:29:10 (31948): Disabling USB Support for VM. 2019-09-20 20:29:10 (31948): Disabling COM Port Support for VM. 2019-09-20 20:29:10 (31948): Disabling LPT Port Support for VM. 2019-09-20 20:29:10 (31948): Disabling Audio Support for VM. 2019-09-20 20:29:11 (31948): Disabling Clipboard Support for VM. 2019-09-20 20:29:11 (31948): Disabling Drag and Drop Support for VM. 2019-09-20 20:29:11 (31948): Adding storage controller(s) to VM. 2019-09-20 20:29:11 (31948): Adding virtual disk drive to VM. (vm_image.vdi) 2019-09-20 20:29:11 (31948): Adding VirtualBox Guest Additions to VM. 2019-09-20 20:29:11 (31948): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-09-20 20:29:11 (31948): forwarding host port 52485 to guest port 80 2019-09-20 20:29:11 (31948): Enabling remote desktop for VM. 2019-09-20 20:29:11 (31948): Required extension pack not installed, remote desktop not enabled. 2019-09-20 20:29:11 (31948): Enabling shared directory for VM. 2019-09-20 20:29:11 (31948): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-20 20:29:12 (31948): Successfully started VM. (PID = '32418') 2019-09-20 20:29:12 (31948): Reporting VM Process ID to BOINC. 2019-09-20 20:29:12 (31948): Guest Log: BIOS: VirtualBox 6.0.12 2019-09-20 20:29:12 (31948): Guest Log: CPUID EDX: 0x178bfbff 2019-09-20 20:29:12 (31948): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-20 20:29:12 (31948): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-20 20:29:12 (31948): Detected: Web Application Enabled (http://localhost:52485) 2019-09-20 20:29:13 (31948): Preference change detected 2019-09-20 20:29:13 (31948): Setting CPU throttle for VM. (100%) 2019-09-20 20:29:13 (31948): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-20 20:29:14 (31948): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-20 20:29:14 (31948): Guest Log: BIOS: Booting from Hard Disk... 2019-09-20 20:29:18 (31948): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-20 20:29:18 (31948): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-20 20:29:33 (31948): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-20 20:29:33 (31948): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-20 20:30:01 (31948): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.000180 main Log opened 2019-09-20T18:30:01.140564000Z 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.000508 main OS Product: Linux 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.000540 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.000563 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.000583 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.000584 main Process ID: 2952 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.000585 main Package type: LINUX_64BITS_GENERIC 2019-09-20 20:30:01 (31948): Guest Log: 00:00:00.002737 main 5.2.6 r120293 started. Verbose level = 0 2019-09-20 20:30:16 (31948): Guest Log: [INFO] Mounting the shared directory 2019-09-20 20:30:17 (31948): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-20 20:30:17 (31948): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] 0 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] 0 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-20 20:30:19 (31948): Guest Log: [DEBUG] 0 2019-09-20 20:31:23 (31948): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-20 20:31:23 (31948): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-20 20:31:24 (31948): 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-20 20:31:24 (31948): Guest Log: 2.4.4.0 3691 1 25832 10287 3 1 1454385 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-20 20:31:31 (31948): Guest Log: [INFO] Reading volunteer information 2019-09-20 20:31:31 (31948): Guest Log: [INFO] Volunteer: Rantanplan (569) 2019-09-20 20:31:31 (31948): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-20 20:31:31 (31948): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-20 20:31:34 (31948): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-20 20:31:34 (31948): Guest Log: [INFO] Running the fast benchmark. 2019-09-20 20:32:14 (31948): Guest Log: [INFO] Machine performance 12.50 HEPSPEC06 2019-09-20 20:32:14 (31948): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-20 20:32:15 (31948): Guest Log: [DEBUG] HTCondor ping 2019-09-20 20:32:16 (31948): Guest Log: [DEBUG] 0 2019-09-20 21:37:20 (31948): Stopping VM. 2019-09-20 21:37:35 (31948): Successfully stopped VM. 2019-09-20 23:56:34 (30192): vboxwrapper (7.7.26196): starting 2019-09-20 23:56:34 (30192): Feature: Checkpoint interval offset (554 seconds) 2019-09-20 23:56:34 (30192): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-20 23:56:34 (30192): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-20 23:56:34 (30192): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-20 23:56:35 (30192): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-20 23:57:04 (30192): Successfully started VM. (PID = '30284') 2019-09-20 23:57:04 (30192): Reporting VM Process ID to BOINC. 2019-09-20 23:57:04 (30192): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-20 23:57:04 (30192): Detected: Web Application Enabled (http://localhost:52485) 2019-09-20 23:57:04 (30192): Preference change detected 2019-09-20 23:57:04 (30192): Setting CPU throttle for VM. (100%) 2019-09-20 23:57:04 (30192): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-20 23:57:05 (30192): Guest Log: 01:07:21.264112 timesync vgsvcTimeSyncWorker: Radical host time change: 8 392 590 000 000ns (HostNow=1 569 016 625 115 000 000 ns HostLast=1 569 008 232 525 000 000 ns) 2019-09-20 23:57:15 (30192): Guest Log: 01:07:31.268275 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 392 580 683 000ns (GuestNow=1 569 016 635 119 223 000 ns GuestLast=1 569 008 242 538 540 000 ns fSetTimeLastLoop=true ) 2019-09-21 00:28:31 (30192): Status Report: Job Duration: '64800.000000' 2019-09-21 00:28:31 (30192): Status Report: Elapsed Time: '6001.052839' 2019-09-21 00:28:31 (30192): Status Report: CPU Time: '4471.620000' 2019-09-21 00:53:26 (30192): Stopping VM. 2019-09-21 00:53:34 (30192): Successfully stopped VM. 2019-09-21 02:32:23 (18381): vboxwrapper (7.7.26196): starting 2019-09-21 02:32:23 (18381): Feature: Checkpoint interval offset (222 seconds) 2019-09-21 02:32:23 (18381): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-21 02:32:23 (18381): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-21 02:32:23 (18381): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-21 02:32:23 (18381): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-21 02:32:30 (18381): Successfully started VM. (PID = '18488') 2019-09-21 02:32:30 (18381): Reporting VM Process ID to BOINC. 2019-09-21 02:32:32 (18381): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-21 02:32:32 (18381): Detected: Web Application Enabled (http://localhost:52485) 2019-09-21 02:32:33 (18381): Status Report: Job Duration: '64800.000000' 2019-09-21 02:32:33 (18381): Status Report: Elapsed Time: '7497.263026' 2019-09-21 02:32:33 (18381): Status Report: CPU Time: '5883.680000' 2019-09-21 02:32:33 (18381): Preference change detected 2019-09-21 02:32:33 (18381): Setting CPU throttle for VM. (100%) 2019-09-21 02:32:33 (18381): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-21 02:32:38 (18381): Guest Log: 02:03:51.910401 timesync vgsvcTimeSyncWorker: Radical host time change: 5 952 188 000 000ns (HostNow=1 569 025 957 930 000 000 ns HostLast=1 569 020 005 742 000 000 ns) 2019-09-21 02:32:48 (18381): Guest Log: 02:04:01.913053 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 952 201 632 000ns (GuestNow=1 569 025 967 947 814 000 ns GuestLast=1 569 020 015 746 182 000 ns fSetTimeLastLoop=true ) 2019-09-21 04:12:08 (18381): Status Report: Job Duration: '64800.000000' 2019-09-21 04:12:08 (18381): Status Report: Elapsed Time: '13498.298239' 2019-09-21 04:12:08 (18381): Status Report: CPU Time: '11459.460000' 2019-09-21 09:27:11 (4416): vboxwrapper (7.7.26196): starting 2019-09-21 09:27:11 (4416): Feature: Checkpoint interval offset (27 seconds) 2019-09-21 09:27:11 (4416): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-21 09:27:11 (4416): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-21 09:27:11 (4416): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-21 09:27:11 (4416): Guest Log: 02:03:51.910401 timesync vgsvcTimeSyncWorker: Radical host time change: 5 952 188 000 000ns (HostNow=1 569 025 957 930 000 000 ns HostLast=1 569 020 005 742 000 000 ns) 2019-09-21 09:27:11 (4416): Guest Log: 02:04:01.913053 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 952 201 632 000ns (GuestNow=1 569 025 967 947 814 000 ns GuestLast=1 569 020 015 746 182 000 ns fSetTimeLastLoop=true ) 2019-09-21 09:27:11 (4416): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-21 09:27:13 (4416): Successfully started VM. (PID = '4524') 2019-09-21 09:27:13 (4416): Reporting VM Process ID to BOINC. 2019-09-21 09:27:13 (4416): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-21 09:27:13 (4416): Detected: Web Application Enabled (http://localhost:52485) 2019-09-21 09:27:13 (4416): Status Report: Job Duration: '64800.000000' 2019-09-21 09:27:13 (4416): Status Report: Elapsed Time: '16043.224013' 2019-09-21 09:27:13 (4416): Status Report: CPU Time: '13961.750000' 2019-09-21 09:27:13 (4416): Preference change detected 2019-09-21 09:27:13 (4416): Setting CPU throttle for VM. (100%) 2019-09-21 09:27:13 (4416): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-21 09:27:58 (4416): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.000164 main Log opened 2019-09-21T07:27:57.127529000Z 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.000458 main OS Product: Linux 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.000490 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.000513 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.000534 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.000535 main Process ID: 2909 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.000535 main Package type: LINUX_64BITS_GENERIC 2019-09-21 09:27:58 (4416): Guest Log: 00:00:00.001629 main 5.2.6 r120293 started. Verbose level = 0 2019-09-21 09:28:13 (4416): Guest Log: [INFO] Mounting the shared directory 2019-09-21 09:28:13 (4416): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-21 09:28:13 (4416): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] 0 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] 0 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-21 09:28:15 (4416): Guest Log: [DEBUG] 0 2019-09-21 09:29:17 (4416): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-21 09:29:18 (4416): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-21 09:29:19 (4416): 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-21 09:29:19 (4416): Guest Log: 2.4.4.0 3629 1 25356 10293 3 1 2543807 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-21 09:29:20 (4416): Guest Log: [INFO] Reading volunteer information 2019-09-21 09:29:20 (4416): Guest Log: [INFO] Volunteer: Rantanplan (569) 2019-09-21 09:29:20 (4416): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-21 09:29:20 (4416): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-21 09:29:21 (4416): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-21 09:29:23 (4416): Guest Log: [INFO] Running the fast benchmark. 2019-09-21 09:30:04 (4416): Guest Log: [INFO] Machine performance 12.28 HEPSPEC06 2019-09-21 09:30:04 (4416): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-21 09:30:05 (4416): Guest Log: [DEBUG] HTCondor ping 2019-09-21 09:30:06 (4416): Guest Log: [DEBUG] 0 2019-09-21 11:06:43 (4416): Status Report: Job Duration: '64800.000000' 2019-09-21 11:06:43 (4416): Status Report: Elapsed Time: '22043.935278' 2019-09-21 11:06:43 (4416): Status Report: CPU Time: '19556.800000' 2019-09-21 12:46:13 (4416): Status Report: Job Duration: '64800.000000' 2019-09-21 12:46:13 (4416): Status Report: Elapsed Time: '28044.660829' 2019-09-21 12:46:13 (4416): Status Report: CPU Time: '25092.530000' 2019-09-21 14:25:44 (4416): Status Report: Job Duration: '64800.000000' 2019-09-21 14:25:44 (4416): Status Report: Elapsed Time: '34045.128900' 2019-09-21 14:25:44 (4416): Status Report: CPU Time: '30805.550000' 2019-09-21 16:05:16 (4416): Status Report: Job Duration: '64800.000000' 2019-09-21 16:05:16 (4416): Status Report: Elapsed Time: '40045.161253' 2019-09-21 16:05:16 (4416): Status Report: CPU Time: '36402.100000' 2019-09-21 18:32:20 (1410): vboxwrapper (7.7.26196): starting 2019-09-21 18:32:21 (1410): Feature: Checkpoint interval offset (0 seconds) 2019-09-21 18:32:21 (1410): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-21 18:32:21 (1410): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-21 18:32:21 (1410): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-21 18:32:21 (1410): Guest Log: BIOS: VirtualBox 6.0.12 2019-09-21 18:32:21 (1410): Guest Log: CPUID EDX: 0x178bfbff 2019-09-21 18:32:21 (1410): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-21 18:32:21 (1410): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-21 18:32:21 (1410): Guest Log: BIOS: Booting from Hard Disk... 2019-09-21 18:32:21 (1410): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-21 18:32:21 (1410): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-21 18:32:21 (1410): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-21 18:32:21 (1410): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-21 18:32:21 (1410): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.000164 main Log opened 2019-09-21T07:27:57.127529000Z 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.000458 main OS Product: Linux 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.000490 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.000513 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.000534 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.000535 main Process ID: 2909 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.000535 main Package type: LINUX_64BITS_GENERIC 2019-09-21 18:32:21 (1410): Guest Log: 00:00:00.001629 main 5.2.6 r120293 started. Verbose level = 0 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Mounting the shared directory 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] 0 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] 0 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] 0 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-21 18:32:21 (1410): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-21 18:32:21 (1410): 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-21 18:32:21 (1410): Guest Log: 2.4.4.0 3629 1 25356 10293 3 1 2543807 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Reading volunteer information 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Volunteer: Rantanplan (569) 2019-09-21 18:32:21 (1410): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Running the fast benchmark. 2019-09-21 18:32:21 (1410): Guest Log: [INFO] Machine performance 12.28 HEPSPEC06 2019-09-21 18:32:21 (1410): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] HTCondor ping 2019-09-21 18:32:21 (1410): Guest Log: [DEBUG] 0 2019-09-21 18:32:21 (1410): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-21 18:32:22 (1410): Successfully started VM. (PID = '1632') 2019-09-21 18:32:22 (1410): Reporting VM Process ID to BOINC. 2019-09-21 18:32:24 (1410): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-21 18:32:24 (1410): Detected: Web Application Enabled (http://localhost:52485) 2019-09-21 18:32:24 (1410): Status Report: Job Duration: '64800.000000' 2019-09-21 18:32:24 (1410): Status Report: Elapsed Time: '40495.449778' 2019-09-21 18:32:24 (1410): Status Report: CPU Time: '36846.980000' 2019-09-21 18:32:24 (1410): Preference change detected 2019-09-21 18:32:24 (1410): Setting CPU throttle for VM. (100%) 2019-09-21 18:32:25 (1410): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-21 17:28:34 (1418): vboxwrapper (7.7.26196): starting 2019-09-21 17:28:35 (1418): Feature: Checkpoint interval offset (322 seconds) 2019-09-21 17:28:35 (1418): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-21 17:28:35 (1418): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-21 17:28:35 (1418): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-21 17:28:35 (1418): Guest Log: BIOS: VirtualBox 6.0.12 2019-09-21 17:28:35 (1418): Guest Log: CPUID EDX: 0x178bfbff 2019-09-21 17:28:35 (1418): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-21 17:28:35 (1418): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-21 17:28:35 (1418): Guest Log: BIOS: Booting from Hard Disk... 2019-09-21 17:28:35 (1418): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-21 17:28:35 (1418): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-21 17:28:35 (1418): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-21 17:28:35 (1418): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-21 17:28:35 (1418): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.000162 main Log opened 2019-09-21T14:33:05.031688000Z 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.000319 main OS Product: Linux 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.000349 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.000371 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.000392 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.000392 main Process ID: 2908 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.000393 main Package type: LINUX_64BITS_GENERIC 2019-09-21 17:28:35 (1418): Guest Log: 00:00:00.006576 main 5.2.6 r120293 started. Verbose level = 0 2019-09-21 17:28:35 (1418): Guest Log: 00:00:10.028569 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 210 498 185 000ns (GuestNow=1 569 083 595 557 621 000 ns GuestLast=1 569 076 385 059 436 000 ns fSetTimeLastLoop=true ) 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Mounting the shared directory 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] 0 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] 0 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] 0 2019-09-21 17:28:35 (1418): Guest Log: 00:00:20.028853 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 190 110 806 000ns (GuestNow=1 569 076 405 446 815 000 ns GuestLast=1 569 083 595 557 621 000 ns fSetTimeLastLoop=false) 2019-09-21 17:28:35 (1418): Guest Log: 00:00:30.029363 timesync vgsvcTimeSyncWorker: Radical host time change: -7 190 110 000 000ns (HostNow=1 569 076 415 450 000 000 ns HostLast=1 569 083 605 560 000 000 ns) 2019-09-21 17:28:35 (1418): Guest Log: 00:00:30.029529 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 210 113 694 000ns (GuestNow=1 569 083 615 560 509 000 ns GuestLast=1 569 076 405 446 815 000 ns fSetTimeLastLoop=true ) 2019-09-21 17:28:35 (1418): Guest Log: 00:00:40.029789 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 190 110 076 000ns (GuestNow=1 569 076 425 450 433 000 ns GuestLast=1 569 083 615 560 509 000 ns fSetTimeLastLoop=true ) 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-21 17:28:35 (1418): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-21 17:28:35 (1418): 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-21 17:28:35 (1418): Guest Log: 2.4.4.0 3627 1 25776 10295 3 1 2588386 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Reading volunteer information 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Volunteer: Rantanplan (569) 2019-09-21 17:28:35 (1418): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Running the fast benchmark. 2019-09-21 17:28:35 (1418): Guest Log: [INFO] Machine performance 12.50 HEPSPEC06 2019-09-21 17:28:35 (1418): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] HTCondor ping 2019-09-21 17:28:35 (1418): Guest Log: [DEBUG] 0 2019-09-21 17:28:35 (1418): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-21 17:28:36 (1418): Successfully started VM. (PID = '1573') 2019-09-21 17:28:36 (1418): Reporting VM Process ID to BOINC. 2019-09-21 17:28:37 (1418): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-21 17:28:37 (1418): Detected: Web Application Enabled (http://localhost:52485) 2019-09-21 17:28:37 (1418): Status Report: Job Duration: '64800.000000' 2019-09-21 17:28:37 (1418): Status Report: Elapsed Time: '40532.482935' 2019-09-21 17:28:37 (1418): Status Report: CPU Time: '36857.380000' 2019-09-21 17:28:37 (1418): Preference change detected 2019-09-21 17:28:37 (1418): Setting CPU throttle for VM. (100%) 2019-09-21 17:28:37 (1418): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-21 18:44:43 (1385): vboxwrapper (7.7.26196): starting 2019-09-21 18:44:43 (1385): Feature: Checkpoint interval offset (214 seconds) 2019-09-21 18:44:43 (1385): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-21 18:44:44 (1385): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-21 18:44:44 (1385): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-21 18:44:44 (1385): Guest Log: BIOS: VirtualBox 6.0.12 2019-09-21 18:44:44 (1385): Guest Log: CPUID EDX: 0x178bfbff 2019-09-21 18:44:44 (1385): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-21 18:44:44 (1385): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-21 18:44:44 (1385): Guest Log: BIOS: Booting from Hard Disk... 2019-09-21 18:44:44 (1385): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-21 18:44:44 (1385): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-21 18:44:44 (1385): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-21 18:44:44 (1385): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-21 18:44:44 (1385): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.000174 main Log opened 2019-09-21T15:29:19.117335000Z 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.000359 main OS Product: Linux 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.000393 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.000415 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.000436 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.000437 main Process ID: 2906 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.000437 main Package type: LINUX_64BITS_GENERIC 2019-09-21 18:44:44 (1385): Guest Log: 00:00:00.001613 main 5.2.6 r120293 started. Verbose level = 0 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Mounting the shared directory 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] 0 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] 0 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] 0 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-21 18:44:44 (1385): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-21 18:44:44 (1385): 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-21 18:44:44 (1385): Guest Log: 2.4.4.0 3624 1 25780 10295 3 1 2592939 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Reading volunteer information 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Volunteer: Rantanplan (569) 2019-09-21 18:44:44 (1385): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Running the fast benchmark. 2019-09-21 18:44:44 (1385): Guest Log: [INFO] Machine performance 12.62 HEPSPEC06 2019-09-21 18:44:44 (1385): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] HTCondor ping 2019-09-21 18:44:44 (1385): Guest Log: [DEBUG] 0 2019-09-21 18:44:44 (1385): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-21 18:44:45 (1385): Successfully started VM. (PID = '1685') 2019-09-21 18:44:45 (1385): Reporting VM Process ID to BOINC. 2019-09-21 18:44:47 (1385): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-21 18:44:47 (1385): Detected: Web Application Enabled (http://localhost:52485) 2019-09-21 18:44:47 (1385): Status Report: Job Duration: '64800.000000' 2019-09-21 18:44:47 (1385): Status Report: Elapsed Time: '40897.477362' 2019-09-21 18:44:47 (1385): Status Report: CPU Time: '37058.990000' 2019-09-21 18:44:47 (1385): Preference change detected 2019-09-21 18:44:47 (1385): Setting CPU throttle for VM. (100%) 2019-09-21 18:44:48 (1385): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-21 18:47:33 (1385): Guest Log: [DEBUG] 0 2019-09-22 03:24:25 (31242): vboxwrapper (7.7.26196): starting 2019-09-22 03:24:25 (31242): Feature: Checkpoint interval offset (522 seconds) 2019-09-22 03:24:25 (31242): Detected: VirtualBox VboxManage Interface (Version: 6.0.12) 2019-09-22 03:24:25 (31242): Detected: Minimum checkpoint interval (600.000000 seconds) 2019-09-22 03:24:25 (31242): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-09-22 03:24:25 (31242): Guest Log: BIOS: VirtualBox 6.0.12 2019-09-22 03:24:25 (31242): Guest Log: CPUID EDX: 0x178bfbff 2019-09-22 03:24:25 (31242): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-09-22 03:24:25 (31242): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-09-22 03:24:25 (31242): Guest Log: BIOS: Booting from Hard Disk... 2019-09-22 03:24:25 (31242): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-09-22 03:24:25 (31242): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-09-22 03:24:25 (31242): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-09-22 03:24:25 (31242): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-09-22 03:24:25 (31242): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.000170 main Log opened 2019-09-21T16:45:26.238251000Z 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.000322 main OS Product: Linux 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.000355 main OS Release: 4.14.44-11.cernvm.x86_64 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.000393 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.000414 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.000415 main Process ID: 2910 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.000415 main Package type: LINUX_64BITS_GENERIC 2019-09-22 03:24:25 (31242): Guest Log: 00:00:00.001848 main 5.2.6 r120293 started. Verbose level = 0 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Mounting the shared directory 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] 0 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] 0 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] 0 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] Probing CVMFS ... 2019-09-22 03:24:25 (31242): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-09-22 03:24:25 (31242): 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:24:25 (31242): Guest Log: 2.4.4.0 3628 1 25984 10295 3 1 2596060 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Reading volunteer information 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Volunteer: Rantanplan (569) 2019-09-22 03:24:25 (31242): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Running the fast benchmark. 2019-09-22 03:24:25 (31242): Guest Log: [INFO] Machine performance 12.54 HEPSPEC06 2019-09-22 03:24:25 (31242): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] HTCondor ping 2019-09-22 03:24:25 (31242): Guest Log: [DEBUG] 0 2019-09-22 03:24:25 (31242): Starting VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-22 03:24:27 (31242): Successfully started VM. (PID = '31349') 2019-09-22 03:24:27 (31242): Reporting VM Process ID to BOINC. 2019-09-22 03:24:27 (31242): VM state change detected. (old = 'poweroff', new = 'running') 2019-09-22 03:24:27 (31242): Detected: Web Application Enabled (http://localhost:52485) 2019-09-22 03:24:27 (31242): Status Report: Job Duration: '64800.000000' 2019-09-22 03:24:27 (31242): Status Report: Elapsed Time: '43323.037894' 2019-09-22 03:24:27 (31242): Status Report: CPU Time: '39256.600000' 2019-09-22 03:24:27 (31242): Preference change detected 2019-09-22 03:24:27 (31242): Setting CPU throttle for VM. (100%) 2019-09-22 03:24:27 (31242): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 40 seconds) or (Vbox_job.xml: 600 seconds)) 2019-09-22 03:27:21 (31242): Guest Log: [INFO] Machine performance 12.48 HEPSPEC06 2019-09-22 03:27:21 (31242): Guest Log: [INFO] CMS application starting. Check log files. 2019-09-22 03:27:22 (31242): Guest Log: [DEBUG] HTCondor ping 2019-09-22 03:27:23 (31242): Guest Log: [DEBUG] 0 2019-09-22 05:03:55 (31242): Status Report: Job Duration: '64800.000000' 2019-09-22 05:03:55 (31242): Status Report: Elapsed Time: '49323.069399' 2019-09-22 05:03:55 (31242): Status Report: CPU Time: '44826.380000' 2019-09-22 06:43:23 (31242): Status Report: Job Duration: '64800.000000' 2019-09-22 06:43:23 (31242): Status Report: Elapsed Time: '55323.983541' 2019-09-22 06:43:23 (31242): Status Report: CPU Time: '50412.600000' 2019-09-22 08:22:52 (31242): Status Report: Job Duration: '64800.000000' 2019-09-22 08:22:52 (31242): Status Report: Elapsed Time: '61324.213891' 2019-09-22 08:22:52 (31242): Status Report: CPU Time: '56151.310000' 2019-09-22 09:20:31 (31242): Powering off VM. 2019-09-22 09:20:31 (31242): Successfully stopped VM. 2019-09-22 09:20:31 (31242): Deregistering VM. (boinc_7526ffa2905de1ab, slot#5) 2019-09-22 09:20:31 (31242): Removing network bandwidth throttle group from VM. 2019-09-22 09:20:31 (31242): Removing storage controller(s) from VM. 2019-09-22 09:20:31 (31242): Removing VM from VirtualBox. 2019-09-22 09:20:31 (31242): Removing virtual disk drive from VirtualBox. 09:20:36 (31242): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN