Name | 1JcNDmhvbw2n7Olcko1bjSoqABFKDmABFKDm7AsVDmNOGKDme6ceMn_0 |
Workunit | 2287422 |
Created | 15 Mar 2023, 8:44:59 UTC |
Sent | 15 Mar 2023, 12:24:40 UTC |
Report deadline | 22 Mar 2023, 12:24:40 UTC |
Received | 18 Mar 2023, 19:03:17 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 4802 |
Run time | 2 days 14 hours 50 min 56 sec |
CPU time | 3 days 1 hours 30 min 10 sec |
Validate state | Valid |
Credit | 2,311.56 |
Device peak FLOPS | 4.41 GFLOPS |
Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) windows_x86_64 |
Peak working set size | 81.38 MB |
Peak swap size | 83.75 MB |
Peak disk usage | 3.06 GB |
<core_client_version>7.20.2</core_client_version> <![CDATA[ <stderr_txt> 2023-03-15 08:13:18 (11596): Detected: vboxwrapper 26206 2023-03-15 08:13:18 (11596): Detected: BOINC client v7.20.2 2023-03-15 08:13:19 (11596): Detected: VirtualBox VboxManage Interface (Version: 6.1.34) 2023-03-15 08:13:19 (11596): Successfully copied 'init_data.xml' to the shared directory. 2023-03-15 08:13:20 (11596): Create VM. (boinc_c0e78b600160c23c, slot#12) 2023-03-15 08:13:20 (11596): Setting Memory Size for VM. (3900MB) 2023-03-15 08:13:20 (11596): Setting CPU Count for VM. (1) 2023-03-15 08:13:21 (11596): Setting Chipset Options for VM. 2023-03-15 08:13:21 (11596): Setting Graphics Controller Options for VM. 2023-03-15 08:13:21 (11596): Setting Boot Options for VM. 2023-03-15 08:13:22 (11596): Setting Network Configuration for NAT. 2023-03-15 08:13:22 (11596): Enabling VM Network Access. 2023-03-15 08:13:22 (11596): Disabling USB Support for VM. 2023-03-15 08:13:22 (11596): Disabling COM Port Support for VM. 2023-03-15 08:13:23 (11596): Disabling LPT Port Support for VM. 2023-03-15 08:13:23 (11596): Disabling Audio Support for VM. 2023-03-15 08:13:23 (11596): Disabling Clipboard Support for VM. 2023-03-15 08:13:23 (11596): Disabling Drag and Drop Support for VM. 2023-03-15 08:13:24 (11596): Adding storage controller(s) to VM. 2023-03-15 08:13:24 (11596): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi) 2023-03-15 08:13:25 (11596): Adding VirtualBox Guest Additions to VM. 2023-03-15 08:13:25 (11596): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2023-03-15 08:13:25 (11596): forwarding host port 62044 to guest port 80 2023-03-15 08:13:26 (11596): Enabling remote desktop for VM. 2023-03-15 08:13:26 (11596): Required extension pack not installed, remote desktop not enabled. 2023-03-15 08:13:26 (11596): Enabling shared directory for VM. 2023-03-15 08:13:27 (11596): Starting VM using VBoxManage interface. (boinc_c0e78b600160c23c, slot#12) 2023-03-15 08:13:38 (11596): Successfully started VM. (PID = '18596') 2023-03-15 08:13:38 (11596): Reporting VM Process ID to BOINC. 2023-03-15 08:13:38 (11596): Guest Log: BIOS: VirtualBox 6.1.34 2023-03-15 08:13:38 (11596): Guest Log: CPUID EDX: 0x178bfbff 2023-03-15 08:13:38 (11596): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-03-15 08:13:38 (11596): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-03-15 08:13:38 (11596): VM state change detected. (old = 'poweredoff', new = 'running') 2023-03-15 08:13:38 (11596): Detected: Web Application Enabled (http://localhost:62044) 2023-03-15 08:13:38 (11596): Preference change detected 2023-03-15 08:13:38 (11596): Setting CPU throttle for VM. (100%) 2023-03-15 08:13:38 (11596): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2023-03-15 08:13:40 (11596): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-03-15 08:13:40 (11596): Guest Log: BIOS: Booting from Hard Disk... 2023-03-15 08:13:43 (11596): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-03-15 08:13:43 (11596): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2023-03-15 08:13:43 (11596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2023-03-15 08:13:51 (11596): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-03-15 08:13:51 (11596): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-03-15 08:14:07 (11596): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.000234 main Log opened 2023-03-15T08:14:05.291789000Z 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.000445 main OS Product: Linux 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.000564 main OS Release: 3.10.0-957.27.2.el7.x86_64 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.000627 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.000683 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.000685 main Process ID: 1262 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.000686 main Package type: LINUX_64BITS_GENERIC 2023-03-15 08:14:07 (11596): Guest Log: 00:00:00.002993 main 5.2.32 r132073 started. Verbose level = 0 2023-03-15 08:14:07 (11596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2023-03-15 08:14:07 (11596): Guest Log: [INFO] Mounting shared directory 2023-03-15 08:14:07 (11596): Guest Log: [INFO] Checking for init_data.xml 2023-03-15 08:14:13 (11596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2023-03-15 08:14:13 (11596): Guest Log: [INFO] Detected branch: dev 2023-03-15 08:14:13 (11596): Guest Log: This is the dev version of the ATLAS job wrapper 2023-03-15 08:14:13 (11596): Guest Log: Copying input files 2023-03-15 08:14:17 (11596): Guest Log: 00:00:10.042613 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 611 680 740 000ns (GuestNow=1 678 889 657 014 394 000 ns GuestLast=1 678 868 045 333 654 000 ns fSetTimeLastLoop=true ) 2023-03-15 08:14:19 (11596): Guest Log: Copied input files into RunAtlas. 2023-03-15 08:14:19 (11596): Guest Log: This VM did not configure a local http proxy via BOINC. 2023-03-15 08:14:19 (11596): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2023-03-15 08:14:19 (11596): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2023-03-15 08:14:19 (11596): Guest Log: Further information can be found at the LHC@home message board. 2023-03-15 08:14:31 (11596): Guest Log: Running cvmfs_config stat atlas.cern.ch 2023-03-15 08:14:31 (11596): 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 2023-03-15 08:14:31 (11596): Guest Log: 2.6.3.0 1535 0 32108 116771 3 1 3116421 4096000 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2023-03-15 08:14:33 (11596): Guest Log: copied the webapp to /var/www 2023-03-15 08:14:33 (11596): Guest Log: core_number=1 2023-03-15 08:14:33 (11596): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2023-03-15 08:14:33 (11596): Guest Log: *** Starting ATLAS job. (PandaID=5753961892 taskID=32413688) *** 2023-03-15 09:53:52 (11596): Status Report: Elapsed Time: '6000.000000' 2023-03-15 09:53:52 (11596): Status Report: CPU Time: '5274.921875' 2023-03-15 11:34:05 (11596): Status Report: Elapsed Time: '12000.000000' 2023-03-15 11:34:05 (11596): Status Report: CPU Time: '11283.140625' 2023-03-15 13:14:18 (11596): Status Report: Elapsed Time: '18000.000000' 2023-03-15 13:14:18 (11596): Status Report: CPU Time: '17285.984375' 2023-03-15 14:28:21 (11596): Stopping VM. 2023-03-15 14:28:53 (11596): Successfully stopped VM. 2023-03-15 14:38:01 (17876): Detected: vboxwrapper 26206 2023-03-15 14:38:01 (17876): Detected: BOINC client v7.20.2 2023-03-15 14:38:02 (17876): Detected: VirtualBox VboxManage Interface (Version: 6.1.34) 2023-03-15 14:38:03 (17876): Guest Log: BIOS: VirtualBox 6.1.34 2023-03-15 14:38:03 (17876): Guest Log: CPUID EDX: 0x178bfbff 2023-03-15 14:38:03 (17876): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-03-15 14:38:03 (17876): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-03-15 14:38:03 (17876): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-03-15 14:38:03 (17876): Guest Log: BIOS: Booting from Hard Disk... 2023-03-15 14:38:03 (17876): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-03-15 14:38:03 (17876): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2023-03-15 14:38:03 (17876): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2023-03-15 14:38:03 (17876): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-03-15 14:38:03 (17876): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-03-15 14:38:03 (17876): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.000234 main Log opened 2023-03-15T08:14:05.291789000Z 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.000445 main OS Product: Linux 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.000564 main OS Release: 3.10.0-957.27.2.el7.x86_64 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.000627 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.000683 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.000685 main Process ID: 1262 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.000686 main Package type: LINUX_64BITS_GENERIC 2023-03-15 14:38:03 (17876): Guest Log: 00:00:00.002993 main 5.2.32 r132073 started. Verbose level = 0 2023-03-15 14:38:03 (17876): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2023-03-15 14:38:03 (17876): Guest Log: [INFO] Mounting shared directory 2023-03-15 14:38:03 (17876): Guest Log: [INFO] Checking for init_data.xml 2023-03-15 14:38:03 (17876): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2023-03-15 14:38:03 (17876): Guest Log: [INFO] Detected branch: dev 2023-03-15 14:38:03 (17876): Guest Log: This is the dev version of the ATLAS job wrapper 2023-03-15 14:38:03 (17876): Guest Log: Copying input files 2023-03-15 14:38:03 (17876): Guest Log: 00:00:10.042613 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 611 680 740 000ns (GuestNow=1 678 889 657 014 394 000 ns GuestLast=1 678 868 045 333 654 000 ns fSetTimeLastLoop=true ) 2023-03-15 14:38:03 (17876): Guest Log: Copied input files into RunAtlas. 2023-03-15 14:38:03 (17876): Guest Log: This VM did not configure a local http proxy via BOINC. 2023-03-15 14:38:03 (17876): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2023-03-15 14:38:03 (17876): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2023-03-15 14:38:03 (17876): Guest Log: Further information can be found at the LHC@home message board. 2023-03-15 14:38:03 (17876): Guest Log: Running cvmfs_config stat atlas.cern.ch 2023-03-15 14:38:03 (17876): 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 2023-03-15 14:38:03 (17876): Guest Log: 2.6.3.0 1535 0 32108 116771 3 1 3116421 4096000 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2023-03-15 14:38:03 (17876): Guest Log: copied the webapp to /var/www 2023-03-15 14:38:03 (17876): Guest Log: core_number=1 2023-03-15 14:38:03 (17876): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2023-03-15 14:38:03 (17876): Guest Log: *** Starting ATLAS job. (PandaID=5753961892 taskID=32413688) *** 2023-03-15 14:38:03 (17876): Starting VM using VBoxManage interface. (boinc_c0e78b600160c23c, slot#12) 2023-03-15 14:38:34 (17876): Successfully started VM. (PID = '500') 2023-03-15 14:38:34 (17876): Reporting VM Process ID to BOINC. 2023-03-15 14:38:34 (17876): VM state change detected. (old = 'poweredoff', new = 'running') 2023-03-15 14:38:34 (17876): Detected: Web Application Enabled (http://localhost:62044) 2023-03-15 14:38:34 (17876): Status Report: Elapsed Time: '22433.000000' 2023-03-15 14:38:34 (17876): Status Report: CPU Time: '21723.656250' 2023-03-15 14:38:34 (17876): Preference change detected 2023-03-15 14:38:34 (17876): Setting CPU throttle for VM. (100%) 2023-03-15 14:38:34 (17876): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2023-03-15 16:18:44 (17876): Status Report: Elapsed Time: '28433.000000' 2023-03-15 16:18:44 (17876): Status Report: CPU Time: '27758.812500' 2023-03-15 17:58:55 (17876): Status Report: Elapsed Time: '34433.000000' 2023-03-15 17:58:55 (17876): Status Report: CPU Time: '33760.125000' 2023-03-15 19:39:11 (17876): Status Report: Elapsed Time: '40433.000000' 2023-03-15 19:39:11 (17876): Status Report: CPU Time: '39768.656250' 2023-03-15 21:20:15 (17876): Status Report: Elapsed Time: '46433.616606' 2023-03-15 21:20:15 (17876): Status Report: CPU Time: '45814.203125' 2023-03-15 23:00:40 (17876): Status Report: Elapsed Time: '52433.616606' 2023-03-15 23:00:40 (17876): Status Report: CPU Time: '51838.109375' 2023-03-16 00:40:57 (17876): Status Report: Elapsed Time: '58433.616606' 2023-03-16 00:40:57 (17876): Status Report: CPU Time: '57852.921875' 2023-03-16 02:21:14 (17876): Status Report: Elapsed Time: '64433.616606' 2023-03-16 02:21:14 (17876): Status Report: CPU Time: '63860.671875' 2023-03-16 04:01:47 (17876): Status Report: Elapsed Time: '70433.616606' 2023-03-16 04:01:47 (17876): Status Report: CPU Time: '69891.296875' 2023-03-16 05:11:35 (17876): Stopping VM. 2023-03-16 05:11:59 (17876): Successfully stopped VM. 2023-03-16 05:12:01 (8620): Detected: vboxwrapper 26206 2023-03-16 05:12:01 (8620): Detected: BOINC client v7.20.2 2023-03-16 05:12:01 (8620): Detected: VirtualBox VboxManage Interface (Version: 6.1.34) 2023-03-16 05:12:02 (8620): Starting VM using VBoxManage interface. (boinc_c0e78b600160c23c, slot#12) 2023-03-16 05:12:33 (8620): Successfully started VM. (PID = '17016') 2023-03-16 05:12:33 (8620): Reporting VM Process ID to BOINC. 2023-03-16 05:12:33 (8620): VM state change detected. (old = 'poweredoff', new = 'running') 2023-03-16 05:12:33 (8620): Detected: Web Application Enabled (http://localhost:62044) 2023-03-16 05:12:33 (8620): Status Report: Elapsed Time: '74608.616606' 2023-03-16 05:12:33 (8620): Status Report: CPU Time: '74070.687500' 2023-03-16 05:12:33 (8620): Preference change detected 2023-03-16 05:12:33 (8620): Setting CPU throttle for VM. (100%) 2023-03-16 05:12:33 (8620): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2023-03-16 06:52:56 (8620): Status Report: Elapsed Time: '80608.616606' 2023-03-16 06:52:56 (8620): Status Report: CPU Time: '80110.718750' 2023-03-16 08:33:11 (8620): Status Report: Elapsed Time: '86608.616606' 2023-03-16 08:33:11 (8620): Status Report: CPU Time: '86116.125000' 2023-03-16 10:13:29 (8620): Status Report: Elapsed Time: '92608.616606' 2023-03-16 10:13:29 (8620): Status Report: CPU Time: '92128.421875' 2023-03-16 11:53:49 (8620): Status Report: Elapsed Time: '98608.616606' 2023-03-16 11:53:49 (8620): Status Report: CPU Time: '98142.359375' 2023-03-16 13:34:14 (8620): Status Report: Elapsed Time: '104608.616606' 2023-03-16 13:34:14 (8620): Status Report: CPU Time: '104156.312500' 2023-03-16 15:14:35 (8620): Status Report: Elapsed Time: '110609.394877' 2023-03-16 15:14:35 (8620): Status Report: CPU Time: '110170.906250' 2023-03-16 16:55:00 (8620): Status Report: Elapsed Time: '116609.394877' 2023-03-16 16:55:00 (8620): Status Report: CPU Time: '116191.062500' 2023-03-16 18:35:28 (8620): Status Report: Elapsed Time: '122609.394877' 2023-03-16 18:35:28 (8620): Status Report: CPU Time: '122214.562500' 2023-03-16 20:15:59 (8620): Status Report: Elapsed Time: '128610.073992' 2023-03-16 20:15:59 (8620): Status Report: CPU Time: '128231.656250' 2023-03-16 20:37:41 (596): Detected: vboxwrapper 26206 2023-03-16 20:37:41 (596): Detected: BOINC client v7.20.2 2023-03-16 20:37:43 (596): Detected: VirtualBox VboxManage Interface (Version: 6.1.34) 2023-03-16 20:37:43 (596): Starting VM using VBoxManage interface. (boinc_c0e78b600160c23c, slot#12) 2023-03-16 20:37:51 (596): Successfully started VM. (PID = '16276') 2023-03-16 20:37:51 (596): Reporting VM Process ID to BOINC. 2023-03-16 20:37:51 (596): Guest Log: BIOS: VirtualBox 6.1.34 2023-03-16 20:37:51 (596): Guest Log: CPUID EDX: 0x178bfbff 2023-03-16 20:37:51 (596): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-03-16 20:37:51 (596): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-03-16 20:37:51 (596): VM state change detected. (old = 'poweredoff', new = 'running') 2023-03-16 20:37:51 (596): Detected: Web Application Enabled (http://localhost:62044) 2023-03-16 20:37:51 (596): Status Report: Elapsed Time: '129774.073992' 2023-03-16 20:37:51 (596): Status Report: CPU Time: '129401.250000' 2023-03-16 20:37:51 (596): Preference change detected 2023-03-16 20:37:51 (596): Setting CPU throttle for VM. (100%) 2023-03-16 20:37:51 (596): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2023-03-16 20:37:53 (596): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-03-16 20:37:53 (596): Guest Log: BIOS: Booting from Hard Disk... 2023-03-16 20:37:56 (596): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-03-16 20:37:56 (596): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2023-03-16 20:37:56 (596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2023-03-16 20:38:00 (596): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-03-16 20:38:00 (596): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-03-16 20:38:12 (596): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.000174 main Log opened 2023-03-16T20:38:10.426346000Z 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.000302 main OS Product: Linux 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.000355 main OS Release: 3.10.0-957.27.2.el7.x86_64 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.000383 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.000410 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.000410 main Process ID: 1245 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.000411 main Package type: LINUX_64BITS_GENERIC 2023-03-16 20:38:12 (596): Guest Log: 00:00:00.001999 main 5.2.32 r132073 started. Verbose level = 0 2023-03-16 20:38:12 (596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2023-03-16 20:38:12 (596): Guest Log: [INFO] Mounting shared directory 2023-03-16 20:38:12 (596): Guest Log: [INFO] Checking for init_data.xml 2023-03-16 20:38:16 (596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2023-03-16 20:38:16 (596): Guest Log: [INFO] Detected branch: dev 2023-03-16 20:38:16 (596): Guest Log: This is the dev version of the ATLAS job wrapper 2023-03-16 20:38:16 (596): Guest Log: Copying input files 2023-03-16 20:38:19 (596): Guest Log: Copied input files into RunAtlas. 2023-03-16 20:38:19 (596): Guest Log: This VM did not configure a local http proxy via BOINC. 2023-03-16 20:38:19 (596): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2023-03-16 20:38:19 (596): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2023-03-16 20:38:19 (596): Guest Log: Further information can be found at the LHC@home message board. 2023-03-16 20:38:22 (596): Guest Log: 00:00:10.029757 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 611 074 397 000ns (GuestNow=1 679 020 701 529 107 000 ns GuestLast=1 678 999 090 454 710 000 ns fSetTimeLastLoop=true ) 2023-03-16 20:38:29 (596): Guest Log: Running cvmfs_config stat atlas.cern.ch 2023-03-16 20:38:29 (596): 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 2023-03-16 20:38:29 (596): Guest Log: 2.6.3.0 1517 0 32044 116835 4 1 3664070 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2023-03-16 20:38:30 (596): Guest Log: copied the webapp to /var/www 2023-03-16 20:38:30 (596): Guest Log: core_number=1 2023-03-16 20:38:30 (596): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2023-03-16 20:38:31 (596): Guest Log: *** Starting ATLAS job. (PandaID=5753961892 taskID=32413688) *** 2023-03-16 22:18:24 (596): Status Report: Elapsed Time: '135774.304728' 2023-03-16 22:18:24 (596): Status Report: CPU Time: '134361.703125' 2023-03-16 23:58:41 (596): Status Report: Elapsed Time: '141774.304728' 2023-03-16 23:58:41 (596): Status Report: CPU Time: '140362.609375' 2023-03-17 01:39:05 (596): Status Report: Elapsed Time: '147774.811671' 2023-03-17 01:39:05 (596): Status Report: CPU Time: '146376.031250' 2023-03-17 03:19:21 (596): Status Report: Elapsed Time: '153774.811671' 2023-03-17 03:19:21 (596): Status Report: CPU Time: '152388.781250' 2023-03-17 04:59:40 (596): Status Report: Elapsed Time: '159774.811671' 2023-03-17 04:59:40 (596): Status Report: CPU Time: '158405.859375' 2023-03-17 06:39:53 (596): Status Report: Elapsed Time: '165774.811671' 2023-03-17 06:39:53 (596): Status Report: CPU Time: '164415.437500' 2023-03-17 08:27:10 (596): Status Report: Elapsed Time: '171774.860556' 2023-03-17 08:27:10 (596): Status Report: CPU Time: '170719.968750' 2023-03-17 10:28:13 (596): Status Report: Elapsed Time: '177775.625061' 2023-03-17 10:28:13 (596): Status Report: CPU Time: '177793.234375' 2023-03-17 12:26:19 (596): Status Report: Elapsed Time: '183776.268423' 2023-03-17 12:26:19 (596): Status Report: CPU Time: '184737.953125' 2023-03-17 14:28:00 (596): Status Report: Elapsed Time: '189776.591841' 2023-03-17 14:28:00 (596): Status Report: CPU Time: '191818.828125' 2023-03-17 16:24:51 (596): Status Report: Elapsed Time: '195777.302683' 2023-03-17 16:24:51 (596): Status Report: CPU Time: '198375.640625' 2023-03-17 18:23:17 (596): Status Report: Elapsed Time: '201777.715706' 2023-03-17 18:23:17 (596): Status Report: CPU Time: '205021.718750' 2023-03-17 20:16:40 (596): Status Report: Elapsed Time: '207778.522684' 2023-03-17 20:16:40 (596): Status Report: CPU Time: '211438.968750' 2023-03-17 22:16:20 (596): Status Report: Elapsed Time: '213779.421257' 2023-03-17 22:16:20 (596): Status Report: CPU Time: '218198.859375' 2023-03-17 22:54:13 (596): Stopping VM. 2023-03-17 22:54:44 (596): Successfully stopped VM. 2023-03-17 22:54:46 (30156): Detected: vboxwrapper 26206 2023-03-17 22:54:46 (30156): Detected: BOINC client v7.20.2 2023-03-17 22:54:47 (30156): Detected: VirtualBox VboxManage Interface (Version: 6.1.34) 2023-03-17 22:54:48 (30156): Guest Log: BIOS: VirtualBox 6.1.34 2023-03-17 22:54:48 (30156): Guest Log: CPUID EDX: 0x178bfbff 2023-03-17 22:54:48 (30156): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-03-17 22:54:48 (30156): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-03-17 22:54:48 (30156): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-03-17 22:54:48 (30156): Guest Log: BIOS: Booting from Hard Disk... 2023-03-17 22:54:48 (30156): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-03-17 22:54:48 (30156): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2023-03-17 22:54:48 (30156): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2023-03-17 22:54:48 (30156): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-03-17 22:54:48 (30156): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-03-17 22:54:48 (30156): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.000174 main Log opened 2023-03-16T20:38:10.426346000Z 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.000302 main OS Product: Linux 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.000355 main OS Release: 3.10.0-957.27.2.el7.x86_64 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.000383 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.000410 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.000410 main Process ID: 1245 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.000411 main Package type: LINUX_64BITS_GENERIC 2023-03-17 22:54:48 (30156): Guest Log: 00:00:00.001999 main 5.2.32 r132073 started. Verbose level = 0 2023-03-17 22:54:48 (30156): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2023-03-17 22:54:48 (30156): Guest Log: [INFO] Mounting shared directory 2023-03-17 22:54:48 (30156): Guest Log: [INFO] Checking for init_data.xml 2023-03-17 22:54:48 (30156): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2023-03-17 22:54:48 (30156): Guest Log: [INFO] Detected branch: dev 2023-03-17 22:54:48 (30156): Guest Log: This is the dev version of the ATLAS job wrapper 2023-03-17 22:54:48 (30156): Guest Log: Copying input files 2023-03-17 22:54:48 (30156): Guest Log: Copied input files into RunAtlas. 2023-03-17 22:54:48 (30156): Guest Log: This VM did not configure a local http proxy via BOINC. 2023-03-17 22:54:48 (30156): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2023-03-17 22:54:48 (30156): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2023-03-17 22:54:48 (30156): Guest Log: Further information can be found at the LHC@home message board. 2023-03-17 22:54:48 (30156): Guest Log: 00:00:10.029757 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 611 074 397 000ns (GuestNow=1 679 020 701 529 107 000 ns GuestLast=1 678 999 090 454 710 000 ns fSetTimeLastLoop=true ) 2023-03-17 22:54:48 (30156): Guest Log: Running cvmfs_config stat atlas.cern.ch 2023-03-17 22:54:48 (30156): 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 2023-03-17 22:54:48 (30156): Guest Log: 2.6.3.0 1517 0 32044 116835 4 1 3664070 4096001 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2023-03-17 22:54:48 (30156): Guest Log: copied the webapp to /var/www 2023-03-17 22:54:48 (30156): Guest Log: core_number=1 2023-03-17 22:54:48 (30156): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2023-03-17 22:54:48 (30156): Guest Log: *** Starting ATLAS job. (PandaID=5753961892 taskID=32413688) *** 2023-03-17 22:54:48 (30156): Starting VM using VBoxManage interface. (boinc_c0e78b600160c23c, slot#12) 2023-03-17 22:55:15 (30156): Successfully started VM. (PID = '50044') 2023-03-17 22:55:15 (30156): Reporting VM Process ID to BOINC. 2023-03-17 22:55:15 (30156): VM state change detected. (old = 'poweredoff', new = 'running') 2023-03-17 22:55:15 (30156): Detected: Web Application Enabled (http://localhost:62044) 2023-03-17 22:55:15 (30156): Status Report: Elapsed Time: '215523.225838' 2023-03-17 22:55:15 (30156): Status Report: CPU Time: '220369.171875' 2023-03-17 22:55:15 (30156): Preference change detected 2023-03-17 22:55:15 (30156): Setting CPU throttle for VM. (100%) 2023-03-17 22:55:15 (30156): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2023-03-18 00:53:54 (30156): Status Report: Elapsed Time: '221524.139780' 2023-03-18 00:53:54 (30156): Status Report: CPU Time: '227249.265625' 2023-03-18 02:49:14 (30156): Status Report: Elapsed Time: '227524.409687' 2023-03-18 02:49:14 (30156): Status Report: CPU Time: '234013.296875' 2023-03-18 04:47:48 (30156): Status Report: Elapsed Time: '233524.708611' 2023-03-18 04:47:48 (30156): Status Report: CPU Time: '240874.390625' 2023-03-18 06:52:20 (30156): Status Report: Elapsed Time: '239525.017210' 2023-03-18 06:52:20 (30156): Status Report: CPU Time: '247925.000000' 2023-03-18 09:00:01 (30156): Status Report: Elapsed Time: '245525.273720' 2023-03-18 09:00:01 (30156): Status Report: CPU Time: '255139.265625' 2023-03-18 11:06:12 (30156): Status Report: Elapsed Time: '251526.002413' 2023-03-18 11:06:12 (30156): Status Report: CPU Time: '262243.125000' 2023-03-18 11:49:21 (30156): Guest Log: *** Job finished *** 2023-03-18 11:49:21 (30156): Guest Log: *** The last 20 lines of the pilot log: *** 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:48:40,575 | INFO | [job] queue monitor thread has finished 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:48:42,135 | INFO | [data] queue_monitor thread has finished 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:48:48,825 | INFO | job.realtimelogging is not enabled 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:48:48,825 | INFO | [payload] run_realtimelog thread has finished 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:14,441 | WARNING | no jobs in monitored_payloads queue (waited for 74 s) 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:14,442 | INFO | [job] job monitor thread has finished 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:15,845 | INFO | end of generic workflow (traces error code: 0) 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:15,845 | INFO | traces error code: 0 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:15,846 | INFO | pilot has finished 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,007 [wrapper] ==== pilot stdout END ==== 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,015 [wrapper] ==== wrapper stdout RESUME ==== 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,024 [wrapper] pilotpid: 5273 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,034 [wrapper] Pilot exit status: 0 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,841 [wrapper] pandaids: 5753961892 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,862 [wrapper] apfmon messages muted 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,878 [wrapper] Test setup, not cleaning 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,887 [wrapper] ==== wrapper stdout END ==== 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:16,895 [wrapper] ==== wrapper stderr END ==== 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:17,022 [wrapper] wrapperexiting ec=0, duration=141046 2023-03-18 11:49:21 (30156): Guest Log: 2023-03-18 17:49:17,031 [wrapper] apfmon messages muted 2023-03-18 11:49:21 (30156): Guest Log: *** Error codes and diagnostics *** 2023-03-18 11:49:21 (30156): Guest Log: "exeErrorCode": 0, 2023-03-18 11:49:21 (30156): Guest Log: "exeErrorDiag": "", 2023-03-18 11:49:21 (30156): Guest Log: "pilotErrorCode": 0, 2023-03-18 11:49:21 (30156): Guest Log: "pilotErrorDiag": "", 2023-03-18 11:49:21 (30156): Guest Log: *** Listing of results directory *** 2023-03-18 11:49:21 (30156): Guest Log: total 311096 2023-03-18 11:49:21 (30156): Guest Log: -rw-r--r--. 1 atlas atlas 386707 Mar 15 08:36 pilot3.tar.gz 2023-03-18 11:49:21 (30156): Guest Log: -rw-r--r--. 1 atlas atlas 4332 Mar 15 08:44 queuedata.json 2023-03-18 11:49:21 (30156): Guest Log: -rwx------. 1 atlas atlas 26447 Mar 15 08:44 runpilot2-wrapper.sh 2023-03-18 11:49:21 (30156): Guest Log: -rwxr-xr-x. 1 atlas atlas 12112 Mar 17 02:38 init_data.xml 2023-03-18 11:49:21 (30156): Guest Log: -rwxr-xr-x. 1 atlas atlas 398357 Mar 17 02:38 input.tar.gz 2023-03-18 11:49:21 (30156): Guest Log: -rwxr-xr-x. 1 atlas atlas 17293 Mar 17 02:38 start_atlas.sh 2023-03-18 11:49:21 (30156): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Mar 17 02:38 EVNT.29838250._000010.pool.root.1 -> /data/./ATLAS.root_0 2023-03-18 11:49:21 (30156): Guest Log: -rw-r--r--. 1 atlas atlas 2549 Mar 17 02:38 pandaJob.out 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 354 Mar 17 02:38 setup.sh.local 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 975566 Mar 17 02:38 agis_schedconf.cvmfs.json 2023-03-18 11:49:21 (30156): Guest Log: drwx------. 4 atlas atlas 245 Mar 17 02:39 pilot3 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 304295596 Mar 18 17:47 HITS.32413688._000229-101283-1678869884.pool.root.1 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 1044 Mar 18 17:48 memory_monitor_summary.json 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 1426500 Mar 18 17:48 agis_ddmendpoints.agis.ALL.json 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 894104 Mar 18 17:48 log.32413688._000229-101283-1678869884.job.log.tgz.1 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 7743 Mar 18 17:48 heartbeat.json 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 2926 Mar 18 17:49 pilotlog.txt 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 4566544 Mar 18 17:49 log.32413688._000229-101283-1678869884.job.log.1 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 399 Mar 18 17:49 output.list 2023-03-18 11:49:21 (30156): Guest Log: -rw-r--r--. 1 atlas atlas 674 Mar 18 17:49 runtime_log 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 5478400 Mar 18 17:49 result.tar.gz 2023-03-18 11:49:21 (30156): Guest Log: -rw-r--r--. 1 atlas atlas 10478 Mar 18 17:49 runtime_log.err 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 651 Mar 18 17:49 1JcNDmhvbw2n7Olcko1bjSoqABFKDmABFKDm7AsVDmNOGKDme6ceMn.diag 2023-03-18 11:49:21 (30156): Guest Log: Looking for outputfile HITS.32413688._000229-101283-1678869884.pool.root.1 2023-03-18 11:49:21 (30156): Guest Log: HITS file was successfully produced 2023-03-18 11:49:21 (30156): Guest Log: -rw-------. 1 atlas atlas 304295596 Mar 18 17:47 /home/atlas/RunAtlas/HITS.32413688._000229-101283-1678869884.pool.root.1 2023-03-18 11:49:25 (30156): Guest Log: Successfully finished the ATLAS job! 2023-03-18 11:49:25 (30156): Guest Log: Copying the results back to the shared directory! 2023-03-18 11:49:25 (30156): Guest Log: *** Contents of shared directory: *** 2023-03-18 11:49:26 (30156): Guest Log: total 729096 2023-03-18 11:49:26 (30156): Guest Log: -rwxrwxrwx. 1 root root 436382292 Mar 15 14:13 ATLAS.root_0 2023-03-18 11:49:26 (30156): Guest Log: -rwxrwxrwx. 1 root root 304295596 Mar 18 17:47 HITS.pool.root.1 2023-03-18 11:49:26 (30156): Guest Log: -rwxrwxrwx. 1 root root 12112 Mar 15 14:13 init_data.xml 2023-03-18 11:49:26 (30156): Guest Log: -rwxrwxrwx. 1 root root 398357 Mar 15 12:24 input.tar.gz 2023-03-18 11:49:26 (30156): Guest Log: -rwxrwxrwx. 1 root root 5478400 Mar 18 17:49 result.tar.gz 2023-03-18 11:49:26 (30156): Guest Log: -rwxrwxrwx. 1 root root 17293 Mar 15 12:24 start_atlas.sh 2023-03-18 11:49:26 (30156): Guest Log: *** Success! Shutting down the machine. *** 2023-03-18 11:49:26 (30156): VM Completion File Detected. 2023-03-18 11:49:26 (30156): Powering off VM. 2023-03-18 11:49:28 (30156): Successfully stopped VM. 2023-03-18 11:49:28 (30156): Deregistering VM. (boinc_c0e78b600160c23c, slot#12) 2023-03-18 11:49:28 (30156): Removing network bandwidth throttle group from VM. 2023-03-18 11:49:29 (30156): Removing VM from VirtualBox. 11:49:35 (30156): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN