Name phbKDmLaAO7n9Rq4apOajLDm4fhM0noT9bVoFjIUDmqMzKDm11dhdn_2
Workunit 231585591
Created 13 Apr 2025, 18:22:15 UTC
Sent 13 Apr 2025, 22:04:22 UTC
Report deadline 21 Apr 2025, 22:04:22 UTC
Received 15 Apr 2025, 11:14:57 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10869290
Run time 31 min 51 sec
CPU time 18 min 28 sec
Validate state Valid
Credit 771.58
Device peak FLOPS 17.79 GFLOPS
Application version ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas)
windows_x86_64
Peak working set size 76.68 MB
Peak swap size 68.74 MB
Peak disk usage 1.96 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2025-04-14 16:38:44 (10620): Detected: vboxwrapper 26206
2025-04-14 16:38:44 (10620): Detected: BOINC client v8.0.2
2025-04-14 16:38:45 (10620): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-14 16:38:45 (10620): Successfully copied 'init_data.xml' to the shared directory.
2025-04-14 16:38:45 (10620): Create VM. (boinc_d0a0c3f5f3a3f1ad, slot#0)
2025-04-14 16:38:46 (10620): Setting Memory Size for VM. (4400MB)
2025-04-14 16:38:46 (10620): Setting CPU Count for VM. (4)
2025-04-14 16:38:47 (10620): Setting Chipset Options for VM.
2025-04-14 16:38:47 (10620): Setting Graphics Controller Options for VM.
2025-04-14 16:38:48 (10620): Setting Boot Options for VM.
2025-04-14 16:38:48 (10620): Setting Network Configuration for NAT.
2025-04-14 16:38:48 (10620): Enabling VM Network Access.
2025-04-14 16:38:48 (10620): Disabling USB Support for VM.
2025-04-14 16:38:49 (10620): Disabling COM Port Support for VM.
2025-04-14 16:38:49 (10620): Disabling LPT Port Support for VM.
2025-04-14 16:38:49 (10620): Disabling Audio Support for VM.
2025-04-14 16:38:49 (10620): Disabling Clipboard Support for VM.
2025-04-14 16:38:50 (10620): Disabling Drag and Drop Support for VM.
2025-04-14 16:38:50 (10620): Adding storage controller(s) to VM.
2025-04-14 16:38:50 (10620): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi)
2025-04-14 16:38:53 (10620): Adding VirtualBox Guest Additions to VM.
2025-04-14 16:38:53 (10620): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-04-14 16:38:54 (10620): forwarding host port 63189 to guest port 80
2025-04-14 16:38:54 (10620): Enabling remote desktop for VM.
2025-04-14 16:38:54 (10620): Required extension pack not installed, remote desktop not enabled.
2025-04-14 16:38:54 (10620): Enabling shared directory for VM.
2025-04-14 16:38:55 (10620): Starting VM using VBoxManage interface. (boinc_d0a0c3f5f3a3f1ad, slot#0)
2025-04-14 16:39:01 (10620): Successfully started VM. (PID = '8392')
2025-04-14 16:39:01 (10620): Reporting VM Process ID to BOINC.
2025-04-14 16:39:01 (10620): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-14 16:39:01 (10620): Guest Log: CPUID EDX: 0x178bfbff
2025-04-14 16:39:01 (10620): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-14 16:39:01 (10620): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-14 16:39:01 (10620): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-14 16:39:01 (10620): Detected: Web Application Enabled (http://localhost:63189)
2025-04-14 16:39:01 (10620): Preference change detected
2025-04-14 16:39:01 (10620): Setting CPU throttle for VM. (100%)
2025-04-14 16:39:01 (10620): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-14 16:39:03 (10620): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-14 16:39:03 (10620): Guest Log: BIOS: Booting from Hard Disk...
2025-04-14 16:39:06 (10620): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-14 16:39:06 (10620): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-14 16:39:06 (10620): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-14 16:39:14 (10620): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-14 16:39:14 (10620): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-14 16:39:26 (10620): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.000246 main     Log opened 2025-04-14T16:39:25.119883000Z
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.000431 main     OS Product: Linux
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.000523 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.000658 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.000722 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.000724 main     Process ID: 1310
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.000725 main     Package type: LINUX_64BITS_GENERIC
2025-04-14 16:39:26 (10620): Guest Log: 00:00:00.004156 main     5.2.32 r132073 started. Verbose level = 0
2025-04-14 16:39:27 (10620): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-14 16:39:27 (10620): Guest Log: [INFO] Mounting shared directory
2025-04-14 16:39:27 (10620): Guest Log: [INFO] Checking for init_data.xml
2025-04-14 16:39:34 (10620): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-14 16:39:34 (10620): Guest Log: [INFO] Detected branch: prod
2025-04-14 16:39:34 (10620): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-14 16:39:34 (10620): Guest Log: Copying input files
2025-04-14 16:39:36 (10620): Guest Log: Copied input files into RunAtlas.
2025-04-14 16:39:36 (10620): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-14 16:39:36 (10620): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-14 16:39:36 (10620): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-14 16:39:36 (10620): Guest Log: Further information can be found at the LHC@home message board.
2025-04-14 16:39:36 (10620): Guest Log: 00:00:10.013810 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 211 569 239 000ns (GuestNow=1 744 673 976 697 601 000 ns GuestLast=1 744 648 765 128 362 000 ns fSetTimeLastLoop=true )
2025-04-14 16:39:47 (10620): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-14 16:39:47 (10620): 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
2025-04-14 16:39:47 (10620): Guest Log: 2.6.3.0 1591 0 30004 144868 3 1 3117322 4096000 0 65024 0 0 n/a 1 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-04-14 16:39:51 (10620): Guest Log: copied the webapp to /var/www
2025-04-14 16:39:51 (10620): Guest Log: ATHENA_PROC_NUMBER=4
2025-04-14 16:39:51 (10620): Guest Log: ATHENA_CORE_NUMBER=4
2025-04-14 16:39:51 (10620): 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 
2025-04-14 16:39:51 (10620): Guest Log:  *** Starting ATLAS job. (PandaID=6601724498 taskID=44075164) ***
2025-04-14 16:43:46 (10620): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 16:44:07 (10620): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 16:44:57 (10620): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 16:45:17 (10620): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 16:59:19 (10620): Stopping VM.
2025-04-14 16:59:43 (10620): Successfully stopped VM.
2025-04-14 17:15:35 (5168): Detected: vboxwrapper 26206
2025-04-14 17:15:35 (5168): Detected: BOINC client v8.0.2
2025-04-14 17:15:36 (5168): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-14 17:15:37 (5168): Guest Log: BIOS: VirtualBox 7.1.6
2025-04-14 17:15:37 (5168): Guest Log: CPUID EDX: 0x178bfbff
2025-04-14 17:15:37 (5168): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-04-14 17:15:37 (5168): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-04-14 17:15:37 (5168): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-04-14 17:15:37 (5168): Guest Log: BIOS: Booting from Hard Disk...
2025-04-14 17:15:37 (5168): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-14 17:15:37 (5168): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-14 17:15:37 (5168): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-14 17:15:37 (5168): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-14 17:15:37 (5168): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-14 17:15:37 (5168): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.000246 main     Log opened 2025-04-14T16:39:25.119883000Z
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.000431 main     OS Product: Linux
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.000523 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.000658 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.000722 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.000724 main     Process ID: 1310
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.000725 main     Package type: LINUX_64BITS_GENERIC
2025-04-14 17:15:37 (5168): Guest Log: 00:00:00.004156 main     5.2.32 r132073 started. Verbose level = 0
2025-04-14 17:15:37 (5168): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-14 17:15:37 (5168): Guest Log: [INFO] Mounting shared directory
2025-04-14 17:15:37 (5168): Guest Log: [INFO] Checking for init_data.xml
2025-04-14 17:15:37 (5168): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-14 17:15:37 (5168): Guest Log: [INFO] Detected branch: prod
2025-04-14 17:15:37 (5168): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-14 17:15:37 (5168): Guest Log: Copying input files
2025-04-14 17:15:37 (5168): Guest Log: Copied input files into RunAtlas.
2025-04-14 17:15:37 (5168): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-14 17:15:37 (5168): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-14 17:15:37 (5168): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-14 17:15:37 (5168): Guest Log: Further information can be found at the LHC@home message board.
2025-04-14 17:15:37 (5168): Guest Log: 00:00:10.013810 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 211 569 239 000ns (GuestNow=1 744 673 976 697 601 000 ns GuestLast=1 744 648 765 128 362 000 ns fSetTimeLastLoop=true )
2025-04-14 17:15:37 (5168): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-14 17:15:37 (5168): 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
2025-04-14 17:15:37 (5168): Guest Log: 2.6.3.0 1591 0 30004 144868 3 1 3117322 4096000 0 65024 0 0 n/a 1 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1
2025-04-14 17:15:37 (5168): Guest Log: copied the webapp to /var/www
2025-04-14 17:15:37 (5168): Guest Log: ATHENA_PROC_NUMBER=4
2025-04-14 17:15:37 (5168): Guest Log: ATHENA_CORE_NUMBER=4
2025-04-14 17:15:37 (5168): 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 
2025-04-14 17:15:37 (5168): Guest Log:  *** Starting ATLAS job. (PandaID=6601724498 taskID=44075164) ***
2025-04-14 17:15:37 (5168): Starting VM using VBoxManage interface. (boinc_d0a0c3f5f3a3f1ad, slot#0)
2025-04-14 17:15:59 (5168): Successfully started VM. (PID = '10348')
2025-04-14 17:15:59 (5168): Reporting VM Process ID to BOINC.
2025-04-14 17:15:59 (5168): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-14 17:15:59 (5168): Detected: Web Application Enabled (http://localhost:63189)
2025-04-14 17:15:59 (5168): Preference change detected
2025-04-14 17:15:59 (5168): Setting CPU throttle for VM. (100%)
2025-04-14 17:16:00 (5168): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-14 17:17:41 (5168): Stopping VM.
2025-04-14 17:18:00 (5168): Successfully stopped VM.
2025-04-14 17:32:32 (7860): Detected: vboxwrapper 26206
2025-04-14 17:32:32 (7860): Detected: BOINC client v8.0.2
2025-04-14 17:32:33 (7860): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-14 17:32:34 (7860): Starting VM using VBoxManage interface. (boinc_d0a0c3f5f3a3f1ad, slot#0)
2025-04-14 17:32:52 (7860): Successfully started VM. (PID = '2400')
2025-04-14 17:32:52 (7860): Reporting VM Process ID to BOINC.
2025-04-14 17:32:52 (7860): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-14 17:32:52 (7860): Detected: Web Application Enabled (http://localhost:63189)
2025-04-14 17:32:52 (7860): Preference change detected
2025-04-14 17:32:52 (7860): Setting CPU throttle for VM. (100%)
2025-04-14 17:32:52 (7860): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-14 17:44:03 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 17:49:18 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 17:54:39 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 17:59:55 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:05:11 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:10:32 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:15:53 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:21:14 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:26:19 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:31:44 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:37:05 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:42:19 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:47:44 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:53:12 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 18:58:35 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:04:11 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:09:30 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:14:52 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:20:10 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:25:33 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:30:38 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:35:49 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:41:04 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:46:14 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:51:31 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 19:56:38 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:02:03 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:07:24 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:12:46 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:18:11 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:23:26 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:28:41 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:33:57 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:39:21 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:44:37 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:50:11 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 20:55:21 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:00:42 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:05:50 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:11:11 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:16:32 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:21:33 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:26:33 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:32:02 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:37:17 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:42:31 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:47:35 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:52:44 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 21:57:54 (7860): Error in pause VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_d0a0c3f5f3a3f1ad" pause
Output:

2025-04-14 22:01:22 (7860): VM state change detected. (old = 'running', new = 'paused')
2025-04-14 22:01:44 (7860): VM state change detected. (old = 'paused', new = 'running')
2025-04-14 22:01:45 (7860): Stopping VM.
2025-04-14 22:02:06 (7860): Successfully stopped VM.
2025-04-15 03:30:53 (9500): Detected: vboxwrapper 26206
2025-04-15 03:30:53 (9500): Detected: BOINC client v8.0.2
2025-04-15 03:30:54 (9500): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-04-15 03:30:55 (9500): Starting VM using VBoxManage interface. (boinc_d0a0c3f5f3a3f1ad, slot#0)
2025-04-15 03:31:18 (9500): Successfully started VM. (PID = '256')
2025-04-15 03:31:18 (9500): Reporting VM Process ID to BOINC.
2025-04-15 03:31:18 (9500): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-15 03:31:18 (9500): Detected: Web Application Enabled (http://localhost:63189)
2025-04-15 03:31:19 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:31:19 (9500): Preference change detected
2025-04-15 03:31:19 (9500): Setting CPU throttle for VM. (100%)
2025-04-15 03:31:20 (9500): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-15 03:31:20 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:31:24 (9500): Guest Log: 04:49:34.696394 timesync vgsvcTimeSyncWorker: Radical host time change: 19 804 771 000 000ns (HostNow=1 744 713 083 675 000 000 ns HostLast=1 744 693 278 904 000 000 ns)
2025-04-15 03:31:30 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:31:50 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:31:54 (9500): Guest Log: 04:49:44.697700 timesync vgsvcTimeSyncWorker: Radical guest time change: 19 804 771 931 000ns (GuestNow=1 744 713 093 676 371 000 ns GuestLast=1 744 693 288 904 440 000 ns fSetTimeLastLoop=true )
2025-04-15 03:32:00 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:32:20 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:32:30 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:32:51 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:33:01 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:33:21 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:33:31 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:33:51 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:34:01 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:34:21 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:34:31 (9500): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 03:34:51 (9500): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 03:38:00 (9500): Guest Log:  *** Job finished ***
2025-04-15 03:38:00 (9500): Guest Log:  *** The last 20 lines of the pilot log: ***
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:28,576 | INFO     | [payload] failed_post thread has finished
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:28,627 | INFO     | [job] control thread has finished
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:32,374 | INFO     | [data] queue_monitor thread has finished
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:34,076 | INFO     | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140289834854208)>', '<ExcThread(monitor, started 140289251464960)>']
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:34,969 | WARNING  | job_aborted has been set - aborting pilot monitoring
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:34,969 | INFO     | [monitor] control thread has ended
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,083 | INFO     | all workflow threads have been joined
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,083 | INFO     | end of generic workflow (traces error code: 0)
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,083 | INFO     | traces error code: 0
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,083 | INFO     | pilot has finished (exit code=0, shell exit code=0)
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,255 [wrapper] ==== pilot stdout END ====
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,262 [wrapper] ==== wrapper stdout RESUME ====
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,267 [wrapper] pilotpid: 5937
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,272 [wrapper] Pilot exit status: 0
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,912 [wrapper] pandaids: 6601724498
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,956 [wrapper] cleanup supervisor_pilot 22275 5938
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,965 [wrapper] Test setup, not cleaning
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,974 [wrapper] apfmon messages muted
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,979 [wrapper] ==== wrapper stdout END ====
2025-04-15 03:38:00 (9500): Guest Log: 2025-04-15 10:35:39,985 [wrapper] ==== wrapper stderr END ====
2025-04-15 03:38:00 (9500): Guest Log:  *** Error codes and diagnostics ***
2025-04-15 03:38:00 (9500): Guest Log:     "exeErrorCode": 0,
2025-04-15 03:38:00 (9500): Guest Log:     "exeErrorDiag": "",
2025-04-15 03:38:00 (9500): Guest Log:     "pilotErrorCode": 0,
2025-04-15 03:38:00 (9500): Guest Log:     "pilotErrorDiag": "",
2025-04-15 03:38:00 (9500): Guest Log:  *** Listing of results directory ***
2025-04-15 03:38:00 (9500): Guest Log: total 198412
2025-04-15 03:38:00 (9500): Guest Log: -rw-r--r--. 1 atlas atlas    495897 Apr 13 11:15 pilot3.tar.gz
2025-04-15 03:38:00 (9500): Guest Log: -rwx------. 1 atlas atlas     37140 Apr 13 11:21 runpilot2-wrapper.sh
2025-04-15 03:38:00 (9500): Guest Log: -rw-r--r--. 1 atlas atlas      5111 Apr 13 11:21 queuedata.json
2025-04-15 03:38:00 (9500): Guest Log: -rwxr-xr-x. 1 atlas atlas      9100 Apr 14 23:39 init_data.xml
2025-04-15 03:38:00 (9500): Guest Log: -rwxr-xr-x. 1 atlas atlas    508880 Apr 14 23:39 input.tar.gz
2025-04-15 03:38:00 (9500): Guest Log: -rwxr-xr-x. 1 atlas atlas     17569 Apr 14 23:39 start_atlas.sh
2025-04-15 03:38:00 (9500): Guest Log: lrwxrwxrwx. 1 atlas atlas        20 Apr 14 23:39 EVNT.44075162._000092.pool.root.1 -> /data/./ATLAS.root_0
2025-04-15 03:38:00 (9500): Guest Log: -rw-r--r--. 1 atlas atlas      2546 Apr 14 23:39 pandaJob.out
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas       424 Apr 14 23:40 setup.sh.local
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas    986083 Apr 14 23:42 agis_schedconf.cvmfs.json
2025-04-15 03:38:00 (9500): Guest Log: drwx------. 4 atlas atlas      4096 Apr 14 23:42 pilot3
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas 195833950 Apr 15 10:34 HITS.44075164._056405.pool.root.1
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas      1032 Apr 15 10:35 memory_monitor_summary.json
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas   1603529 Apr 15 10:35 agis_ddmendpoints.agis.ALL.json
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas    343362 Apr 15 10:35 log.44075164._056405.job.log.tgz.1
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas      7691 Apr 15 10:35 heartbeat.json
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas        98 Apr 15 10:35 pilot_heartbeat.json
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas      4413 Apr 15 10:35 pilotlog.txt
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas   1437768 Apr 15 10:35 log.44075164._056405.job.log.1
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas       357 Apr 15 10:35 output.list
2025-04-15 03:38:00 (9500): Guest Log: -rw-r--r--. 1 atlas atlas       620 Apr 15 10:35 runtime_log
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas   1802240 Apr 15 10:35 result.tar.gz
2025-04-15 03:38:00 (9500): Guest Log: -rw-r--r--. 1 atlas atlas     10953 Apr 15 10:35 runtime_log.err
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas       665 Apr 15 10:35 phbKDmLaAO7n9Rq4apOajLDm4fhM0noT9bVoFjIUDmqMzKDm11dhdn.diag
2025-04-15 03:38:00 (9500): Guest Log: Looking for outputfile HITS.44075164._056405.pool.root.1
2025-04-15 03:38:00 (9500): Guest Log: HITS file was successfully produced
2025-04-15 03:38:00 (9500): Guest Log: -rw-------. 1 atlas atlas 195833950 Apr 15 10:34 /home/atlas/RunAtlas/HITS.44075164._056405.pool.root.1
2025-04-15 03:38:01 (9500): Guest Log: Successfully finished the ATLAS job!
2025-04-15 03:38:01 (9500): Guest Log: Copying the results back to the shared directory!
2025-04-15 03:38:02 (9500): Guest Log:  *** Contents of shared directory: ***
2025-04-15 03:38:02 (9500): Guest Log: total 410168
2025-04-15 03:38:02 (9500): Guest Log: -rwxrwxrwx. 1 root root 221825744 Apr 14 23:38 ATLAS.root_0
2025-04-15 03:38:02 (9500): Guest Log: -rwxrwxrwx. 1 root root 195833950 Apr 15  2025 HITS.pool.root.1
2025-04-15 03:38:02 (9500): Guest Log: -rwxrwxrwx. 1 root root      9100 Apr 14 23:38 init_data.xml
2025-04-15 03:38:02 (9500): Guest Log: -rwxrwxrwx. 1 root root    508880 Apr 13 22:04 input.tar.gz
2025-04-15 03:38:02 (9500): Guest Log: -rwxrwxrwx. 1 root root   1802240 Apr 15  2025 result.tar.gz
2025-04-15 03:38:02 (9500): Guest Log: -rwxrwxrwx. 1 root root     17569 Apr 13 22:04 start_atlas.sh
2025-04-15 03:38:02 (9500): Guest Log:  *** Success! Shutting down the machine. ***
2025-04-15 03:38:02 (9500): VM Completion File Detected.
2025-04-15 03:38:02 (9500): Powering off VM.
2025-04-15 03:38:03 (9500): Successfully stopped VM.
2025-04-15 03:38:03 (9500): Deregistering VM. (boinc_d0a0c3f5f3a3f1ad, slot#0)
2025-04-15 03:38:03 (9500): Removing network bandwidth throttle group from VM.
2025-04-15 03:38:04 (9500): Removing VM from VirtualBox.
03:38:10 (9500): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN