| Name | Theory_2390-1087813-272_1 |
| Workunit | 2198016 |
| Created | 4 Aug 2022, 16:39:26 UTC |
| Sent | 6 Aug 2022, 19:16:52 UTC |
| Report deadline | 16 Aug 2022, 19:16:52 UTC |
| Received | 17 Aug 2022, 6:39:53 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 0 (0x00000000) |
| Computer ID | 1361 |
| Run time | 10 days 0 hours 27 min 44 sec |
| CPU time | 9 days 21 hours 46 min 41 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 4.99 GFLOPS |
| Application version | Theory Simulation v5.40 (vbox64_theory) windows_x86_64 |
| Peak working set size | 92.70 MB |
| Peak swap size | 108.09 MB |
| Peak disk usage | 1.72 GB |
Stderr output
<core_client_version>7.20.2</core_client_version> <![CDATA[ <stderr_txt> 2022-08-06 21:16:54 (19940): Detected: vboxwrapper 26205 2022-08-06 21:16:54 (19940): Detected: BOINC client v7.20.2 2022-08-06 21:16:55 (19940): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2022-08-06 21:16:55 (19940): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-08-06 21:16:55 (19940): Successfully copied 'init_data.xml' to the shared directory. 2022-08-06 21:16:55 (19940): Successfully copied 'input' to the shared directory. 2022-08-06 21:16:56 (19940): Create VM. (boinc_945a30f0f96e6fc9, slot#2) 2022-08-06 21:16:56 (19940): Setting Memory Size for VM. (630MB) 2022-08-06 21:16:56 (19940): Setting CPU Count for VM. (1) 2022-08-06 21:16:57 (19940): Setting Chipset Options for VM. 2022-08-06 21:16:57 (19940): Setting Graphics Controller Options for VM. 2022-08-06 21:16:57 (19940): Setting Boot Options for VM. 2022-08-06 21:16:57 (19940): Setting Network Configuration for NAT. 2022-08-06 21:16:58 (19940): Enabling VM Network Access. 2022-08-06 21:16:58 (19940): Disabling USB Support for VM. 2022-08-06 21:16:58 (19940): Disabling COM Port Support for VM. 2022-08-06 21:16:59 (19940): Disabling LPT Port Support for VM. 2022-08-06 21:16:59 (19940): Disabling Audio Support for VM. 2022-08-06 21:16:59 (19940): Disabling Clipboard Support for VM. 2022-08-06 21:16:59 (19940): Disabling Drag and Drop Support for VM. 2022-08-06 21:17:00 (19940): Adding storage controller(s) to VM. 2022-08-06 21:17:00 (19940): Adding virtual disk drive to VM. (Theory_2022_07_28.vdi) 2022-08-06 21:17:00 (19940): Adding VirtualBox Guest Additions to VM. 2022-08-06 21:17:01 (19940): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2022-08-06 21:17:01 (19940): forwarding host port 57106 to guest port 80 2022-08-06 21:17:01 (19940): Enabling remote desktop for VM. 2022-08-06 21:17:02 (19940): Enabling shared directory for VM. 2022-08-06 21:17:03 (19940): Starting VM using VBoxManage interface. (boinc_945a30f0f96e6fc9, slot#2) 2022-08-06 21:17:10 (19940): Successfully started VM. (PID = '20740') 2022-08-06 21:17:10 (19940): Reporting VM Process ID to BOINC. 2022-08-06 21:17:10 (19940): Guest Log: BIOS: VirtualBox 6.1.36 2022-08-06 21:17:10 (19940): Guest Log: CPUID EDX: 0x178bfbff 2022-08-06 21:17:10 (19940): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-08-06 21:17:10 (19940): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-08-06 21:17:10 (19940): VM state change detected. (old = 'poweredoff', new = 'running') 2022-08-06 21:17:10 (19940): Detected: Web Application Enabled (http://localhost:57106) 2022-08-06 21:17:10 (19940): Detected: Remote Desktop Enabled (localhost:57107) 2022-08-06 21:17:10 (19940): Preference change detected 2022-08-06 21:17:10 (19940): Setting CPU throttle for VM. (100%) 2022-08-06 21:17:11 (19940): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-06 21:17:12 (19940): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-08-06 21:17:13 (19940): Guest Log: BIOS: Booting from Hard Disk... 2022-08-06 21:17:16 (19940): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-08-06 21:17:16 (19940): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-08-06 21:17:38 (19940): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-08-06 21:17:38 (19940): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-08-06 21:17:43 (19940): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.000289 main Log opened 2022-08-06T19:17:44.586296000Z 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.004917 main OS Product: Linux 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.005032 main OS Release: 4.14.76-13.cernvm.x86_64 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.005073 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.005126 main Executable: /usr/sbin/VBoxService 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.005128 main Process ID: 3219 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.005129 main Package type: LINUX_64BITS_GENERIC 2022-08-06 21:17:43 (19940): Guest Log: 00:00:00.009036 main 5.2.6 r120293 started. Verbose level = 0 2022-08-06 21:18:07 (19940): Guest Log: 21:18:08 CEST +02:00 2022-08-06: cranky: [INFO] Detected Theory App 2022-08-06 21:18:07 (19940): Guest Log: 21:18:08 CEST +02:00 2022-08-06: cranky: [INFO] Checking CVMFS. 2022-08-06 21:18:08 (19940): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-08-06 21:18:09 (19940): 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 2022-08-06 21:18:09 (19940): Guest Log: 2.5.2.0 4056 0 28436 23527 3 1 265171 4096000 0 65024 0 0 n/a 5 15 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-08-06 21:18:10 (19940): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-08-06 21:18:11 (19940): 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 2022-08-06 21:18:11 (19940): Guest Log: 2.5.2.0 4098 0 27424 18919 3 2 265171 4096000 0 65024 0 2 -100 7753 5110 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-08-06 21:18:12 (19940): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-08-06 21:18:13 (19940): 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 2022-08-06 21:18:13 (19940): Guest Log: 2.5.2.0 4078 0 25184 268 3 1 265171 4096000 0 65024 0 0 n/a 4 6 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-08-06 21:18:14 (19940): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-08-06 21:18:15 (19940): 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 2022-08-06 21:18:15 (19940): Guest Log: 2.5.2.0 4125 0 34540 13009 3 1 265171 4096000 0 65024 0 0 n/a 2921 5693 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-08-06 21:18:15 (19940): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Checking runc. 2022-08-06 21:18:15 (19940): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Creating the filesystem. 2022-08-06 21:18:15 (19940): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-08-06 21:18:15 (19940): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Updating config.json. 2022-08-06 21:18:15 (19940): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Running Container 'runc'. 2022-08-06 21:18:17 (19940): Guest Log: job: htmld=/shared/html/job 2022-08-06 21:18:17 (19940): Guest Log: job: unpack exitcode=0 2022-08-06 21:18:17 (19940): Guest Log: 21:18:19 CEST +02:00 2022-08-06: cranky: [INFO] ===> [runRivet] Sat Aug 6 19:18:18 UTC 2022 [boinc ppbar jets 1960 100,1960,10,1960 - sherpa 1.4.0 default 100000 272] 2022-08-06 22:57:16 (19940): Status Report: Job Duration: '864000.000000' 2022-08-06 22:57:16 (19940): Status Report: Elapsed Time: '6000.000000' 2022-08-06 22:57:16 (19940): Status Report: CPU Time: '5845.781250' 2022-08-07 00:04:30 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 00:05:04 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 00:38:00 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 00:38:00 (19940): Status Report: Elapsed Time: '12000.000000' 2022-08-07 00:38:00 (19940): Status Report: CPU Time: '11829.593750' 2022-08-07 02:18:06 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 02:18:06 (19940): Status Report: Elapsed Time: '18000.000000' 2022-08-07 02:18:06 (19940): Status Report: CPU Time: '17822.625000' 2022-08-07 03:58:12 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 03:58:12 (19940): Status Report: Elapsed Time: '24000.000000' 2022-08-07 03:58:12 (19940): Status Report: CPU Time: '23812.000000' 2022-08-07 05:38:18 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 05:38:18 (19940): Status Report: Elapsed Time: '30000.000000' 2022-08-07 05:38:18 (19940): Status Report: CPU Time: '29804.390625' 2022-08-07 07:18:24 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 07:18:24 (19940): Status Report: Elapsed Time: '36000.000000' 2022-08-07 07:18:24 (19940): Status Report: CPU Time: '35796.187500' 2022-08-07 08:58:30 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 08:58:30 (19940): Status Report: Elapsed Time: '42000.000000' 2022-08-07 08:58:30 (19940): Status Report: CPU Time: '41788.734375' 2022-08-07 10:38:36 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 10:38:36 (19940): Status Report: Elapsed Time: '48000.000000' 2022-08-07 10:38:36 (19940): Status Report: CPU Time: '47782.296875' 2022-08-07 12:18:42 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 12:18:42 (19940): Status Report: Elapsed Time: '54000.000000' 2022-08-07 12:18:42 (19940): Status Report: CPU Time: '53774.156250' 2022-08-07 13:58:48 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 13:58:48 (19940): Status Report: Elapsed Time: '60000.000000' 2022-08-07 13:58:48 (19940): Status Report: CPU Time: '59764.750000' 2022-08-07 14:27:38 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 15:53:19 (19940): Preference change detected 2022-08-07 15:53:19 (19940): Setting CPU throttle for VM. (100%) 2022-08-07 15:53:19 (19940): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-07 15:53:19 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 15:53:24 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 18:54:39 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 18:54:40 (19940): Guest Log: 17:09:50.003539 timesync vgsvcTimeSyncWorker: Radical host time change: 16 025 773 000 000ns (HostNow=1 659 891 279 921 000 000 ns HostLast=1 659 875 254 148 000 000 ns) 2022-08-07 18:54:50 (19940): Guest Log: 17:10:00.016723 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 035 405 660 000ns (GuestNow=1 659 891 289 959 240 000 ns GuestLast=1 659 875 254 553 580 000 ns fSetTimeLastLoop=true ) 2022-08-07 19:02:06 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 19:02:43 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 19:03:02 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 19:06:05 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 19:22:55 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 19:23:31 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 19:24:43 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 19:25:34 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 19:27:17 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 19:28:05 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 19:28:59 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 19:34:30 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 19:41:15 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 19:41:36 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 19:58:46 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 20:20:35 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 20:20:45 (19940): Guest Log: 18:02:20.901201 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 024 200 498 000ns (GuestNow=1 659 896 445 043 107 000 ns GuestLast=1 659 894 420 842 609 000 ns fSetTimeLastLoop=true ) 2022-08-07 20:39:36 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 20:39:36 (19940): Status Report: Elapsed Time: '66000.000000' 2022-08-07 20:39:36 (19940): Status Report: CPU Time: '65756.078125' 2022-08-07 21:49:44 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 21:50:11 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 21:59:35 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 21:59:58 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 22:03:43 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-07 22:07:06 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-07 22:23:58 (19940): Status Report: Job Duration: '864000.000000' 2022-08-07 22:23:58 (19940): Status Report: Elapsed Time: '72000.000000' 2022-08-07 22:23:58 (19940): Status Report: CPU Time: '71727.937500' 2022-08-08 00:04:05 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 00:04:05 (19940): Status Report: Elapsed Time: '78000.000000' 2022-08-08 00:04:05 (19940): Status Report: CPU Time: '77681.625000' 2022-08-08 01:44:13 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 01:44:13 (19940): Status Report: Elapsed Time: '84000.000000' 2022-08-08 01:44:13 (19940): Status Report: CPU Time: '83657.250000' 2022-08-08 03:24:19 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 03:24:19 (19940): Status Report: Elapsed Time: '90000.000000' 2022-08-08 03:24:19 (19940): Status Report: CPU Time: '89642.156250' 2022-08-08 05:04:26 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 05:04:26 (19940): Status Report: Elapsed Time: '96000.000000' 2022-08-08 05:04:26 (19940): Status Report: CPU Time: '95627.234375' 2022-08-08 06:34:23 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-08 07:29:17 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-08 07:29:19 (19940): Guest Log: 28:12:00.689544 timesync vgsvcTimeSyncWorker: Radical host time change: 3 304 425 000 000ns (HostNow=1 659 936 559 317 000 000 ns HostLast=1 659 933 254 892 000 000 ns) 2022-08-08 07:29:29 (19940): Guest Log: 28:12:10.693967 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 544 490 009 000ns (GuestNow=1 659 936 569 321 439 000 ns GuestLast=1 659 933 024 831 430 000 ns fSetTimeLastLoop=true ) 2022-08-08 07:39:27 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 07:39:27 (19940): Status Report: Elapsed Time: '102000.000000' 2022-08-08 07:39:27 (19940): Status Report: CPU Time: '101599.328125' 2022-08-08 09:19:33 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 09:19:33 (19940): Status Report: Elapsed Time: '108000.000000' 2022-08-08 09:19:33 (19940): Status Report: CPU Time: '107526.718750' 2022-08-08 10:59:39 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 10:59:39 (19940): Status Report: Elapsed Time: '114000.000000' 2022-08-08 10:59:39 (19940): Status Report: CPU Time: '113505.078125' 2022-08-08 12:39:45 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 12:39:45 (19940): Status Report: Elapsed Time: '120000.000000' 2022-08-08 12:39:45 (19940): Status Report: CPU Time: '119489.781250' 2022-08-08 14:19:51 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 14:19:51 (19940): Status Report: Elapsed Time: '126000.000000' 2022-08-08 14:19:51 (19940): Status Report: CPU Time: '125474.625000' 2022-08-08 15:59:57 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 15:59:57 (19940): Status Report: Elapsed Time: '132000.000000' 2022-08-08 15:59:57 (19940): Status Report: CPU Time: '131459.281250' 2022-08-08 17:40:03 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 17:40:03 (19940): Status Report: Elapsed Time: '138000.000000' 2022-08-08 17:40:03 (19940): Status Report: CPU Time: '137447.312500' 2022-08-08 19:20:09 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 19:20:09 (19940): Status Report: Elapsed Time: '144000.000000' 2022-08-08 19:20:09 (19940): Status Report: CPU Time: '143436.000000' 2022-08-08 21:00:15 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 21:00:15 (19940): Status Report: Elapsed Time: '150000.000000' 2022-08-08 21:00:15 (19940): Status Report: CPU Time: '149427.046875' 2022-08-08 22:26:48 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-08 22:27:10 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-08 22:40:44 (19940): Status Report: Job Duration: '864000.000000' 2022-08-08 22:40:44 (19940): Status Report: Elapsed Time: '156000.000000' 2022-08-08 22:40:44 (19940): Status Report: CPU Time: '155413.140625' 2022-08-09 00:20:51 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 00:20:51 (19940): Status Report: Elapsed Time: '162000.000000' 2022-08-09 00:20:51 (19940): Status Report: CPU Time: '161326.687500' 2022-08-09 02:00:59 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 02:00:59 (19940): Status Report: Elapsed Time: '168000.000000' 2022-08-09 02:00:59 (19940): Status Report: CPU Time: '167282.203125' 2022-08-09 03:41:05 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 03:41:05 (19940): Status Report: Elapsed Time: '174000.000000' 2022-08-09 03:41:05 (19940): Status Report: CPU Time: '173272.078125' 2022-08-09 05:21:11 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 05:21:11 (19940): Status Report: Elapsed Time: '180000.000000' 2022-08-09 05:21:11 (19940): Status Report: CPU Time: '179249.781250' 2022-08-09 07:01:17 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 07:01:17 (19940): Status Report: Elapsed Time: '186000.000000' 2022-08-09 07:01:17 (19940): Status Report: CPU Time: '185235.656250' 2022-08-09 07:46:30 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-09 07:47:04 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-09 08:41:59 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 08:41:59 (19940): Status Report: Elapsed Time: '192000.000000' 2022-08-09 08:41:59 (19940): Status Report: CPU Time: '191188.265625' 2022-08-09 10:22:05 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 10:22:05 (19940): Status Report: Elapsed Time: '198000.000000' 2022-08-09 10:22:05 (19940): Status Report: CPU Time: '197127.484375' 2022-08-09 12:02:11 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 12:02:11 (19940): Status Report: Elapsed Time: '204000.000000' 2022-08-09 12:02:11 (19940): Status Report: CPU Time: '203114.578125' 2022-08-09 13:42:17 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 13:42:17 (19940): Status Report: Elapsed Time: '210000.000000' 2022-08-09 13:42:17 (19940): Status Report: CPU Time: '209117.250000' 2022-08-09 15:22:23 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 15:22:23 (19940): Status Report: Elapsed Time: '216000.000000' 2022-08-09 15:22:23 (19940): Status Report: CPU Time: '215119.578125' 2022-08-09 17:02:29 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 17:02:29 (19940): Status Report: Elapsed Time: '222000.000000' 2022-08-09 17:02:29 (19940): Status Report: CPU Time: '221120.453125' 2022-08-09 18:42:34 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 18:42:34 (19940): Status Report: Elapsed Time: '228000.000000' 2022-08-09 18:42:34 (19940): Status Report: CPU Time: '227122.812500' 2022-08-09 20:22:40 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 20:22:40 (19940): Status Report: Elapsed Time: '234000.000000' 2022-08-09 20:22:40 (19940): Status Report: CPU Time: '233126.734375' 2022-08-09 21:54:39 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-09 21:55:02 (19940): VM state change detected. (old = 'paused', new = 'running') 2022-08-09 22:03:10 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 22:03:10 (19940): Status Report: Elapsed Time: '240000.000000' 2022-08-09 22:03:10 (19940): Status Report: CPU Time: '239114.625000' 2022-08-09 23:43:20 (19940): Status Report: Job Duration: '864000.000000' 2022-08-09 23:43:20 (19940): Status Report: Elapsed Time: '246000.839626' 2022-08-09 23:43:20 (19940): Status Report: CPU Time: '245011.625000' 2022-08-10 01:23:26 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 01:23:26 (19940): Status Report: Elapsed Time: '252000.839626' 2022-08-10 01:23:26 (19940): Status Report: CPU Time: '251007.875000' 2022-08-10 03:03:32 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 03:03:32 (19940): Status Report: Elapsed Time: '258000.839626' 2022-08-10 03:03:32 (19940): Status Report: CPU Time: '257007.593750' 2022-08-10 04:43:38 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 04:43:38 (19940): Status Report: Elapsed Time: '264000.839626' 2022-08-10 04:43:38 (19940): Status Report: CPU Time: '263008.796875' 2022-08-10 06:23:44 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 06:23:44 (19940): Status Report: Elapsed Time: '270000.839626' 2022-08-10 06:23:44 (19940): Status Report: CPU Time: '269009.781250' 2022-08-10 08:03:49 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 08:03:49 (19940): Status Report: Elapsed Time: '276000.839626' 2022-08-10 08:03:49 (19940): Status Report: CPU Time: '275010.593750' 2022-08-10 09:43:55 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 09:43:55 (19940): Status Report: Elapsed Time: '282000.839626' 2022-08-10 09:43:55 (19940): Status Report: CPU Time: '281011.671875' 2022-08-10 11:24:01 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 11:24:01 (19940): Status Report: Elapsed Time: '288000.839626' 2022-08-10 11:24:01 (19940): Status Report: CPU Time: '287011.953125' 2022-08-10 13:04:07 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 13:04:07 (19940): Status Report: Elapsed Time: '294000.839626' 2022-08-10 13:04:07 (19940): Status Report: CPU Time: '293014.843750' 2022-08-10 14:44:13 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 14:44:13 (19940): Status Report: Elapsed Time: '300000.839626' 2022-08-10 14:44:13 (19940): Status Report: CPU Time: '299015.765625' 2022-08-10 16:24:19 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 16:24:19 (19940): Status Report: Elapsed Time: '306000.839626' 2022-08-10 16:24:19 (19940): Status Report: CPU Time: '305016.875000' 2022-08-10 18:04:25 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 18:04:25 (19940): Status Report: Elapsed Time: '312000.839626' 2022-08-10 18:04:25 (19940): Status Report: CPU Time: '311021.078125' 2022-08-10 19:44:31 (19940): Status Report: Job Duration: '864000.000000' 2022-08-10 19:44:31 (19940): Status Report: Elapsed Time: '318000.839626' 2022-08-10 19:44:31 (19940): Status Report: CPU Time: '317022.171875' 2022-08-10 21:07:01 (19940): VM state change detected. (old = 'running', new = 'paused') 2022-08-10 21:07:08 (19940): Stopping VM. 2022-08-10 21:07:10 (19940): Successfully stopped VM. 2022-08-10 21:11:15 (15876): Detected: vboxwrapper 26205 2022-08-10 21:11:16 (15876): Detected: BOINC client v7.20.2 2022-08-10 21:11:17 (15876): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2022-08-10 21:11:17 (15876): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-08-10 21:11:18 (15876): Guest Log: BIOS: VirtualBox 6.1.36 2022-08-10 21:11:18 (15876): Guest Log: CPUID EDX: 0x178bfbff 2022-08-10 21:11:18 (15876): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2022-08-10 21:11:18 (15876): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-08-10 21:11:18 (15876): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-08-10 21:11:18 (15876): Guest Log: BIOS: Booting from Hard Disk... 2022-08-10 21:11:18 (15876): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-08-10 21:11:18 (15876): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-08-10 21:11:18 (15876): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-08-10 21:11:18 (15876): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-08-10 21:11:18 (15876): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.000289 main Log opened 2022-08-06T19:17:44.586296000Z 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.004917 main OS Product: Linux 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.005032 main OS Release: 4.14.76-13.cernvm.x86_64 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.005073 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.005126 main Executable: /usr/sbin/VBoxService 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.005128 main Process ID: 3219 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.005129 main Package type: LINUX_64BITS_GENERIC 2022-08-10 21:11:18 (15876): Guest Log: 00:00:00.009036 main 5.2.6 r120293 started. Verbose level = 0 2022-08-10 21:11:18 (15876): Guest Log: 21:18:08 CEST +02:00 2022-08-06: cranky: [INFO] Detected Theory App 2022-08-10 21:11:18 (15876): Guest Log: 21:18:08 CEST +02:00 2022-08-06: cranky: [INFO] Checking CVMFS. 2022-08-10 21:11:18 (15876): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2022-08-10 21:11:18 (15876): 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 2022-08-10 21:11:18 (15876): Guest Log: 2.5.2.0 4056 0 28436 23527 3 1 265171 4096000 0 65024 0 0 n/a 5 15 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2022-08-10 21:11:18 (15876): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2022-08-10 21:11:18 (15876): 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 2022-08-10 21:11:18 (15876): Guest Log: 2.5.2.0 4098 0 27424 18919 3 2 265171 4096000 0 65024 0 2 -100 7753 5110 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2022-08-10 21:11:18 (15876): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2022-08-10 21:11:18 (15876): 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 2022-08-10 21:11:18 (15876): Guest Log: 2.5.2.0 4078 0 25184 268 3 1 265171 4096000 0 65024 0 0 n/a 4 6 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2022-08-10 21:11:18 (15876): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2022-08-10 21:11:18 (15876): 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 2022-08-10 21:11:18 (15876): Guest Log: 2.5.2.0 4125 0 34540 13009 3 1 265171 4096000 0 65024 0 0 n/a 2921 5693 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2022-08-10 21:11:18 (15876): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Checking runc. 2022-08-10 21:11:18 (15876): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Creating the filesystem. 2022-08-10 21:11:18 (15876): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2022-08-10 21:11:18 (15876): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Updating config.json. 2022-08-10 21:11:18 (15876): Guest Log: 21:18:16 CEST +02:00 2022-08-06: cranky: [INFO] Running Container 'runc'. 2022-08-10 21:11:18 (15876): Guest Log: job: htmld=/shared/html/job 2022-08-10 21:11:18 (15876): Guest Log: job: unpack exitcode=0 2022-08-10 21:11:18 (15876): Guest Log: 21:18:19 CEST +02:00 2022-08-06: cranky: [INFO] ===> [runRivet] Sat Aug 6 19:18:18 UTC 2022 [boinc ppbar jets 1960 100,1960,10,1960 - sherpa 1.4.0 default 100000 272] 2022-08-10 21:11:18 (15876): Guest Log: 17:09:50.003539 timesync vgsvcTimeSyncWorker: Radical host time change: 16 025 773 000 000ns (HostNow=1 659 891 279 921 000 000 ns HostLast=1 659 875 254 148 000 000 ns) 2022-08-10 21:11:18 (15876): Guest Log: 17:10:00.016723 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 035 405 660 000ns (GuestNow=1 659 891 289 959 240 000 ns GuestLast=1 659 875 254 553 580 000 ns fSetTimeLastLoop=true ) 2022-08-10 21:11:18 (15876): Guest Log: 18:02:20.901201 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 024 200 498 000ns (GuestNow=1 659 896 445 043 107 000 ns GuestLast=1 659 894 420 842 609 000 ns fSetTimeLastLoop=true ) 2022-08-10 21:11:18 (15876): Guest Log: 28:12:00.689544 timesync vgsvcTimeSyncWorker: Radical host time change: 3 304 425 000 000ns (HostNow=1 659 936 559 317 000 000 ns HostLast=1 659 933 254 892 000 000 ns) 2022-08-10 21:11:18 (15876): Guest Log: 28:12:10.693967 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 544 490 009 000ns (GuestNow=1 659 936 569 321 439 000 ns GuestLast=1 659 933 024 831 430 000 ns fSetTimeLastLoop=true ) 2022-08-10 21:11:18 (15876): Starting VM using VBoxManage interface. (boinc_945a30f0f96e6fc9, slot#2) 2022-08-10 21:11:30 (15876): Successfully started VM. (PID = '13776') 2022-08-10 21:11:30 (15876): Reporting VM Process ID to BOINC. 2022-08-10 21:11:30 (15876): VM state change detected. (old = 'poweredoff', new = 'running') 2022-08-10 21:11:30 (15876): Detected: Web Application Enabled (http://localhost:57106) 2022-08-10 21:11:30 (15876): Detected: Remote Desktop Enabled (localhost:57107) 2022-08-10 21:11:31 (15876): VM state change detected. (old = 'running', new = 'paused') 2022-08-10 22:28:51 (15876): Status Report: Job Duration: '864000.000000' 2022-08-10 22:28:51 (15876): Status Report: Elapsed Time: '322943.839626' 2022-08-10 22:28:51 (15876): Status Report: CPU Time: '321969.796875' 2022-08-10 22:28:51 (15876): Preference change detected 2022-08-10 22:28:51 (15876): Setting CPU throttle for VM. (100%) 2022-08-10 22:28:51 (15876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-10 22:28:52 (15876): VM state change detected. (old = 'paused', new = 'running') 2022-08-10 22:28:59 (15876): Guest Log: 89:49:50.455203 timesync vgsvcTimeSyncWorker: Radical host time change: 4 919 687 000 000ns (HostNow=1 660 163 338 753 000 000 ns HostLast=1 660 158 419 066 000 000 ns) 2022-08-10 22:29:09 (15876): Guest Log: 89:50:00.456558 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 919 698 758 000ns (GuestNow=1 660 163 348 767 888 000 ns GuestLast=1 660 158 429 069 130 000 ns fSetTimeLastLoop=true ) 2022-08-11 00:08:58 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 00:08:58 (15876): Status Report: Elapsed Time: '328943.839626' 2022-08-11 00:08:58 (15876): Status Report: CPU Time: '327965.859375' 2022-08-11 01:49:04 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 01:49:04 (15876): Status Report: Elapsed Time: '334943.839626' 2022-08-11 01:49:04 (15876): Status Report: CPU Time: '333962.031250' 2022-08-11 03:29:10 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 03:29:10 (15876): Status Report: Elapsed Time: '340943.839626' 2022-08-11 03:29:10 (15876): Status Report: CPU Time: '339961.218750' 2022-08-11 05:09:17 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 05:09:17 (15876): Status Report: Elapsed Time: '346943.839626' 2022-08-11 05:09:17 (15876): Status Report: CPU Time: '345961.203125' 2022-08-11 06:49:23 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 06:49:23 (15876): Status Report: Elapsed Time: '352943.839626' 2022-08-11 06:49:23 (15876): Status Report: CPU Time: '351959.562500' 2022-08-11 08:29:29 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 08:29:29 (15876): Status Report: Elapsed Time: '358943.839626' 2022-08-11 08:29:29 (15876): Status Report: CPU Time: '357964.046875' 2022-08-11 10:09:35 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 10:09:35 (15876): Status Report: Elapsed Time: '364943.839626' 2022-08-11 10:09:35 (15876): Status Report: CPU Time: '363970.109375' 2022-08-11 11:49:41 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 11:49:41 (15876): Status Report: Elapsed Time: '370943.839626' 2022-08-11 11:49:41 (15876): Status Report: CPU Time: '369975.484375' 2022-08-11 13:29:47 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 13:29:47 (15876): Status Report: Elapsed Time: '376943.839626' 2022-08-11 13:29:47 (15876): Status Report: CPU Time: '375971.515625' 2022-08-11 15:09:54 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 15:09:54 (15876): Status Report: Elapsed Time: '382943.839626' 2022-08-11 15:09:54 (15876): Status Report: CPU Time: '381922.359375' 2022-08-11 16:50:00 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 16:50:00 (15876): Status Report: Elapsed Time: '388943.839626' 2022-08-11 16:50:00 (15876): Status Report: CPU Time: '387861.062500' 2022-08-11 18:30:08 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 18:30:08 (15876): Status Report: Elapsed Time: '394943.839626' 2022-08-11 18:30:08 (15876): Status Report: CPU Time: '393794.843750' 2022-08-11 20:10:14 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 20:10:14 (15876): Status Report: Elapsed Time: '400943.839626' 2022-08-11 20:10:14 (15876): Status Report: CPU Time: '399734.765625' 2022-08-11 21:50:21 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 21:50:21 (15876): Status Report: Elapsed Time: '406943.839626' 2022-08-11 21:50:21 (15876): Status Report: CPU Time: '405706.171875' 2022-08-11 23:30:31 (15876): Status Report: Job Duration: '864000.000000' 2022-08-11 23:30:31 (15876): Status Report: Elapsed Time: '412943.839626' 2022-08-11 23:30:31 (15876): Status Report: CPU Time: '411708.734375' 2022-08-12 01:10:38 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 01:10:38 (15876): Status Report: Elapsed Time: '418943.839626' 2022-08-12 01:10:38 (15876): Status Report: CPU Time: '417710.281250' 2022-08-12 02:50:45 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 02:50:45 (15876): Status Report: Elapsed Time: '424943.839626' 2022-08-12 02:50:45 (15876): Status Report: CPU Time: '423709.671875' 2022-08-12 04:30:52 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 04:30:52 (15876): Status Report: Elapsed Time: '430943.839626' 2022-08-12 04:30:52 (15876): Status Report: CPU Time: '429707.171875' 2022-08-12 06:11:01 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 06:11:01 (15876): Status Report: Elapsed Time: '436943.839626' 2022-08-12 06:11:01 (15876): Status Report: CPU Time: '435626.375000' 2022-08-12 07:51:07 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 07:51:07 (15876): Status Report: Elapsed Time: '442943.839626' 2022-08-12 07:51:07 (15876): Status Report: CPU Time: '441543.640625' 2022-08-12 09:31:14 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 09:31:14 (15876): Status Report: Elapsed Time: '448943.839626' 2022-08-12 09:31:14 (15876): Status Report: CPU Time: '447469.734375' 2022-08-12 11:11:20 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 11:11:20 (15876): Status Report: Elapsed Time: '454943.839626' 2022-08-12 11:11:20 (15876): Status Report: CPU Time: '453400.703125' 2022-08-12 12:51:27 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 12:51:27 (15876): Status Report: Elapsed Time: '460943.839626' 2022-08-12 12:51:27 (15876): Status Report: CPU Time: '459321.781250' 2022-08-12 14:31:33 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 14:31:33 (15876): Status Report: Elapsed Time: '466943.839626' 2022-08-12 14:31:33 (15876): Status Report: CPU Time: '465245.687500' 2022-08-12 16:11:40 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 16:11:40 (15876): Status Report: Elapsed Time: '472943.839626' 2022-08-12 16:11:40 (15876): Status Report: CPU Time: '471181.281250' 2022-08-12 17:51:46 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 17:51:46 (15876): Status Report: Elapsed Time: '478943.839626' 2022-08-12 17:51:46 (15876): Status Report: CPU Time: '477111.656250' 2022-08-12 19:31:53 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 19:31:53 (15876): Status Report: Elapsed Time: '484943.839626' 2022-08-12 19:31:53 (15876): Status Report: CPU Time: '483040.046875' 2022-08-12 21:12:00 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 21:12:00 (15876): Status Report: Elapsed Time: '490943.839626' 2022-08-12 21:12:00 (15876): Status Report: CPU Time: '488970.359375' 2022-08-12 22:52:06 (15876): Status Report: Job Duration: '864000.000000' 2022-08-12 22:52:06 (15876): Status Report: Elapsed Time: '496943.839626' 2022-08-12 22:52:06 (15876): Status Report: CPU Time: '494974.281250' 2022-08-13 00:32:15 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 00:32:15 (15876): Status Report: Elapsed Time: '502943.839626' 2022-08-13 00:32:15 (15876): Status Report: CPU Time: '500923.546875' 2022-08-13 02:12:22 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 02:12:22 (15876): Status Report: Elapsed Time: '508943.839626' 2022-08-13 02:12:22 (15876): Status Report: CPU Time: '506844.250000' 2022-08-13 03:52:29 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 03:52:29 (15876): Status Report: Elapsed Time: '514943.839626' 2022-08-13 03:52:29 (15876): Status Report: CPU Time: '512775.734375' 2022-08-13 05:32:37 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 05:32:37 (15876): Status Report: Elapsed Time: '520943.839626' 2022-08-13 05:32:37 (15876): Status Report: CPU Time: '518688.156250' 2022-08-13 07:12:44 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 07:12:44 (15876): Status Report: Elapsed Time: '526943.839626' 2022-08-13 07:12:44 (15876): Status Report: CPU Time: '524609.250000' 2022-08-13 08:52:51 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 08:52:51 (15876): Status Report: Elapsed Time: '532943.839626' 2022-08-13 08:52:51 (15876): Status Report: CPU Time: '530534.796875' 2022-08-13 10:32:58 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 10:32:58 (15876): Status Report: Elapsed Time: '538943.839626' 2022-08-13 10:32:58 (15876): Status Report: CPU Time: '536468.093750' 2022-08-13 12:13:04 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 12:13:04 (15876): Status Report: Elapsed Time: '544943.839626' 2022-08-13 12:13:04 (15876): Status Report: CPU Time: '542399.171875' 2022-08-13 13:53:10 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 13:53:10 (15876): Status Report: Elapsed Time: '550943.839626' 2022-08-13 13:53:10 (15876): Status Report: CPU Time: '548340.546875' 2022-08-13 15:33:17 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 15:33:17 (15876): Status Report: Elapsed Time: '556943.839626' 2022-08-13 15:33:17 (15876): Status Report: CPU Time: '554266.453125' 2022-08-13 17:13:23 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 17:13:23 (15876): Status Report: Elapsed Time: '562943.839626' 2022-08-13 17:13:23 (15876): Status Report: CPU Time: '560209.890625' 2022-08-13 18:53:29 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 18:53:29 (15876): Status Report: Elapsed Time: '568943.839626' 2022-08-13 18:53:29 (15876): Status Report: CPU Time: '566201.015625' 2022-08-13 20:33:35 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 20:33:35 (15876): Status Report: Elapsed Time: '574943.839626' 2022-08-13 20:33:35 (15876): Status Report: CPU Time: '572193.953125' 2022-08-13 22:13:41 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 22:13:41 (15876): Status Report: Elapsed Time: '580943.839626' 2022-08-13 22:13:41 (15876): Status Report: CPU Time: '578195.890625' 2022-08-13 23:53:51 (15876): Status Report: Job Duration: '864000.000000' 2022-08-13 23:53:51 (15876): Status Report: Elapsed Time: '586943.839626' 2022-08-13 23:53:51 (15876): Status Report: CPU Time: '584116.078125' 2022-08-14 01:33:57 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 01:33:57 (15876): Status Report: Elapsed Time: '592943.839626' 2022-08-14 01:33:57 (15876): Status Report: CPU Time: '589905.890625' 2022-08-14 03:14:04 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 03:14:04 (15876): Status Report: Elapsed Time: '598943.839626' 2022-08-14 03:14:04 (15876): Status Report: CPU Time: '595765.125000' 2022-08-14 04:54:11 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 04:54:11 (15876): Status Report: Elapsed Time: '604943.839626' 2022-08-14 04:54:11 (15876): Status Report: CPU Time: '601686.218750' 2022-08-14 06:34:17 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 06:34:17 (15876): Status Report: Elapsed Time: '610943.839626' 2022-08-14 06:34:17 (15876): Status Report: CPU Time: '607655.078125' 2022-08-14 08:14:23 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 08:14:23 (15876): Status Report: Elapsed Time: '616943.839626' 2022-08-14 08:14:23 (15876): Status Report: CPU Time: '613597.734375' 2022-08-14 09:54:30 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 09:54:30 (15876): Status Report: Elapsed Time: '622943.839626' 2022-08-14 09:54:30 (15876): Status Report: CPU Time: '619499.140625' 2022-08-14 11:34:36 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 11:34:36 (15876): Status Report: Elapsed Time: '628943.839626' 2022-08-14 11:34:36 (15876): Status Report: CPU Time: '625439.562500' 2022-08-14 13:14:42 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 13:14:42 (15876): Status Report: Elapsed Time: '634943.839626' 2022-08-14 13:14:42 (15876): Status Report: CPU Time: '631401.000000' 2022-08-14 14:20:42 (15876): VM state change detected. (old = 'running', new = 'paused') 2022-08-14 17:21:39 (15876): Preference change detected 2022-08-14 17:21:39 (15876): Setting CPU throttle for VM. (100%) 2022-08-14 17:21:40 (15876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-14 17:21:40 (15876): VM state change detected. (old = 'paused', new = 'running') 2022-08-14 17:21:41 (15876): Guest Log: 177:41:34.946180 timesync vgsvcTimeSyncWorker: Radical host time change: 10 867 869 000 000ns (HostNow=1 660 490 501 042 000 000 ns HostLast=1 660 479 633 173 000 000 ns) 2022-08-14 17:21:51 (15876): Guest Log: 177:41:44.947850 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 867 816 585 000ns (GuestNow=1 660 490 511 058 879 000 ns GuestLast=1 660 479 643 242 294 000 ns fSetTimeLastLoop=true ) 2022-08-14 17:55:47 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 17:55:47 (15876): Status Report: Elapsed Time: '640943.839626' 2022-08-14 17:55:47 (15876): Status Report: CPU Time: '637366.125000' 2022-08-14 19:35:53 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 19:35:53 (15876): Status Report: Elapsed Time: '646943.839626' 2022-08-14 19:35:53 (15876): Status Report: CPU Time: '643330.250000' 2022-08-14 21:15:59 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 21:15:59 (15876): Status Report: Elapsed Time: '652943.839626' 2022-08-14 21:15:59 (15876): Status Report: CPU Time: '649303.296875' 2022-08-14 22:56:06 (15876): Status Report: Job Duration: '864000.000000' 2022-08-14 22:56:06 (15876): Status Report: Elapsed Time: '658943.839626' 2022-08-14 22:56:06 (15876): Status Report: CPU Time: '655292.140625' 2022-08-15 00:36:15 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 00:36:15 (15876): Status Report: Elapsed Time: '664943.839626' 2022-08-15 00:36:15 (15876): Status Report: CPU Time: '661293.562500' 2022-08-15 02:16:21 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 02:16:21 (15876): Status Report: Elapsed Time: '670943.839626' 2022-08-15 02:16:21 (15876): Status Report: CPU Time: '667297.156250' 2022-08-15 03:56:27 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 03:56:27 (15876): Status Report: Elapsed Time: '676943.839626' 2022-08-15 03:56:27 (15876): Status Report: CPU Time: '673298.062500' 2022-08-15 05:36:33 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 05:36:33 (15876): Status Report: Elapsed Time: '682943.839626' 2022-08-15 05:36:33 (15876): Status Report: CPU Time: '679299.609375' 2022-08-15 07:16:39 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 07:16:39 (15876): Status Report: Elapsed Time: '688943.839626' 2022-08-15 07:16:39 (15876): Status Report: CPU Time: '685302.500000' 2022-08-15 08:56:45 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 08:56:45 (15876): Status Report: Elapsed Time: '694943.839626' 2022-08-15 08:56:45 (15876): Status Report: CPU Time: '691304.515625' 2022-08-15 10:36:51 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 10:36:51 (15876): Status Report: Elapsed Time: '700943.839626' 2022-08-15 10:36:51 (15876): Status Report: CPU Time: '697306.609375' 2022-08-15 12:16:57 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 12:16:57 (15876): Status Report: Elapsed Time: '706943.839626' 2022-08-15 12:16:57 (15876): Status Report: CPU Time: '703309.906250' 2022-08-15 13:57:03 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 13:57:03 (15876): Status Report: Elapsed Time: '712943.839626' 2022-08-15 13:57:03 (15876): Status Report: CPU Time: '709279.468750' 2022-08-15 14:18:00 (15876): VM state change detected. (old = 'running', new = 'paused') 2022-08-15 14:46:58 (15876): Preference change detected 2022-08-15 14:46:58 (15876): Setting CPU throttle for VM. (100%) 2022-08-15 14:46:58 (15876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2022-08-15 14:46:58 (15876): VM state change detected. (old = 'paused', new = 'running') 2022-08-15 16:06:45 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 16:06:45 (15876): Status Report: Elapsed Time: '718943.839626' 2022-08-15 16:06:45 (15876): Status Report: CPU Time: '714936.328125' 2022-08-15 17:47:38 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 17:47:38 (15876): Status Report: Elapsed Time: '724943.839626' 2022-08-15 17:47:38 (15876): Status Report: CPU Time: '720496.421875' 2022-08-15 19:28:26 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 19:28:26 (15876): Status Report: Elapsed Time: '730943.839626' 2022-08-15 19:28:26 (15876): Status Report: CPU Time: '726386.921875' 2022-08-15 21:09:16 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 21:09:16 (15876): Status Report: Elapsed Time: '736943.839626' 2022-08-15 21:09:16 (15876): Status Report: CPU Time: '732295.125000' 2022-08-15 22:50:32 (15876): Status Report: Job Duration: '864000.000000' 2022-08-15 22:50:32 (15876): Status Report: Elapsed Time: '742943.839626' 2022-08-15 22:50:32 (15876): Status Report: CPU Time: '738030.921875' 2022-08-16 00:31:26 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 00:31:26 (15876): Status Report: Elapsed Time: '748943.839626' 2022-08-16 00:31:26 (15876): Status Report: CPU Time: '743766.046875' 2022-08-16 02:12:17 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 02:12:17 (15876): Status Report: Elapsed Time: '754943.839626' 2022-08-16 02:12:17 (15876): Status Report: CPU Time: '749683.937500' 2022-08-16 03:53:08 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 03:53:08 (15876): Status Report: Elapsed Time: '760943.839626' 2022-08-16 03:53:08 (15876): Status Report: CPU Time: '755551.750000' 2022-08-16 05:33:59 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 05:33:59 (15876): Status Report: Elapsed Time: '766943.839626' 2022-08-16 05:33:59 (15876): Status Report: CPU Time: '761454.171875' 2022-08-16 07:14:48 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 07:14:48 (15876): Status Report: Elapsed Time: '772943.839626' 2022-08-16 07:14:48 (15876): Status Report: CPU Time: '767345.375000' 2022-08-16 08:55:37 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 08:55:37 (15876): Status Report: Elapsed Time: '778943.839626' 2022-08-16 08:55:37 (15876): Status Report: CPU Time: '773160.953125' 2022-08-16 10:36:28 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 10:36:28 (15876): Status Report: Elapsed Time: '784943.839626' 2022-08-16 10:36:28 (15876): Status Report: CPU Time: '779047.968750' 2022-08-16 12:17:24 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 12:17:24 (15876): Status Report: Elapsed Time: '790943.839626' 2022-08-16 12:17:24 (15876): Status Report: CPU Time: '784914.015625' 2022-08-16 13:58:11 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 13:58:11 (15876): Status Report: Elapsed Time: '796943.839626' 2022-08-16 13:58:11 (15876): Status Report: CPU Time: '790766.312500' 2022-08-16 15:38:59 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 15:38:59 (15876): Status Report: Elapsed Time: '802943.839626' 2022-08-16 15:38:59 (15876): Status Report: CPU Time: '796598.859375' 2022-08-16 17:19:13 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 17:19:13 (15876): Status Report: Elapsed Time: '808943.839626' 2022-08-16 17:19:13 (15876): Status Report: CPU Time: '802411.265625' 2022-08-16 18:59:22 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 18:59:22 (15876): Status Report: Elapsed Time: '814943.839626' 2022-08-16 18:59:22 (15876): Status Report: CPU Time: '808266.906250' 2022-08-16 20:39:32 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 20:39:32 (15876): Status Report: Elapsed Time: '820943.839626' 2022-08-16 20:39:32 (15876): Status Report: CPU Time: '814116.765625' 2022-08-16 22:19:44 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 22:19:44 (15876): Status Report: Elapsed Time: '826943.839626' 2022-08-16 22:19:44 (15876): Status Report: CPU Time: '819932.218750' 2022-08-16 23:59:57 (15876): Status Report: Job Duration: '864000.000000' 2022-08-16 23:59:57 (15876): Status Report: Elapsed Time: '832943.839626' 2022-08-16 23:59:57 (15876): Status Report: CPU Time: '825766.078125' 2022-08-17 01:40:07 (15876): Status Report: Job Duration: '864000.000000' 2022-08-17 01:40:07 (15876): Status Report: Elapsed Time: '838943.839626' 2022-08-17 01:40:07 (15876): Status Report: CPU Time: '831615.171875' 2022-08-17 03:20:16 (15876): Status Report: Job Duration: '864000.000000' 2022-08-17 03:20:16 (15876): Status Report: Elapsed Time: '844943.839626' 2022-08-17 03:20:16 (15876): Status Report: CPU Time: '837466.062500' 2022-08-17 05:00:27 (15876): Status Report: Job Duration: '864000.000000' 2022-08-17 05:00:27 (15876): Status Report: Elapsed Time: '850943.839626' 2022-08-17 05:00:27 (15876): Status Report: CPU Time: '843302.187500' 2022-08-17 06:40:37 (15876): Status Report: Job Duration: '864000.000000' 2022-08-17 06:40:37 (15876): Status Report: Elapsed Time: '856943.839626' 2022-08-17 06:40:37 (15876): Status Report: CPU Time: '849166.468750' 2022-08-17 08:20:47 (15876): Status Report: Job Duration: '864000.000000' 2022-08-17 08:20:47 (15876): Status Report: Elapsed Time: '862943.839626' 2022-08-17 08:20:47 (15876): Status Report: CPU Time: '854978.859375' 2022-08-17 08:38:26 (15876): Powering off VM. 2022-08-17 08:38:27 (15876): Successfully stopped VM. 2022-08-17 08:38:27 (15876): Deregistering VM. (boinc_945a30f0f96e6fc9, slot#2) 2022-08-17 08:38:27 (15876): Removing network bandwidth throttle group from VM. 2022-08-17 08:38:28 (15876): Removing VM from VirtualBox. 08:38:33 (15876): called boinc_finish(0) </stderr_txt> <message> upload failure: <file_xfer_error> <file_name>Theory_2390-1087813-272_1_r1469617940_result</file_name> <error_code>-240 (stat() failed)</error_code> </file_xfer_error> </message> ]]>
©2024 CERN