Name | Theory_2743-2854899-240_0 |
Workunit | 223724677 |
Created | 24 Jun 2024, 13:42:03 UTC |
Sent | 24 Jun 2024, 22:47:59 UTC |
Report deadline | 5 Jul 2024, 22:47:59 UTC |
Received | 29 Jun 2024, 13:55:10 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10773647 |
Run time | 9 hours 52 min 26 sec |
CPU time | 5 hours 8 min 3 sec |
Validate state | Valid |
Credit | 217.62 |
Device peak FLOPS | 2.64 GFLOPS |
Application version | Theory Simulation v300.30 (vbox64_theory) windows_x86_64 |
Peak working set size | 91.76 MB |
Peak swap size | 104.58 MB |
Peak disk usage | 1.55 GB |
<core_client_version>8.0.2</core_client_version> <![CDATA[ <stderr_txt> IDE 2024-06-26 13:24:28 (7556): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-26 13:24:28 (7556): VM state change detected. (old = 'poweredoff', new = 'running') 2024-06-26 13:24:28 (7556): Detected: Web Application Enabled (http://localhost:54261) 2024-06-26 13:24:28 (7556): Detected: Remote Desktop Enabled (localhost:54262) 2024-06-26 13:24:28 (7556): Preference change detected 2024-06-26 13:24:28 (7556): Setting CPU throttle for VM. (100%) 2024-06-26 13:24:29 (7556): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-06-26 13:24:30 (7556): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-26 13:24:30 (7556): Guest Log: BIOS: Booting from Hard Disk... 2024-06-26 13:24:32 (7556): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-26 13:24:32 (7556): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-26 13:24:55 (7556): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-26 13:24:55 (7556): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-26 13:24:59 (7556): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.000167 main Log opened 2024-06-26T03:25:00.352152000Z 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.000353 main OS Product: Linux 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.000456 main OS Release: 4.14.76-13.cernvm.x86_64 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.000510 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.000590 main Executable: /usr/sbin/VBoxService 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.000593 main Process ID: 3232 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.000594 main Package type: LINUX_64BITS_GENERIC 2024-06-26 13:24:59 (7556): Guest Log: 00:00:00.004034 main 5.2.6 r120293 started. Verbose level = 0 2024-06-26 13:26:02 (7556): Guest Log: 13:26:03 AEST +10:00 2024-06-26: cranky: [INFO] Detected Theory App 2024-06-26 13:26:02 (7556): Guest Log: 13:26:03 AEST +10:00 2024-06-26: cranky: [INFO] Checking CVMFS. 2024-06-26 13:26:03 (7556): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-06-26 13:26:04 (7556): 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 2024-06-26 13:26:04 (7556): Guest Log: 2.5.2.0 4071 0 28260 29746 3 1 272413 4096000 0 65024 0 0 n/a 5 4 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-06-26 13:26:05 (7556): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-06-26 13:26:06 (7556): 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 2024-06-26 13:26:06 (7556): Guest Log: 2.5.2.0 4096 0 27516 24563 3 2 272413 4096000 0 65024 0 2 -100 7959 3448 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-06-26 13:26:07 (7556): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-06-26 13:26:08 (7556): 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 2024-06-26 13:26:08 (7556): Guest Log: 2.5.2.0 4141 0 27216 272 3 1 272413 4096000 0 65024 0 0 n/a 4 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-06-26 13:26:09 (7556): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-06-26 13:26:10 (7556): 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 2024-06-26 13:26:10 (7556): Guest Log: 2.5.2.0 4163 0 39636 19004 3 1 272413 4096000 0 65024 0 0 n/a 5538 211 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-06-26 13:26:10 (7556): Guest Log: 13:26:10 AEST +10:00 2024-06-26: cranky: [INFO] Checking runc. 2024-06-26 13:26:10 (7556): Guest Log: 13:26:10 AEST +10:00 2024-06-26: cranky: [INFO] Creating the filesystem. 2024-06-26 13:26:10 (7556): Guest Log: 13:26:10 AEST +10:00 2024-06-26: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-06-26 13:26:10 (7556): Guest Log: 13:26:11 AEST +10:00 2024-06-26: cranky: [INFO] Updating config.json. 2024-06-26 13:26:10 (7556): Guest Log: 13:26:11 AEST +10:00 2024-06-26: cranky: [INFO] Running Container 'runc'. 2024-06-26 13:26:14 (7556): Guest Log: job: htmld=/shared/html/job 2024-06-26 13:26:14 (7556): Guest Log: job: unpack exitcode=0 2024-06-26 13:26:15 (7556): Guest Log: INFO: activated the work-around for ld: 2024-06-26 13:26:15 (7556): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 26 03:26 /tmp/tmp.aMlpRGJL0p/ld -> /usr/bin/ld.bfd 2024-06-26 13:26:17 (7556): Guest Log: 13:26:17 AEST +10:00 2024-06-26: cranky: [INFO] ===> [runRivet] Wed Jun 26 03:26:16 UTC 2024 [boinc pp z1j 7000 125 - herwig++ 2.6.0 LHC-UE-EE-4-CTEQ6L1 100000 240] 2024-06-26 13:35:21 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-26 13:46:52 (7556): VM state change detected. (old = 'paused', new = 'running') 2024-06-26 13:49:38 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-26 14:02:16 (7556): VM state change detected. (old = 'paused', new = 'running') 2024-06-26 14:03:13 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-26 14:20:00 (7556): VM state change detected. (old = 'paused', new = 'running') 2024-06-26 14:20:15 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-26 14:23:20 (7556): VM state change detected. (old = 'paused', new = 'running') 2024-06-26 14:30:23 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-26 14:35:41 (7556): VM state change detected. (old = 'paused', new = 'running') 2024-06-26 14:42:02 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-26 14:55:45 (7556): VM state change detected. (old = 'paused', new = 'running') 2024-06-26 14:58:05 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-26 15:09:05 (7556): VM state change detected. (old = 'paused', new = 'running') 2024-06-26 15:11:42 (7556): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 08:33:15 (22476): vboxwrapper version 26207 2024-06-27 08:33:15 (22476): BOINC client version: 8.0.2 2024-06-27 08:33:17 (22476): Detected: VirtualBox VboxManage Interface (Version: 7.0.14) 2024-06-27 08:33:18 (22476): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-06-27 08:33:21 (22476): Guest Log: BIOS: VirtualBox 7.0.14 2024-06-27 08:33:21 (22476): Guest Log: CPUID EDX: 0x178bfbff 2024-06-27 08:33:21 (22476): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-27 08:33:21 (22476): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-27 08:33:21 (22476): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-27 08:33:21 (22476): Guest Log: BIOS: Booting from Hard Disk... 2024-06-27 08:33:21 (22476): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-27 08:33:21 (22476): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-27 08:33:21 (22476): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-27 08:33:21 (22476): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-27 08:33:21 (22476): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.000167 main Log opened 2024-06-26T03:25:00.352152000Z 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.000353 main OS Product: Linux 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.000456 main OS Release: 4.14.76-13.cernvm.x86_64 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.000510 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.000590 main Executable: /usr/sbin/VBoxService 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.000593 main Process ID: 3232 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.000594 main Package type: LINUX_64BITS_GENERIC 2024-06-27 08:33:21 (22476): Guest Log: 00:00:00.004034 main 5.2.6 r120293 started. Verbose level = 0 2024-06-27 08:33:21 (22476): Guest Log: 13:26:03 AEST +10:00 2024-06-26: cranky: [INFO] Detected Theory App 2024-06-27 08:33:21 (22476): Guest Log: 13:26:03 AEST +10:00 2024-06-26: cranky: [INFO] Checking CVMFS. 2024-06-27 08:33:21 (22476): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-06-27 08:33:21 (22476): 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 2024-06-27 08:33:21 (22476): Guest Log: 2.5.2.0 4071 0 28260 29746 3 1 272413 4096000 0 65024 0 0 n/a 5 4 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-06-27 08:33:21 (22476): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-06-27 08:33:21 (22476): 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 2024-06-27 08:33:21 (22476): Guest Log: 2.5.2.0 4096 0 27516 24563 3 2 272413 4096000 0 65024 0 2 -100 7959 3448 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-06-27 08:33:21 (22476): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-06-27 08:33:21 (22476): 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 2024-06-27 08:33:21 (22476): Guest Log: 2.5.2.0 4141 0 27216 272 3 1 272413 4096000 0 65024 0 0 n/a 4 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-06-27 08:33:21 (22476): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-06-27 08:33:21 (22476): 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 2024-06-27 08:33:21 (22476): Guest Log: 2.5.2.0 4163 0 39636 19004 3 1 272413 4096000 0 65024 0 0 n/a 5538 211 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-06-27 08:33:21 (22476): Guest Log: 13:26:10 AEST +10:00 2024-06-26: cranky: [INFO] Checking runc. 2024-06-27 08:33:21 (22476): Guest Log: 13:26:10 AEST +10:00 2024-06-26: cranky: [INFO] Creating the filesystem. 2024-06-27 08:33:21 (22476): Guest Log: 13:26:10 AEST +10:00 2024-06-26: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-06-27 08:33:21 (22476): Guest Log: 13:26:11 AEST +10:00 2024-06-26: cranky: [INFO] Updating config.json. 2024-06-27 08:33:21 (22476): Guest Log: 13:26:11 AEST +10:00 2024-06-26: cranky: [INFO] Running Container 'runc'. 2024-06-27 08:33:21 (22476): Guest Log: job: htmld=/shared/html/job 2024-06-27 08:33:21 (22476): Guest Log: job: unpack exitcode=0 2024-06-27 08:33:21 (22476): Guest Log: INFO: activated the work-around for ld: 2024-06-27 08:33:21 (22476): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 26 03:26 /tmp/tmp.aMlpRGJL0p/ld -> /usr/bin/ld.bfd 2024-06-27 08:33:21 (22476): Guest Log: 13:26:17 AEST +10:00 2024-06-26: cranky: [INFO] ===> [runRivet] Wed Jun 26 03:26:16 UTC 2024 [boinc pp z1j 7000 125 - herwig++ 2.6.0 LHC-UE-EE-4-CTEQ6L1 100000 240] 2024-06-27 08:33:21 (22476): Starting VM using VBoxManage interface. (boinc_be9255f6b638f701, slot#3) 2024-06-27 08:33:38 (22476): Successfully started VM. (PID = '3700') 2024-06-27 08:33:38 (22476): Reporting VM Process ID to BOINC. 2024-06-27 08:33:38 (22476): Guest Log: BIOS: VirtualBox 7.0.14 2024-06-27 08:33:38 (22476): Guest Log: CPUID EDX: 0x178bfbff 2024-06-27 08:33:38 (22476): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-27 08:33:38 (22476): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-27 08:33:38 (22476): VM state change detected. (old = 'poweredoff', new = 'running') 2024-06-27 08:33:38 (22476): Detected: Web Application Enabled (http://localhost:54261) 2024-06-27 08:33:38 (22476): Detected: Remote Desktop Enabled (localhost:54262) 2024-06-27 08:33:40 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 08:41:34 (22476): Preference change detected 2024-06-27 08:41:34 (22476): Setting CPU throttle for VM. (100%) 2024-06-27 08:41:35 (22476): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-06-27 08:41:35 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 08:41:36 (22476): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-27 08:41:36 (22476): Guest Log: BIOS: Booting from Hard Disk... 2024-06-27 08:41:39 (22476): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-27 08:41:39 (22476): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-27 08:42:02 (22476): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-27 08:42:02 (22476): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-27 08:42:07 (22476): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.000105 main Log opened 2024-06-26T22:42:07.045322000Z 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.000281 main OS Product: Linux 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.000344 main OS Release: 4.14.76-13.cernvm.x86_64 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.000382 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.000417 main Executable: /usr/sbin/VBoxService 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.000418 main Process ID: 3229 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.000419 main Package type: LINUX_64BITS_GENERIC 2024-06-27 08:42:07 (22476): Guest Log: 00:00:00.003939 main 5.2.6 r120293 started. Verbose level = 0 2024-06-27 08:43:05 (22476): Guest Log: 08:43:04 AEST +10:00 2024-06-27: cranky: [INFO] Detected Theory App 2024-06-27 08:43:05 (22476): Guest Log: 08:43:04 AEST +10:00 2024-06-27: cranky: [INFO] Checking CVMFS. 2024-06-27 08:43:06 (22476): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-06-27 08:43:07 (22476): 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 2024-06-27 08:43:07 (22476): Guest Log: 2.5.2.0 4129 0 27188 29767 3 1 1104736 4096001 0 65024 0 0 n/a 5 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-06-27 08:43:08 (22476): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-06-27 08:43:08 (22476): 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 2024-06-27 08:43:08 (22476): Guest Log: 2.5.2.0 4104 0 27588 24571 3 2 1104736 4096001 0 65024 0 2 0 5822 228 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-06-27 08:43:09 (22476): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-06-27 08:43:10 (22476): 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 2024-06-27 08:43:10 (22476): Guest Log: 2.5.2.0 4060 0 27860 272 3 1 1104736 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-06-27 08:43:11 (22476): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-06-27 08:43:12 (22476): 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 2024-06-27 08:43:12 (22476): Guest Log: 2.5.2.0 4155 0 39936 19009 3 1 1104736 4096001 0 65024 0 0 n/a 5540 214 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-06-27 08:43:12 (22476): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Checking runc. 2024-06-27 08:43:12 (22476): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Creating the filesystem. 2024-06-27 08:43:12 (22476): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-06-27 08:43:13 (22476): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Updating config.json. 2024-06-27 08:43:13 (22476): Guest Log: 08:43:13 AEST +10:00 2024-06-27: cranky: [INFO] Running Container 'runc'. 2024-06-27 08:43:14 (22476): Guest Log: job: htmld=/shared/html/job 2024-06-27 08:43:14 (22476): Guest Log: job: unpack exitcode=0 2024-06-27 08:43:14 (22476): Guest Log: INFO: activated the work-around for ld: 2024-06-27 08:43:14 (22476): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 26 22:43 /tmp/tmp.xQ9qL0uR3p/ld -> /usr/bin/ld.bfd 2024-06-27 08:43:15 (22476): Guest Log: 08:43:15 AEST +10:00 2024-06-27: cranky: [INFO] ===> [runRivet] Wed Jun 26 22:43:14 UTC 2024 [boinc pp z1j 7000 125 - herwig++ 2.6.0 LHC-UE-EE-4-CTEQ6L1 100000 240] 2024-06-27 08:43:17 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 08:46:24 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 09:04:52 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 09:08:20 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 09:10:27 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 09:13:34 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 09:13:35 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 09:30:10 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 09:32:30 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 09:45:59 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 09:48:14 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 09:51:19 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 09:51:36 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 10:10:19 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 10:10:31 (22476): Guest Log: 00:26:53.756139 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 125 534 239 000ns (GuestNow=1 719 447 030 385 410 000 ns GuestLast=1 719 444 904 851 171 000 ns fSetTimeLastLoop=true ) 2024-06-27 10:12:49 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 10:29:09 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 10:58:50 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 11:12:33 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 11:12:44 (22476): Guest Log: 00:59:06.616587 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 810 285 529 000ns (GuestNow=1 719 450 763 576 155 000 ns GuestLast=1 719 448 953 290 626 000 ns fSetTimeLastLoop=true ) 2024-06-27 11:16:19 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 11:19:36 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 11:19:39 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 11:33:28 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 11:38:41 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 12:08:19 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 12:08:32 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 12:20:26 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 12:20:29 (22476): Guest Log: 01:08:17.531517 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 810 777 456 000ns (GuestNow=1 719 454 115 237 767 000 ns GuestLast=1 719 451 304 460 311 000 ns fSetTimeLastLoop=true ) 2024-06-27 12:20:51 (22476): Status Report: Job Duration: '864000.000000' 2024-06-27 12:20:51 (22476): Status Report: Elapsed Time: '6000.308752' 2024-06-27 12:20:51 (22476): Status Report: CPU Time: '3377.812500' 2024-06-27 12:24:48 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 12:30:35 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 12:33:02 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 12:36:02 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 12:38:06 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 12:47:53 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 12:48:26 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 13:21:01 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 13:21:10 (22476): Guest Log: 01:17:58.461025 timesync vgsvcTimeSyncWorker: Radical host time change: 1 963 521 000 000ns (HostNow=1 719 458 469 974 000 000 ns HostLast=1 719 456 506 453 000 000 ns) 2024-06-27 13:21:20 (22476): Guest Log: 01:18:08.476710 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 549 418 399 000ns (GuestNow=1 719 458 479 989 650 000 ns GuestLast=1 719 455 930 571 251 000 ns fSetTimeLastLoop=true ) 2024-06-27 13:22:05 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 13:28:53 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 13:31:55 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 13:42:15 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 13:46:36 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 13:57:21 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 13:58:38 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 14:05:48 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 14:06:32 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 14:16:33 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 14:22:40 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 14:37:46 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 14:37:57 (22476): Guest Log: 01:34:39.796409 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 946 094 175 000ns (GuestNow=1 719 463 077 137 720 000 ns GuestLast=1 719 461 131 043 545 000 ns fSetTimeLastLoop=true ) 2024-06-27 14:38:21 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 14:48:46 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 14:50:52 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 15:00:57 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 15:04:51 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 15:08:22 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 15:14:57 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 15:18:48 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 15:36:17 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 16:02:53 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 16:03:04 (22476): Guest Log: 02:05:22.753349 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 045 799 519 000ns (GuestNow=1 719 468 183 985 584 000 ns GuestLast=1 719 466 138 186 065 000 ns fSetTimeLastLoop=true ) 2024-06-27 16:04:04 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 16:26:21 (22476): VM state change detected. (old = 'paused', new = 'running') 2024-06-27 16:27:46 (22476): VM state change detected. (old = 'running', new = 'paused') 2024-06-27 16:34:19 (22476): VM state change detected. (old = 'paused', new = 'stopping') 2024-06-27 16:34:19 (22476): Stopping VM. 2024-06-27 16:34:20 (22476): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_be9255f6b638f701" savestate Output: 2024-06-27 16:34:20 (22476): VM did not stop when requested. 2024-06-27 16:34:20 (22476): VM was NOT successfully terminated. 2024-06-28 08:15:08 (11904): vboxwrapper version 26207 2024-06-28 08:15:08 (11904): BOINC client version: 8.0.2 2024-06-28 08:15:11 (11904): Detected: VirtualBox VboxManage Interface (Version: 7.0.14) 2024-06-28 08:15:11 (11904): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-06-28 08:15:14 (11904): Guest Log: BIOS: VirtualBox 7.0.14 2024-06-28 08:15:14 (11904): Guest Log: CPUID EDX: 0x178bfbff 2024-06-28 08:15:14 (11904): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-28 08:15:14 (11904): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-28 08:15:14 (11904): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-28 08:15:14 (11904): Guest Log: BIOS: Booting from Hard Disk... 2024-06-28 08:15:14 (11904): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-28 08:15:14 (11904): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-28 08:15:14 (11904): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-28 08:15:14 (11904): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-28 08:15:14 (11904): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.000105 main Log opened 2024-06-26T22:42:07.045322000Z 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.000281 main OS Product: Linux 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.000344 main OS Release: 4.14.76-13.cernvm.x86_64 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.000382 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.000417 main Executable: /usr/sbin/VBoxService 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.000418 main Process ID: 3229 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.000419 main Package type: LINUX_64BITS_GENERIC 2024-06-28 08:15:14 (11904): Guest Log: 00:00:00.003939 main 5.2.6 r120293 started. Verbose level = 0 2024-06-28 08:15:14 (11904): Guest Log: 08:43:04 AEST +10:00 2024-06-27: cranky: [INFO] Detected Theory App 2024-06-28 08:15:14 (11904): Guest Log: 08:43:04 AEST +10:00 2024-06-27: cranky: [INFO] Checking CVMFS. 2024-06-28 08:15:14 (11904): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-06-28 08:15:14 (11904): 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 2024-06-28 08:15:14 (11904): Guest Log: 2.5.2.0 4129 0 27188 29767 3 1 1104736 4096001 0 65024 0 0 n/a 5 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-06-28 08:15:14 (11904): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-06-28 08:15:14 (11904): 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 2024-06-28 08:15:14 (11904): Guest Log: 2.5.2.0 4104 0 27588 24571 3 2 1104736 4096001 0 65024 0 2 0 5822 228 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-06-28 08:15:14 (11904): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-06-28 08:15:14 (11904): 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 2024-06-28 08:15:14 (11904): Guest Log: 2.5.2.0 4060 0 27860 272 3 1 1104736 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-06-28 08:15:14 (11904): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-06-28 08:15:14 (11904): 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 2024-06-28 08:15:14 (11904): Guest Log: 2.5.2.0 4155 0 39936 19009 3 1 1104736 4096001 0 65024 0 0 n/a 5540 214 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-06-28 08:15:14 (11904): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Checking runc. 2024-06-28 08:15:14 (11904): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Creating the filesystem. 2024-06-28 08:15:14 (11904): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-06-28 08:15:14 (11904): Guest Log: 08:43:12 AEST +10:00 2024-06-27: cranky: [INFO] Updating config.json. 2024-06-28 08:15:14 (11904): Guest Log: 08:43:13 AEST +10:00 2024-06-27: cranky: [INFO] Running Container 'runc'. 2024-06-28 08:15:14 (11904): Guest Log: job: htmld=/shared/html/job 2024-06-28 08:15:14 (11904): Guest Log: job: unpack exitcode=0 2024-06-28 08:15:14 (11904): Guest Log: INFO: activated the work-around for ld: 2024-06-28 08:15:14 (11904): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 26 22:43 /tmp/tmp.xQ9qL0uR3p/ld -> /usr/bin/ld.bfd 2024-06-28 08:15:14 (11904): Guest Log: 08:43:15 AEST +10:00 2024-06-27: cranky: [INFO] ===> [runRivet] Wed Jun 26 22:43:14 UTC 2024 [boinc pp z1j 7000 125 - herwig++ 2.6.0 LHC-UE-EE-4-CTEQ6L1 100000 240] 2024-06-28 08:15:14 (11904): Guest Log: 00:26:53.756139 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 125 534 239 000ns (GuestNow=1 719 447 030 385 410 000 ns GuestLast=1 719 444 904 851 171 000 ns fSetTimeLastLoop=true ) 2024-06-28 08:15:14 (11904): Guest Log: 00:59:06.616587 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 810 285 529 000ns (GuestNow=1 719 450 763 576 155 000 ns GuestLast=1 719 448 953 290 626 000 ns fSetTimeLastLoop=true ) 2024-06-28 08:15:14 (11904): Guest Log: 01:08:17.531517 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 810 777 456 000ns (GuestNow=1 719 454 115 237 767 000 ns GuestLast=1 719 451 304 460 311 000 ns fSetTimeLastLoop=true ) 2024-06-28 08:15:14 (11904): Guest Log: 01:17:58.461025 timesync vgsvcTimeSyncWorker: Radical host time change: 1 963 521 000 000ns (HostNow=1 719 458 469 974 000 000 ns HostLast=1 719 456 506 453 000 000 ns) 2024-06-28 08:15:14 (11904): Guest Log: 01:18:08.476710 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 549 418 399 000ns (GuestNow=1 719 458 479 989 650 000 ns GuestLast=1 719 455 930 571 251 000 ns fSetTimeLastLoop=true ) 2024-06-28 08:15:14 (11904): Guest Log: 01:34:39.796409 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 946 094 175 000ns (GuestNow=1 719 463 077 137 720 000 ns GuestLast=1 719 461 131 043 545 000 ns fSetTimeLastLoop=true ) 2024-06-28 08:15:14 (11904): Guest Log: 02:05:22.753349 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 045 799 519 000ns (GuestNow=1 719 468 183 985 584 000 ns GuestLast=1 719 466 138 186 065 000 ns fSetTimeLastLoop=true ) 2024-06-28 08:15:14 (11904): Starting VM using VBoxManage interface. (boinc_be9255f6b638f701, slot#3) 2024-06-28 08:15:30 (11904): Successfully started VM. (PID = '16616') 2024-06-28 08:15:30 (11904): Reporting VM Process ID to BOINC. 2024-06-28 08:15:30 (11904): Guest Log: BIOS: VirtualBox 7.0.14 2024-06-28 08:15:30 (11904): Guest Log: CPUID EDX: 0x178bfbff 2024-06-28 08:15:30 (11904): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-28 08:15:30 (11904): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-28 08:15:30 (11904): VM state change detected. (old = 'poweredoff', new = 'running') 2024-06-28 08:15:30 (11904): Detected: Web Application Enabled (http://localhost:54261) 2024-06-28 08:15:30 (11904): Detected: Remote Desktop Enabled (localhost:54262) 2024-06-28 08:15:30 (11904): Status Report: Job Duration: '864000.000000' 2024-06-28 08:15:30 (11904): Status Report: Elapsed Time: '9372.531795' 2024-06-28 08:15:30 (11904): Status Report: CPU Time: '5623.031250' 2024-06-28 08:15:30 (11904): Preference change detected 2024-06-28 08:15:30 (11904): Setting CPU throttle for VM. (100%) 2024-06-28 08:15:30 (11904): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-06-28 08:15:32 (11904): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-28 08:15:32 (11904): Guest Log: BIOS: Booting from Hard Disk... 2024-06-28 08:15:35 (11904): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-28 08:15:35 (11904): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-28 08:16:02 (11904): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-28 08:16:02 (11904): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-28 08:16:08 (11904): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.000136 main Log opened 2024-06-27T22:16:07.287377000Z 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.000387 main OS Product: Linux 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.000463 main OS Release: 4.14.76-13.cernvm.x86_64 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.000525 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.000583 main Executable: /usr/sbin/VBoxService 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.000585 main Process ID: 3232 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.000586 main Package type: LINUX_64BITS_GENERIC 2024-06-28 08:16:08 (11904): Guest Log: 00:00:00.004494 main 5.2.6 r120293 started. Verbose level = 0 2024-06-28 08:16:32 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 08:19:32 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 08:19:58 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 08:37:27 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 08:37:41 (11904): Guest Log: 08:37:40 AEST +10:00 2024-06-28: cranky: [INFO] Detected Theory App 2024-06-28 08:37:41 (11904): Guest Log: 08:37:40 AEST +10:00 2024-06-28: cranky: [INFO] Checking CVMFS. 2024-06-28 08:37:42 (11904): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-06-28 08:37:43 (11904): 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 2024-06-28 08:37:43 (11904): Guest Log: 2.5.2.0 4163 21 25136 29782 3 1 1254432 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-06-28 08:37:44 (11904): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-06-28 08:37:45 (11904): 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 2024-06-28 08:37:45 (11904): Guest Log: 2.5.2.0 4134 21 27480 24579 3 2 1254432 4096001 0 65024 0 2 0 5820 304 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-06-28 08:37:46 (11904): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-06-28 08:38:07 (11904): 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 2024-06-28 08:38:07 (11904): Guest Log: 2.5.2.0 4090 21 25164 272 -17 1 1254432 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-06-28 08:38:08 (11904): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-06-28 08:38:10 (11904): 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 2024-06-28 08:38:10 (11904): Guest Log: 2.5.2.0 4068 21 39640 19015 -17 1 1254432 4096001 0 65024 0 0 n/a 5541 1346 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-06-28 08:38:10 (11904): Guest Log: 08:38:10 AEST +10:00 2024-06-28: cranky: [INFO] Checking runc. 2024-06-28 08:38:10 (11904): Guest Log: 08:38:10 AEST +10:00 2024-06-28: cranky: [INFO] Creating the filesystem. 2024-06-28 08:38:10 (11904): Guest Log: 08:38:10 AEST +10:00 2024-06-28: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-06-28 08:38:11 (11904): Guest Log: 08:38:11 AEST +10:00 2024-06-28: cranky: [INFO] Updating config.json. 2024-06-28 08:38:11 (11904): Guest Log: 08:38:11 AEST +10:00 2024-06-28: cranky: [INFO] Running Container 'runc'. 2024-06-28 08:38:12 (11904): Guest Log: job: htmld=/shared/html/job 2024-06-28 08:38:13 (11904): Guest Log: job: unpack exitcode=0 2024-06-28 08:38:13 (11904): Guest Log: INFO: activated the work-around for ld: 2024-06-28 08:38:13 (11904): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 27 22:38 /tmp/tmp.RGujV0tUiF/ld -> /usr/bin/ld.bfd 2024-06-28 08:38:13 (11904): Guest Log: 08:38:13 AEST +10:00 2024-06-28: cranky: [INFO] ===> [runRivet] Thu Jun 27 22:38:13 UTC 2024 [boinc pp z1j 7000 125 - herwig++ 2.6.0 LHC-UE-EE-4-CTEQ6L1 100000 240] 2024-06-28 08:38:57 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 08:46:07 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 08:47:10 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 08:50:10 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 08:50:48 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 08:57:09 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 08:57:37 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 09:00:36 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 09:06:06 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 09:14:31 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 09:20:32 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 09:56:36 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 09:56:43 (11904): Guest Log: 00:16:11.210814 timesync vgsvcTimeSyncWorker: Radical host time change: 2 173 732 000 000ns (HostNow=1 719 532 603 194 000 000 ns HostLast=1 719 530 429 462 000 000 ns) 2024-06-28 09:56:53 (11904): Guest Log: 00:16:21.242762 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 173 788 602 000ns (GuestNow=1 719 532 613 254 329 000 ns GuestLast=1 719 530 439 465 727 000 ns fSetTimeLastLoop=true ) 2024-06-28 09:57:52 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 10:00:52 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 10:04:57 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 10:31:30 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 10:32:26 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 10:35:26 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 10:36:16 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 10:39:22 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 10:44:42 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 11:04:53 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 11:05:35 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 11:15:30 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 11:17:15 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 11:21:14 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 11:22:42 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 11:27:15 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 11:30:36 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 11:56:08 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 11:56:21 (11904): Guest Log: 00:36:02.812459 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 647 256 830 000ns (GuestNow=1 719 539 781 150 024 000 ns GuestLast=1 719 537 133 893 194 000 ns fSetTimeLastLoop=true ) 2024-06-28 12:00:43 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 12:35:52 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 12:36:00 (11904): Guest Log: 00:40:33.260257 timesync vgsvcTimeSyncWorker: Radical host time change: 2 119 313 000 000ns (HostNow=1 719 542 160 897 000 000 ns HostLast=1 719 540 041 584 000 000 ns) 2024-06-28 12:36:10 (11904): Guest Log: 00:40:43.266328 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 119 311 410 000ns (GuestNow=1 719 542 170 906 026 000 ns GuestLast=1 719 540 051 594 616 000 ns fSetTimeLastLoop=true ) 2024-06-28 12:36:41 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 12:39:41 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 12:42:47 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 12:47:05 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 12:48:02 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 13:16:57 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 13:17:12 (11904): Guest Log: 00:45:33.659930 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 180 949 347 000ns (GuestNow=1 719 544 632 240 105 000 ns GuestLast=1 719 542 451 290 758 000 ns fSetTimeLastLoop=true ) 2024-06-28 14:00:06 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 14:20:56 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 14:34:08 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 14:46:13 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 14:46:19 (11904): Status Report: Job Duration: '864000.000000' 2024-06-28 14:46:19 (11904): Status Report: Elapsed Time: '15372.618803' 2024-06-28 14:46:19 (11904): Status Report: CPU Time: '9117.546875' 2024-06-28 14:47:38 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-28 15:05:22 (11904): VM state change detected. (old = 'paused', new = 'running') 2024-06-28 15:07:10 (11904): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 12:54:16 (11664): vboxwrapper version 26207 2024-06-29 12:54:16 (11664): BOINC client version: 8.0.2 2024-06-29 12:54:21 (11664): Detected: VirtualBox VboxManage Interface (Version: 7.0.14) 2024-06-29 12:54:22 (11664): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-06-29 12:54:28 (11664): Guest Log: BIOS: VirtualBox 7.0.14 2024-06-29 12:54:28 (11664): Guest Log: CPUID EDX: 0x178bfbff 2024-06-29 12:54:28 (11664): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-29 12:54:28 (11664): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-29 12:54:28 (11664): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-29 12:54:28 (11664): Guest Log: BIOS: Booting from Hard Disk... 2024-06-29 12:54:28 (11664): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-29 12:54:28 (11664): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-29 12:54:28 (11664): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-29 12:54:28 (11664): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-29 12:54:28 (11664): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.000136 main Log opened 2024-06-27T22:16:07.287377000Z 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.000387 main OS Product: Linux 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.000463 main OS Release: 4.14.76-13.cernvm.x86_64 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.000525 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.000583 main Executable: /usr/sbin/VBoxService 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.000585 main Process ID: 3232 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.000586 main Package type: LINUX_64BITS_GENERIC 2024-06-29 12:54:28 (11664): Guest Log: 00:00:00.004494 main 5.2.6 r120293 started. Verbose level = 0 2024-06-29 12:54:28 (11664): Guest Log: 08:37:40 AEST +10:00 2024-06-28: cranky: [INFO] Detected Theory App 2024-06-29 12:54:28 (11664): Guest Log: 08:37:40 AEST +10:00 2024-06-28: cranky: [INFO] Checking CVMFS. 2024-06-29 12:54:28 (11664): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-06-29 12:54:28 (11664): 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 2024-06-29 12:54:28 (11664): Guest Log: 2.5.2.0 4163 21 25136 29782 3 1 1254432 4096001 0 65024 0 0 n/a 5 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-06-29 12:54:28 (11664): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-06-29 12:54:28 (11664): 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 2024-06-29 12:54:28 (11664): Guest Log: 2.5.2.0 4134 21 27480 24579 3 2 1254432 4096001 0 65024 0 2 0 5820 304 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-06-29 12:54:28 (11664): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-06-29 12:54:28 (11664): 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 2024-06-29 12:54:28 (11664): Guest Log: 2.5.2.0 4090 21 25164 272 -17 1 1254432 4096001 0 65024 0 0 n/a 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-06-29 12:54:28 (11664): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-06-29 12:54:28 (11664): 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 2024-06-29 12:54:28 (11664): Guest Log: 2.5.2.0 4068 21 39640 19015 -17 1 1254432 4096001 0 65024 0 0 n/a 5541 1346 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-06-29 12:54:28 (11664): Guest Log: 08:38:10 AEST +10:00 2024-06-28: cranky: [INFO] Checking runc. 2024-06-29 12:54:28 (11664): Guest Log: 08:38:10 AEST +10:00 2024-06-28: cranky: [INFO] Creating the filesystem. 2024-06-29 12:54:28 (11664): Guest Log: 08:38:10 AEST +10:00 2024-06-28: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-06-29 12:54:28 (11664): Guest Log: 08:38:11 AEST +10:00 2024-06-28: cranky: [INFO] Updating config.json. 2024-06-29 12:54:28 (11664): Guest Log: 08:38:11 AEST +10:00 2024-06-28: cranky: [INFO] Running Container 'runc'. 2024-06-29 12:54:28 (11664): Guest Log: job: htmld=/shared/html/job 2024-06-29 12:54:28 (11664): Guest Log: job: unpack exitcode=0 2024-06-29 12:54:28 (11664): Guest Log: INFO: activated the work-around for ld: 2024-06-29 12:54:28 (11664): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 27 22:38 /tmp/tmp.RGujV0tUiF/ld -> /usr/bin/ld.bfd 2024-06-29 12:54:28 (11664): Guest Log: 08:38:13 AEST +10:00 2024-06-28: cranky: [INFO] ===> [runRivet] Thu Jun 27 22:38:13 UTC 2024 [boinc pp z1j 7000 125 - herwig++ 2.6.0 LHC-UE-EE-4-CTEQ6L1 100000 240] 2024-06-29 12:54:28 (11664): Guest Log: 00:16:11.210814 timesync vgsvcTimeSyncWorker: Radical host time change: 2 173 732 000 000ns (HostNow=1 719 532 603 194 000 000 ns HostLast=1 719 530 429 462 000 000 ns) 2024-06-29 12:54:28 (11664): Guest Log: 00:16:21.242762 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 173 788 602 000ns (GuestNow=1 719 532 613 254 329 000 ns GuestLast=1 719 530 439 465 727 000 ns fSetTimeLastLoop=true ) 2024-06-29 12:54:28 (11664): Guest Log: 00:36:02.812459 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 647 256 830 000ns (GuestNow=1 719 539 781 150 024 000 ns GuestLast=1 719 537 133 893 194 000 ns fSetTimeLastLoop=true ) 2024-06-29 12:54:28 (11664): Guest Log: 00:40:33.260257 timesync vgsvcTimeSyncWorker: Radical host time change: 2 119 313 000 000ns (HostNow=1 719 542 160 897 000 000 ns HostLast=1 719 540 041 584 000 000 ns) 2024-06-29 12:54:28 (11664): Guest Log: 00:40:43.266328 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 119 311 410 000ns (GuestNow=1 719 542 170 906 026 000 ns GuestLast=1 719 540 051 594 616 000 ns fSetTimeLastLoop=true ) 2024-06-29 12:54:28 (11664): Guest Log: 00:45:33.659930 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 180 949 347 000ns (GuestNow=1 719 544 632 240 105 000 ns GuestLast=1 719 542 451 290 758 000 ns fSetTimeLastLoop=true ) 2024-06-29 12:54:28 (11664): Starting VM using VBoxManage interface. (boinc_be9255f6b638f701, slot#3) 2024-06-29 12:54:53 (11664): Successfully started VM. (PID = '11400') 2024-06-29 12:54:53 (11664): Reporting VM Process ID to BOINC. 2024-06-29 12:54:54 (11664): Guest Log: BIOS: VirtualBox 7.0.14 2024-06-29 12:54:54 (11664): Guest Log: CPUID EDX: 0x178bfbff 2024-06-29 12:54:54 (11664): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-06-29 12:54:54 (11664): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-06-29 12:54:54 (11664): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-06-29 12:54:54 (11664): Guest Log: BIOS: Booting from Hard Disk... 2024-06-29 12:54:54 (11664): VM state change detected. (old = 'poweredoff', new = 'running') 2024-06-29 12:54:54 (11664): Detected: Web Application Enabled (http://localhost:54261) 2024-06-29 12:54:54 (11664): Detected: Remote Desktop Enabled (localhost:54262) 2024-06-29 12:54:54 (11664): Status Report: Job Duration: '864000.000000' 2024-06-29 12:54:54 (11664): Status Report: Elapsed Time: '15513.618803' 2024-06-29 12:54:55 (11664): Status Report: CPU Time: '9193.578125' 2024-06-29 12:54:55 (11664): Preference change detected 2024-06-29 12:54:55 (11664): Setting CPU throttle for VM. (100%) 2024-06-29 12:55:05 (11664): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-06-29 12:55:05 (11664): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-06-29 12:55:05 (11664): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-06-29 12:55:30 (11664): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-06-29 12:55:30 (11664): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-06-29 12:55:38 (11664): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.000191 main Log opened 2024-06-29T02:55:37.908037000Z 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.000433 main OS Product: Linux 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.000551 main OS Release: 4.14.76-13.cernvm.x86_64 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.000642 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.000705 main Executable: /usr/sbin/VBoxService 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.000707 main Process ID: 3239 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.000709 main Package type: LINUX_64BITS_GENERIC 2024-06-29 12:55:38 (11664): Guest Log: 00:00:00.006150 main 5.2.6 r120293 started. Verbose level = 0 2024-06-29 12:56:14 (11664): Guest Log: 12:56:13 AEST +10:00 2024-06-29: cranky: [INFO] Detected Theory App 2024-06-29 12:56:14 (11664): Guest Log: 12:56:13 AEST +10:00 2024-06-29: cranky: [INFO] Checking CVMFS. 2024-06-29 12:56:15 (11664): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-06-29 12:56:16 (11664): 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 2024-06-29 12:56:16 (11664): Guest Log: 2.5.2.0 4082 0 27196 29804 3 1 1281402 4096001 0 65024 0 0 n/a 5 3 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-06-29 12:56:18 (11664): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-06-29 12:56:18 (11664): 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 2024-06-29 12:56:18 (11664): Guest Log: 2.5.2.0 4132 0 25644 24587 3 2 1281402 4096001 0 65024 0 2 0 5819 2958 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-06-29 12:56:20 (11664): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-06-29 12:56:21 (11664): 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 2024-06-29 12:56:21 (11664): Guest Log: 2.5.2.0 4155 0 25156 272 3 1 1281402 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-06-29 12:56:22 (11664): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-06-29 12:56:23 (11664): 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 2024-06-29 12:56:23 (11664): Guest Log: 2.5.2.0 4103 0 37748 19023 3 1 1281402 4096001 0 65024 0 0 n/a 5543 2694 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-06-29 12:56:23 (11664): Guest Log: 12:56:23 AEST +10:00 2024-06-29: cranky: [INFO] Checking runc. 2024-06-29 12:56:23 (11664): Guest Log: 12:56:23 AEST +10:00 2024-06-29: cranky: [INFO] Creating the filesystem. 2024-06-29 12:56:23 (11664): Guest Log: 12:56:23 AEST +10:00 2024-06-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-06-29 12:56:24 (11664): Guest Log: 12:56:23 AEST +10:00 2024-06-29: cranky: [INFO] Updating config.json. 2024-06-29 12:56:24 (11664): Guest Log: 12:56:23 AEST +10:00 2024-06-29: cranky: [INFO] Running Container 'runc'. 2024-06-29 12:56:25 (11664): Guest Log: job: htmld=/shared/html/job 2024-06-29 12:56:25 (11664): Guest Log: job: unpack exitcode=0 2024-06-29 12:56:25 (11664): Guest Log: INFO: activated the work-around for ld: 2024-06-29 12:56:25 (11664): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 29 02:56 /tmp/tmp.lMusAaedX5/ld -> /usr/bin/ld.bfd 2024-06-29 12:56:26 (11664): Guest Log: 12:56:25 AEST +10:00 2024-06-29: cranky: [INFO] ===> [runRivet] Sat Jun 29 02:56:24 UTC 2024 [boinc pp z1j 7000 125 - herwig++ 2.6.0 LHC-UE-EE-4-CTEQ6L1 100000 240] 2024-06-29 13:26:33 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 13:35:34 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 13:36:07 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 14:12:23 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 14:12:28 (11664): Guest Log: 00:31:32.585548 timesync vgsvcTimeSyncWorker: Radical host time change: 2 185 227 000 000ns (HostNow=1 719 634 347 832 000 000 ns HostLast=1 719 632 162 605 000 000 ns) 2024-06-29 14:12:38 (11664): Guest Log: 00:31:42.664320 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 727 432 668 000ns (GuestNow=1 719 634 357 918 404 000 ns GuestLast=1 719 631 630 485 736 000 ns fSetTimeLastLoop=true ) 2024-06-29 14:19:06 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 14:27:20 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 15:00:41 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 15:18:39 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 15:48:08 (11664): Status Report: Job Duration: '864000.000000' 2024-06-29 15:48:08 (11664): Status Report: Elapsed Time: '21514.195093' 2024-06-29 15:48:08 (11664): Status Report: CPU Time: '11915.031250' 2024-06-29 17:28:58 (11664): Status Report: Job Duration: '864000.000000' 2024-06-29 17:28:58 (11664): Status Report: Elapsed Time: '27515.115351' 2024-06-29 17:28:58 (11664): Status Report: CPU Time: '14685.531250' 2024-06-29 18:24:34 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 18:30:18 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 18:37:52 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 18:43:08 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 18:44:23 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:03:02 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:03:43 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:15:11 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:15:13 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:18:16 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:18:18 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:30:32 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:31:54 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:35:28 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:35:33 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:38:35 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:38:56 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:41:57 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:42:00 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:45:01 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:45:21 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 19:55:42 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 19:55:52 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 20:08:36 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 20:10:39 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 20:13:42 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 20:14:25 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 20:17:48 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 20:18:02 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 20:21:22 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 20:21:23 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 20:31:49 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 20:32:06 (11664): Guest Log: 04:32:53.578536 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 981 625 482 000ns (GuestNow=1 719 657 126 137 246 000 ns GuestLast=1 719 655 144 511 764 000 ns fSetTimeLastLoop=true ) 2024-06-29 20:32:45 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 20:52:23 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 21:13:58 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 21:23:03 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 21:24:46 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 21:42:54 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 21:43:04 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 21:54:42 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 21:55:05 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 22:03:28 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 22:03:33 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 22:06:45 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 22:06:54 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 22:14:24 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 22:15:03 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 22:18:04 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 22:18:22 (11664): VM state change detected. (old = 'running', new = 'paused') 2024-06-29 22:26:20 (11664): VM state change detected. (old = 'paused', new = 'running') 2024-06-29 22:31:19 (11664): Status Report: Job Duration: '864000.000000' 2024-06-29 22:31:19 (11664): Status Report: Elapsed Time: '33515.544090' 2024-06-29 22:31:19 (11664): Status Report: CPU Time: '17735.656250' 2024-06-29 22:54:27 (11664): Guest Log: job: run exitcode=0 2024-06-29 22:54:27 (11664): Guest Log: job: diskusage=4228 2024-06-29 22:54:27 (11664): Guest Log: job: logsize=1024 k 2024-06-29 22:54:27 (11664): Guest Log: job: times= 2024-06-29 22:54:27 (11664): Guest Log: 0m0.019s 0m0.021s 2024-06-29 22:54:27 (11664): Guest Log: 308m37.728s 4m20.183s 2024-06-29 22:54:27 (11664): Guest Log: job: cpuusage=18778 2024-06-29 22:54:28 (11664): Guest Log: 22:46:30 AEST +10:00 2024-06-29: cranky: [INFO] Container 'runc' finished with status code 0. 2024-06-29 22:54:28 (11664): Guest Log: 22:46:30 AEST +10:00 2024-06-29: cranky: [INFO] Preparing output. 2024-06-29 22:54:29 (11664): Guest Log: [INFO] Job Finished 2024-06-29 22:54:30 (11664): Guest Log: [INFO] Shutting Down. 2024-06-29 22:54:30 (11664): VM Completion File Detected. 2024-06-29 22:54:30 (11664): VM Completion Message: Job Finished . 2024-06-29 22:54:30 (11664): Powering off VM. 2024-06-29 22:54:32 (11664): Successfully stopped VM. 2024-06-29 22:54:32 (11664): Deregistering VM. (boinc_be9255f6b638f701, slot#3) 2024-06-29 22:54:32 (11664): Removing network bandwidth throttle group from VM. 2024-06-29 22:54:33 (11664): Removing VM from VirtualBox. 2024-06-29 22:54:38 (11664): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN