Name | 3VoMDm3rwR8n9Rq4apOajLDm4fhM0noT9bVof3QYDmpfSMDmhGtYBn_2 |
Workunit | 235907391 |
Created | 12 Oct 2025, 5:03:43 UTC |
Sent | 12 Oct 2025, 7:21:10 UTC |
Report deadline | 20 Oct 2025, 7:21:10 UTC |
Received | 12 Oct 2025, 10:36:40 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10828247 |
Run time | 3 hours 10 min 43 sec |
CPU time | 22 hours 44 min 32 sec |
Validate state | Valid |
Credit | 495.27 |
Device peak FLOPS | 35.88 GFLOPS |
Application version | ATLAS Simulation v3.01 (native_mt) x86_64-pc-linux-gnu |
Peak working set size | 2.69 GB |
Peak swap size | 31.90 GB |
Peak disk usage | 839.90 MB |
<core_client_version>7.7.0</core_client_version> <![CDATA[ <stderr_txt> 03:21:25 (2466754): wrapper (7.7.26015): starting 03:21:25 (2466754): wrapper: running run_atlas (--nthreads 8) [2025-10-12 03:21:25] Arguments: --nthreads 8 [2025-10-12 03:21:25] Threads: 8 [2025-10-12 03:21:25] Checking for CVMFS [2025-10-12 03:21:25] Probing /cvmfs/atlas.cern.ch... OK [2025-10-12 03:21:25] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-10-12 03:21:25] Running cvmfs_config stat atlas.cern.ch [2025-10-12 03:21:25] 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-10-12 03:21:25] 2.10.1.0 4440 186764 169084 151612 1 57 16430472 18432000 3665 130560 2 224138576 99.991 7125741 5567 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-10-12 03:21:25] CVMFS is ok [2025-10-12 03:21:25] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-10-12 03:21:25] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-10-12 03:21:25] Further information can be found at the LHC@home message board. [2025-10-12 03:21:25] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-10-12 03:21:25] Checking for apptainer binary... [2025-10-12 03:21:25] Using apptainer found in PATH at /usr/bin/apptainer [2025-10-12 03:21:25] Running /usr/bin/apptainer --version [2025-10-12 03:21:25] apptainer version 1.1.9-1.el8 [2025-10-12 03:21:25] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-10-12 03:21:26] c-16-31.aglt2.org [2025-10-12 03:21:26] apptainer works [2025-10-12 03:21:26] Set ATHENA_PROC_NUMBER=8 [2025-10-12 03:21:26] Set ATHENA_CORE_NUMBER=8 [2025-10-12 03:21:26] Starting ATLAS job with PandaID=6838989802 [2025-10-12 03:21:26] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh 03:40:06 (2466754): BOINC client no longer exists - exiting 03:40:06 (2466754): timer handler: client dead, exiting 03:40:49 (2886068): wrapper (7.7.26015): starting 03:40:49 (2886068): wrapper: running run_atlas (--nthreads 8) [2025-10-12 03:40:49] Arguments: --nthreads 8 [2025-10-12 03:40:49] Threads: 8 [2025-10-12 03:40:49] This job has been restarted, cleaning up previous attempt [2025-10-12 03:40:49] Checking for CVMFS [2025-10-12 03:40:49] Probing /cvmfs/atlas.cern.ch... OK [2025-10-12 03:40:49] Probing /cvmfs/atlas-condb.cern.ch... OK [2025-10-12 03:40:49] Running cvmfs_config stat atlas.cern.ch [2025-10-12 03:40:49] 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-10-12 03:40:49] 2.10.1.0 4440 186783 165552 151612 2 188 16440001 18432001 1 130560 2 224246796 99.991 7125811 5567 http://cvmfs-s1fnal.opensciencegrid.org:8000/cvmfs/atlas.cern.ch http://192.41.231.237:6081 1 [2025-10-12 03:40:49] CVMFS is ok [2025-10-12 03:40:49] Efficiency of ATLAS tasks can be improved by the following measure(s): [2025-10-12 03:40:49] The CVMFS client on this computer should be configured to use Cloudflare's openhtc.io. [2025-10-12 03:40:49] Further information can be found at the LHC@home message board. [2025-10-12 03:40:49] Using apptainer image /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 [2025-10-12 03:40:49] Checking for apptainer binary... [2025-10-12 03:40:49] Using apptainer found in PATH at /usr/bin/apptainer [2025-10-12 03:40:49] Running /usr/bin/apptainer --version [2025-10-12 03:40:49] apptainer version 1.1.9-1.el8 [2025-10-12 03:40:49] Checking apptainer works with /usr/bin/apptainer exec -B /cvmfs /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 hostname [2025-10-12 03:40:50] c-16-31.aglt2.org [2025-10-12 03:40:50] apptainer works [2025-10-12 03:40:50] Set ATHENA_PROC_NUMBER=8 [2025-10-12 03:40:50] Set ATHENA_CORE_NUMBER=8 [2025-10-12 03:40:50] Starting ATLAS job with PandaID=6838989802 [2025-10-12 03:40:50] Running command: /usr/bin/apptainer exec -B /cvmfs,/tmp/boinchome/slots/2 /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 sh start_atlas.sh [2025-10-12 06:32:53] *** The last 200 lines of the pilot log: *** [2025-10-12 06:32:53] 2025-10-12 10:30:27,143 | INFO | [job] validate thread has finished [2025-10-12 06:32:53] 2025-10-12 10:30:27,869 | INFO | [payload] control thread has finished [2025-10-12 06:32:53] 2025-10-12 10:30:27,875 | INFO | [data] copytool_in thread has finished [2025-10-12 06:32:53] 2025-10-12 10:30:29,846 | INFO | [data] queue_monitor thread has finished [2025-10-12 06:32:53] 2025-10-12 10:30:48,059 | INFO | job 6838989802 has state=failed [2025-10-12 06:32:53] 2025-10-12 10:30:48,059 | INFO | preparing for final server update for job 6838989802 in state='failed' [2025-10-12 06:32:53] 2025-10-12 10:30:48,075 | WARNING | job_aborted has been set - aborting pilot monitoring [2025-10-12 06:32:53] 2025-10-12 10:30:48,075 | INFO | [monitor] control thread has ended [2025-10-12 06:32:53] 2025-10-12 10:31:15,135 | INFO | [monitor] cgroup control has ended [2025-10-12 06:32:53] 2025-10-12 10:31:15,820 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:17,831 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:19,841 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:21,851 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:23,861 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:25,870 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:27,877 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:29,887 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:31,898 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:33,908 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:35,918 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:37,928 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:39,938 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:41,948 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:43,959 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:45,968 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:47,978 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:49,988 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:51,998 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:54,008 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:56,018 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:31:58,028 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:00,038 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:02,048 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:04,058 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:06,064 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:08,074 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:10,080 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:12,090 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:14,100 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:16,110 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:18,120 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:20,130 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:22,140 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:24,150 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:26,160 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:28,170 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:30,180 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:32,190 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:34,201 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:36,211 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:38,222 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:40,232 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:42,243 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:43,069 | INFO | proceeding with final server update [2025-10-12 06:32:53] 2025-10-12 10:32:43,070 | INFO | this job has now completed (state=failed) [2025-10-12 06:32:53] 2025-10-12 10:32:43,070 | INFO | pilot will not update the server (heartbeat message will be written to file) [2025-10-12 06:32:53] 2025-10-12 10:32:43,070 | INFO | log transfer has not been attempted: IN_PROGRESS [2025-10-12 06:32:53] 2025-10-12 10:32:43,070 | INFO | job 6838989802 has state 'failed' - writing heartbeat [2025-10-12 06:32:53] 2025-10-12 10:32:43,071 | INFO | total number of processed events: 400 (read) [2025-10-12 06:32:53] 2025-10-12 10:32:43,071 | INFO | executing command: lscpu [2025-10-12 06:32:53] 2025-10-12 10:32:43,120 | INFO | executing command: export ATLAS_LOCAL_ROOT_BASE=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase;source ${ATLAS_LOCAL_ROOT_BASE}/user/atlasLocalSetup.sh --quiet;lsetup [2025-10-12 06:32:53] 2025-10-12 10:32:44,253 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:46,263 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:46,473 | INFO | CPU arch script returned: x86-64-v2 [2025-10-12 06:32:53] 2025-10-12 10:32:46,495 | INFO | found 20 cores (10 cores per socket, 2 sockets) HT, CPU MHz: 3099.917375 [2025-10-12 06:32:53] 2025-10-12 10:32:46,511 | INFO | using path: /tmp/boinchome/slots/2/PanDA_Pilot-6838989802/memory_monitor_summary.json (trf name=prmon) [2025-10-12 06:32:53] 2025-10-12 10:32:46,511 | INFO | extracted standard info from prmon json [2025-10-12 06:32:53] 2025-10-12 10:32:46,511 | INFO | extracted standard memory fields from prmon json [2025-10-12 06:32:53] 2025-10-12 10:32:46,511 | WARNING | GPU info not found in prmon json: 'gpu' [2025-10-12 06:32:53] 2025-10-12 10:32:46,512 | WARNING | format EVNTtoHITS has no such key: dbData [2025-10-12 06:32:53] 2025-10-12 10:32:46,512 | WARNING | format EVNTtoHITS has no such key: dbTime [2025-10-12 06:32:53] 2025-10-12 10:32:46,514 | INFO | fitting pss+swap vs Time [2025-10-12 06:32:53] 2025-10-12 10:32:46,515 | INFO | sum of square deviations: 1444149868.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,515 | INFO | sum of deviations: 5130698288.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,515 | INFO | mean x: 1760259944.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,516 | INFO | mean y: 2495620.0718562873 [2025-10-12 06:32:53] 2025-10-12 10:32:46,516 | INFO | -- intersect: -6251261611.941252 [2025-10-12 06:32:53] 2025-10-12 10:32:46,516 | INFO | intersect: -6251261611.941252 [2025-10-12 06:32:53] 2025-10-12 10:32:46,516 | INFO | chi2: 1.9981066228225615 [2025-10-12 06:32:53] 2025-10-12 10:32:46,516 | INFO | sum of square deviations: 1318277740.5 [2025-10-12 06:32:53] 2025-10-12 10:32:46,517 | INFO | sum of deviations: 16069330772.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,517 | INFO | mean x: 1760259791.5 [2025-10-12 06:32:53] 2025-10-12 10:32:46,517 | INFO | mean y: 2508537.777777778 [2025-10-12 06:32:53] 2025-10-12 10:32:46,517 | INFO | -- intersect: -21454424220.21356 [2025-10-12 06:32:53] 2025-10-12 10:32:46,517 | INFO | intersect: -21454424220.21356 [2025-10-12 06:32:53] 2025-10-12 10:32:46,517 | INFO | chi2: 1.188111607295955 [2025-10-12 06:32:53] 2025-10-12 10:32:46,518 | INFO | current chi2=1.188111607295955 (change=40.53812775928808 %) [2025-10-12 06:32:53] 2025-10-12 10:32:46,518 | INFO | sum of square deviations: 1199940638.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,518 | INFO | sum of deviations: 15435389431.000002 [2025-10-12 06:32:53] 2025-10-12 10:32:46,519 | INFO | mean x: 1760259639.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,519 | INFO | mean y: 2507721.121019108 [2025-10-12 06:32:53] 2025-10-12 10:32:46,519 | INFO | -- intersect: -22640523248.246384 [2025-10-12 06:32:53] 2025-10-12 10:32:46,519 | INFO | intersect: -22640523248.246384 [2025-10-12 06:32:53] 2025-10-12 10:32:46,519 | INFO | chi2: 1.1890960503035428 [2025-10-12 06:32:53] 2025-10-12 10:32:46,519 | INFO | current chi2=1.1890960503035428 (change=-0.08285778890994362 %) [2025-10-12 06:32:53] 2025-10-12 10:32:46,519 | INFO | right removable region: 156 [2025-10-12 06:32:53] 2025-10-12 10:32:46,520 | INFO | sum of square deviations: 1318277740.5 [2025-10-12 06:32:53] 2025-10-12 10:32:46,520 | INFO | sum of deviations: -15397761642.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,520 | INFO | mean x: 1760260096.5 [2025-10-12 06:32:53] 2025-10-12 10:32:46,520 | INFO | mean y: 2520096.3827160494 [2025-10-12 06:32:53] 2025-10-12 10:32:46,521 | INFO | -- intersect: 20562728739.17662 [2025-10-12 06:32:53] 2025-10-12 10:32:46,521 | INFO | intersect: 20562728739.17662 [2025-10-12 06:32:53] 2025-10-12 10:32:46,521 | INFO | chi2: 0.8416340075744186 [2025-10-12 06:32:53] 2025-10-12 10:32:46,521 | INFO | current chi2=0.8416340075744186 (change=57.8784236055676 %) [2025-10-12 06:32:53] 2025-10-12 10:32:46,521 | INFO | sum of square deviations: 1199940638.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,522 | INFO | sum of deviations: -14860725633.000002 [2025-10-12 06:32:53] 2025-10-12 10:32:46,522 | INFO | mean x: 1760260249.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,522 | INFO | mean y: 2519399.4012738853 [2025-10-12 06:32:53] 2025-10-12 10:32:46,522 | INFO | -- intersect: 21802551646.550877 [2025-10-12 06:32:53] 2025-10-12 10:32:46,522 | INFO | intersect: 21802551646.550877 [2025-10-12 06:32:53] 2025-10-12 10:32:46,522 | INFO | chi2: 0.8420325857415515 [2025-10-12 06:32:53] 2025-10-12 10:32:46,522 | INFO | current chi2=0.8420325857415515 (change=-0.04735765945123159 %) [2025-10-12 06:32:53] 2025-10-12 10:32:46,523 | INFO | left removable region: 20 [2025-10-12 06:32:53] 2025-10-12 10:32:46,523 | INFO | sum of square deviations: 779958810.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,523 | INFO | sum of deviations: -2609168982.0 [2025-10-12 06:32:53] 2025-10-12 10:32:46,523 | INFO | mean x: 1760260218.5 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | mean y: 2531642.970588235 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | -- intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | chi2: 0.008513304203673213 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | -- intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | current memory leak: -3.35 B/s (using 136 data points, chi2=0.01) [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | could have reported an average CPU frequency of 3032 MHz (9 samples) [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | .............................. [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . Timing measurements: [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . get job = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . initial setup = 1 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . payload setup = 4 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . stage-in = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . payload execution = 10131 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . stage-out = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . log creation = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | .............................. [2025-10-12 06:32:53] 2025-10-12 10:32:46,526 | INFO | building log extracts (sent to the server as 'pilotLog') [2025-10-12 06:32:53] 2025-10-12 10:32:46,526 | INFO | executing command: tail -n 20 /tmp/boinchome/slots/2/PanDA_Pilot-6838989802/pilotlog.txt [2025-10-12 06:32:53] 2025-10-12 10:32:46,536 | WARNING | detected the following tail of warning/fatal messages in the pilot log: [2025-10-12 06:32:53] - Log from pilotlog.txt - [2025-10-12 06:32:53] 2025-10-12 10:32:46,523 | INFO | mean x: 1760260218.5 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | mean y: 2531642.970588235 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | -- intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | chi2: 0.008513304203673213 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | -- intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | current memory leak: -3.35 B/s (using 136 data points, chi2=0.01) [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | could have reported an average CPU frequency of 3032 MHz (9 samples) [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | .............................. [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . Timing measurements: [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . get job = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . initial setup = 1 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . payload setup = 4 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . stage-in = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . payload execution = 10131 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . stage-out = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . log creation = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | .............................. [2025-10-12 06:32:53] 2025-10-12 10:32:46,526 | INFO | building log extracts (sent to the server as 'pilotLog') [2025-10-12 06:32:53] 2025-10-12 10:32:46,526 | INFO | executing command: tail -n 20 /tmp/boinchome/slots/2/PanDA_Pilot-6838989802/pilotlog.txt [2025-10-12 06:32:53] 2025-10-12 10:32:46,536 | WARNING | [2025-10-12 06:32:53] [begin log extracts] [2025-10-12 06:32:53] - Log from pilotlog.txt - [2025-10-12 06:32:53] 2025-10-12 10:32:46,523 | INFO | mean x: 1760260218.5 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | mean y: 2531642.970588235 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | -- intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | chi2: 0.008513304203673213 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | -- intersect: 5891068708.612225 [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | current memory leak: -3.35 B/s (using 136 data points, chi2=0.01) [2025-10-12 06:32:53] 2025-10-12 10:32:46,524 | INFO | could have reported an average CPU frequency of 3032 MHz (9 samples) [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | .............................. [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . Timing measurements: [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . get job = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . initial setup = 1 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . payload setup = 4 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . stage-in = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . payload execution = 10131 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . stage-out = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | . log creation = 0 s [2025-10-12 06:32:53] 2025-10-12 10:32:46,525 | INFO | .............................. [2025-10-12 06:32:53] 2025-10-12 10:32:46,526 | INFO | building log extracts (sent to the server as 'pilotLog') [2025-10-12 06:32:53] 2025-10-12 10:32:46,526 | INFO | executing command: tail -n 20 /tmp/boinchome/slots/2/PanDA_Pilot-6838989802/pilotlog.txt [2025-10-12 06:32:53] [end log extracts] [2025-10-12 06:32:53] 2025-10-12 10:32:46,536 | WARNING | pilotErrorCodes = [1200] (will report primary/first error code) [2025-10-12 06:32:53] 2025-10-12 10:32:46,537 | WARNING | pilotErrorDiags = ['Job terminated by unknown kill signal'] (will report primary/first error diag) [2025-10-12 06:32:53] 2025-10-12 10:32:47,705 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140005050677056)>', '<ExcThread(queue_monitor, started 140004214941440)>'] [2025-10-12 06:32:53] 2025-10-12 10:32:47,705 | INFO | [job] queue monitor thread has finished [2025-10-12 06:32:53] 2025-10-12 10:32:48,273 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 140005050677056)>']) [2025-10-12 06:32:53] 2025-10-12 10:32:53,298 | INFO | all workflow threads have been joined [2025-10-12 06:32:53] 2025-10-12 10:32:53,298 | INFO | end of generic workflow (traces error code: 0) [2025-10-12 06:32:53] 2025-10-12 10:32:53,299 | INFO | traces error code: 0 [2025-10-12 06:32:53] 2025-10-12 10:32:53,299 | INFO | pilot has finished (exit code=0, shell exit code=0) [2025-10-12 06:32:53] 2025-10-12 10:32:53,410 [wrapper] ==== pilot stdout END ==== [2025-10-12 06:32:53] 2025-10-12 10:32:53,413 [wrapper] ==== wrapper stdout RESUME ==== [2025-10-12 06:32:53] 2025-10-12 10:32:53,415 [wrapper] pilotpid: 2904784 [2025-10-12 06:32:53] 2025-10-12 10:32:53,416 [wrapper] Pilot exit status: 0 [2025-10-12 06:32:53] 2025-10-12 10:32:53,423 [wrapper] pandaids: 6838989802 6838989802 [2025-10-12 06:32:53] 2025-10-12 10:32:53,483 [wrapper] cleanup supervisor_pilot 1023808 2904787 [2025-10-12 06:32:53] 2025-10-12 10:32:53,486 [wrapper] Test setup, not cleaning [2025-10-12 06:32:53] 2025-10-12 10:32:53,488 [wrapper] apfmon messages muted [2025-10-12 06:32:53] 2025-10-12 10:32:53,490 [wrapper] ==== wrapper stdout END ==== [2025-10-12 06:32:53] 2025-10-12 10:32:53,492 [wrapper] ==== wrapper stderr END ==== [2025-10-12 06:32:53] *** Error codes and diagnostics *** [2025-10-12 06:32:53] "exeErrorCode": 0, [2025-10-12 06:32:53] "exeErrorDiag": "", [2025-10-12 06:32:53] "pilotErrorCode": 1200, [2025-10-12 06:32:53] "pilotErrorDiag": "Job terminated by unknown kill signal", [2025-10-12 06:32:53] *** Listing of results directory *** [2025-10-12 06:32:53] total 635360 [2025-10-12 06:32:53] drwx------ 5 boincer umatlas 4096 Oct 7 03:00 pilot3 [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 557409 Oct 11 17:39 pilot3.tar.gz [2025-10-12 06:32:53] -rwx------ 1 boincer umatlas 36292 Oct 11 18:03 runpilot2-wrapper.sh [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 5112 Oct 11 18:03 queuedata.json [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 100 Oct 12 03:21 wrapper_26015_x86_64-pc-linux-gnu [2025-10-12 06:32:53] -rwxr-xr-x 1 boincer umatlas 7986 Oct 12 03:21 run_atlas [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 105 Oct 12 03:21 job.xml [2025-10-12 06:32:53] -rw-r--r-- 3 boincer umatlas 221690542 Oct 12 03:21 EVNT.46676267._002640.pool.root.1 [2025-10-12 06:32:53] -rw-r--r-- 3 boincer umatlas 221690542 Oct 12 03:21 ATLAS.root_0 [2025-10-12 06:32:53] -rw-r--r-- 2 boincer umatlas 15120 Oct 12 03:21 start_atlas.sh [2025-10-12 06:32:53] drwxrwx--x 2 boincer umatlas 4096 Oct 12 03:21 shared [2025-10-12 06:32:53] -rw-r--r-- 2 boincer umatlas 569677 Oct 12 03:21 input.tar.gz [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 0 Oct 12 03:21 boinc_lockfile [2025-10-12 06:32:53] drwxrwx--- 2 boincer umatlas 4096 Oct 12 03:40 tarball_PandaJob_6838989802_BOINC_MCORE [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 207280 Oct 12 03:40 log.46676269._065710.job.log.tgz.1 [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 2549 Oct 12 03:40 pandaJob.out [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 975520 Oct 12 03:40 agis_schedconf.cvmfs.json [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 531 Oct 12 06:29 boinc_task_state.xml [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 95 Oct 12 06:29 pilot_heartbeat.json [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 198812161 Oct 12 06:29 HITS.46676269._065710.pool.root.1 [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 1050 Oct 12 06:30 memory_monitor_summary.json [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 1560580 Oct 12 06:30 agis_ddmendpoints.agis.ALL.json [2025-10-12 06:32:53] drwxrwx--- 2 boincer umatlas 4096 Oct 12 06:30 PanDA_Pilot-6838989802 [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 6014 Oct 12 06:30 init_data.xml [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 8301 Oct 12 06:32 heartbeat.json [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 8192 Oct 12 06:32 boinc_mmap_file [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 28 Oct 12 06:32 wrapper_checkpoint.txt [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 1419675 Oct 12 06:32 pilotlog.txt [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 1434431 Oct 12 06:32 log.46676269._065710.job.log.1 [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 169 Oct 12 06:32 output.list [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 585 Oct 12 06:32 runtime_log [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 1454080 Oct 12 06:32 result.tar.gz [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 8444 Oct 12 06:32 runtime_log.err [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 784 Oct 12 06:32 3VoMDm3rwR8n9Rq4apOajLDm4fhM0noT9bVof3QYDmpfSMDmhGtYBn.diag [2025-10-12 06:32:53] -rw-r--r-- 1 boincer umatlas 28636 Oct 12 06:32 stderr.txt [2025-10-12 06:32:53] HITS file was successfully produced: [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 198812161 Oct 12 06:29 shared/HITS.pool.root.1 [2025-10-12 06:32:53] *** Contents of shared directory: *** [2025-10-12 06:32:53] total 412652 [2025-10-12 06:32:53] -rw-r--r-- 3 boincer umatlas 221690542 Oct 12 03:21 ATLAS.root_0 [2025-10-12 06:32:53] -rw-r--r-- 2 boincer umatlas 15120 Oct 12 03:21 start_atlas.sh [2025-10-12 06:32:53] -rw-r--r-- 2 boincer umatlas 569677 Oct 12 03:21 input.tar.gz [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 198812161 Oct 12 06:29 HITS.pool.root.1 [2025-10-12 06:32:53] -rw------- 1 boincer umatlas 1454080 Oct 12 06:32 result.tar.gz 06:32:55 (2886068): run_atlas exited; CPU time 75091.905782 06:32:55 (2886068): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN