Name CMS_2999821_1627326906.674638_0
Workunit 2111138
Created 26 Jul 2021, 19:15:08 UTC
Sent 27 Jul 2021, 8:22:37 UTC
Report deadline 3 Aug 2021, 8:22:37 UTC
Received 28 Jul 2021, 13:31:29 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4357
Run time 12 hours 17 min 48 sec
CPU time 11 hours 39 min 28 sec
Validate state Valid
Credit 444.73
Device peak FLOPS 3.04 GFLOPS
Application version CMS Simulation v60.50 (vbox64_mt_mcore_cms)
x86_64-pc-linux-gnu
Peak working set size 333.91 MB
Peak swap size 4.14 GB
Peak disk usage 4.71 GB

Stderr output

<core_client_version>7.9.3</core_client_version>
<![CDATA[
<stderr_txt>
2021-07-27 04:22:56 (30051): vboxwrapper (7.7.26196): starting
2021-07-27 04:22:56 (30051): Feature: Checkpoint interval offset (312 seconds)
2021-07-27 04:22:56 (30051): Detected: VirtualBox VboxManage Interface (Version: 5.2.42)
2021-07-27 04:22:56 (30051): Detected: Minimum checkpoint interval (600.000000 seconds)
2021-07-27 04:22:56 (30051): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-07-27 04:22:56 (30051): Successfully copied 'init_data.xml' to the shared directory.
2021-07-27 04:23:00 (30051): Create VM. (boinc_9868584a3dc40155, slot#41)
2021-07-27 04:23:00 (30051): Setting Memory Size for VM. (1896MB)
2021-07-27 04:23:00 (30051): Setting CPU Count for VM. (1)
2021-07-27 04:23:01 (30051): Setting Chipset Options for VM.
2021-07-27 04:23:01 (30051): Setting Boot Options for VM.
2021-07-27 04:23:01 (30051): Setting Network Configuration for NAT.
2021-07-27 04:23:01 (30051): Enabling VM Network Access.
2021-07-27 04:23:01 (30051): Disabling USB Support for VM.
2021-07-27 04:23:01 (30051): Disabling COM Port Support for VM.
2021-07-27 04:23:01 (30051): Disabling LPT Port Support for VM.
2021-07-27 04:23:01 (30051): Disabling Audio Support for VM.
2021-07-27 04:23:01 (30051): Disabling Clipboard Support for VM.
2021-07-27 04:23:02 (30051): Disabling Drag and Drop Support for VM.
2021-07-27 04:23:02 (30051): Adding storage controller(s) to VM.
2021-07-27 04:23:02 (30051): Adding virtual disk drive to VM. (vm_image.vdi)
2021-07-27 04:23:02 (30051): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-07-27 04:23:02 (30051): forwarding host port 41451 to guest port 80
2021-07-27 04:23:02 (30051): Enabling remote desktop for VM.
2021-07-27 04:23:02 (30051): Enabling shared directory for VM.
2021-07-27 04:23:02 (30051): Starting VM. (boinc_9868584a3dc40155, slot#41)
2021-07-27 04:23:04 (30051): Successfully started VM. (PID = '30555')
2021-07-27 04:23:04 (30051): Reporting VM Process ID to BOINC.
2021-07-27 04:23:04 (30051): Guest Log: BIOS: VirtualBox 5.2.41
2021-07-27 04:23:04 (30051): Guest Log: CPUID EDX: 0x078bfbff
2021-07-27 04:23:04 (30051): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2021-07-27 04:23:04 (30051): VM state change detected. (old = 'poweroff', new = 'running')
2021-07-27 04:23:04 (30051): Detected: Web Application Enabled (http://localhost:41451)
2021-07-27 04:23:04 (30051): Detected: Remote Desktop Enabled (localhost:52411)
2021-07-27 04:23:04 (30051): Preference change detected
2021-07-27 04:23:04 (30051): Setting CPU throttle for VM. (100%)
2021-07-27 04:23:04 (30051): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2021-07-27 04:23:06 (30051): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2021-07-27 04:23:06 (30051): Guest Log: BIOS: Booting from Hard Disk...
2021-07-27 04:23:08 (30051): Guest Log: BIOS: KBD: unsupported int 16h function 03
2021-07-27 04:23:08 (30051): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2021-07-27 04:24:06 (30051): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2021-07-27 04:24:06 (30051): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2021-07-27 04:24:07 (30051): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.000241 main     Log opened 2021-07-27T08:24:07.762393000Z
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.000453 main     OS Product: Linux
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.000557 main     OS Release: 4.14.232-19.cernvm.x86_64
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.000622 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.000665 main     Executable: /usr/sbin/VBoxService
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.000667 main     Process ID: 2112
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.000668 main     Package type: LINUX_64BITS_GENERIC
2021-07-27 04:24:07 (30051): Guest Log: 00:00:00.014543 main     5.2.6 r120293 started. Verbose level = 0
2021-07-27 04:24:54 (30051): Guest Log: [INFO] Mounting the shared directory
2021-07-27 04:24:55 (30051): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2021-07-27 04:24:55 (30051): Guest Log: [INFO] Testing connection to cern.ch
2021-07-27 04:24:55 (30051): Guest Log: [INFO] Testing connection to VCCS
2021-07-27 04:24:55 (30051): Guest Log: [INFO] Testing connection to HTCondor
2021-07-27 04:25:10 (30051): Guest Log: [DEBUG] Status run 1 of up to 3: 1
2021-07-27 04:25:29 (30051): Guest Log: [DEBUG] Status run 2 of up to 3: 1
2021-07-27 04:25:35 (30051): Guest Log: [INFO] Testing connection to WMAgent
2021-07-27 04:25:50 (30051): Guest Log: [DEBUG] Status run 1 of up to 3: 1
2021-07-27 04:25:56 (30051): Guest Log: [INFO] Testing connection to Frontier
2021-07-27 04:26:26 (30051): Guest Log: [DEBUG] Status run 1 of up to 3: 1
2021-07-27 04:26:33 (30051): Guest Log: [INFO] Could not find a local HTTP proxy.
2021-07-27 04:26:33 (30051): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections.
2021-07-27 04:26:33 (30051): Guest Log: [INFO] This makes the application less efficient.
2021-07-27 04:26:33 (30051): Guest Log: [INFO] It also puts higher load on the project servers.
2021-07-27 04:26:33 (30051): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended.
2021-07-27 04:26:33 (30051): Guest Log: [INFO] Advice can be found in the project forum.
2021-07-27 04:26:33 (30051): Guest Log: [INFO] Reloading the CVMFS configuration (can take a while) ...
2021-07-27 04:26:41 (30051): Guest Log: [INFO] Probing CVMFS ...
2021-07-27 04:26:43 (30051): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK
2021-07-27 04:26:46 (30051): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2021-07-27 04:26:53 (30051): Guest Log: Probing /cvmfs/cms.cern.ch... OK
2021-07-27 04:27:01 (30051): Guest Log: Probing /cvmfs/cms-ib.cern.ch... OK
2021-07-27 04:27:11 (30051): Guest Log: Probing /cvmfs/oasis.opensciencegrid.org... OK
2021-07-27 04:27:17 (30051): Guest Log: Probing /cvmfs/singularity.opensciencegrid.org... OK
2021-07-27 04:27:17 (30051): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2021-07-27 04:27:17 (30051): Guest Log: 2.7.2.0 2828 2 28164 15817 3 1 2079956 10240000 2 65024 0 8 100 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2021-07-27 04:27:20 (30051): Guest Log: [INFO] Reading volunteer information
2021-07-27 04:27:21 (30051): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2021-07-27 04:27:22 (30051): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2021-07-27 04:27:23 (30051): Guest Log: [INFO] CMS application starting. Check log files.
2021-07-27 06:03:06 (30051): Status Report: Job Duration: '64800.000000'
2021-07-27 06:03:06 (30051): Status Report: Elapsed Time: '6002.849334'
2021-07-27 06:03:06 (30051): Status Report: CPU Time: '5658.380000'
2021-07-27 07:43:11 (30051): Status Report: Job Duration: '64800.000000'
2021-07-27 07:43:11 (30051): Status Report: Elapsed Time: '12008.658709'
2021-07-27 07:43:11 (30051): Status Report: CPU Time: '11665.340000'
2021-07-27 09:23:06 (30051): Status Report: Job Duration: '64800.000000'
2021-07-27 09:23:06 (30051): Status Report: Elapsed Time: '18010.292792'
2021-07-27 09:23:06 (30051): Status Report: CPU Time: '17716.650000'
2021-07-27 11:02:38 (30051): Status Report: Job Duration: '64800.000000'
2021-07-27 11:02:38 (30051): Status Report: Elapsed Time: '24016.665589'
2021-07-27 11:02:38 (30051): Status Report: CPU Time: '20926.450000'
2021-07-27 12:42:41 (30051): Status Report: Job Duration: '64800.000000'
2021-07-27 12:42:41 (30051): Status Report: Elapsed Time: '30022.216277'
2021-07-27 12:42:41 (30051): Status Report: CPU Time: '26994.090000'
2021-07-27 14:22:27 (30051): Status Report: Job Duration: '64800.000000'
2021-07-27 14:22:27 (30051): Status Report: Elapsed Time: '36022.269387'
2021-07-27 14:22:27 (30051): Status Report: CPU Time: '33033.150000'
2021-07-27 16:01:44 (30051): Status Report: Job Duration: '64800.000000'
2021-07-27 16:01:44 (30051): Status Report: Elapsed Time: '42022.395574'
2021-07-27 16:01:44 (30051): Status Report: CPU Time: '38559.320000'
2021-07-27 16:35:35 (30051): VM state change detected. (old = 'running', new = 'paused')
2021-07-28 09:26:09 (30051): VM state change detected. (old = 'paused', new = 'running')
2021-07-28 09:26:09 (30051): Guest Log: 12:11:29.129909 timesync vgsvcTimeSyncWorker: Radical host time change: 60 640 872 000 000ns (HostNow=1 627 478 767 705 000 000 ns HostLast=1 627 418 126 833 000 000 ns)
2021-07-28 09:26:24 (30051): Guest Log: 12:11:39.213151 timesync vgsvcTimeSyncWorker: Radical guest time change: 60 641 076 212 000ns (GuestNow=1 627 478 777 867 619 000 ns GuestLast=1 627 418 136 791 407 000 ns fSetTimeLastLoop=true )
2021-07-28 09:31:11 (30051): Guest Log: [INFO] glidein exited with return value 0.
2021-07-28 09:31:11 (30051): Guest Log: [INFO] Shutting Down.
2021-07-28 09:31:11 (30051): VM Completion File Detected.
2021-07-28 09:31:11 (30051): VM Completion Message: glidein exited with return value 0.
.
2021-07-28 09:31:11 (30051): Powering off VM.
2021-07-28 09:31:12 (30051): Successfully stopped VM.
2021-07-28 09:31:12 (30051): Deregistering VM. (boinc_9868584a3dc40155, slot#41)
2021-07-28 09:31:13 (30051): Removing network bandwidth throttle group from VM.
2021-07-28 09:31:14 (30051): Removing storage controller(s) from VM.
2021-07-28 09:31:15 (30051): Removing VM from VirtualBox.
2021-07-28 09:31:16 (30051): Removing virtual disk drive from VirtualBox.
09:31:22 (30051): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN