Name | Theory_2743-2759306-287_2 |
Workunit | 223869620 |
Created | 3 Jul 2024, 14:11:04 UTC |
Sent | 3 Jul 2024, 16:32:24 UTC |
Report deadline | 14 Jul 2024, 16:32:24 UTC |
Received | 6 Jul 2024, 22:20:24 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10677116 |
Run time | 52 min 30 sec |
CPU time | 40 min 54 sec |
Validate state | Valid |
Credit | 40.13 |
Device peak FLOPS | 5.50 GFLOPS |
Application version | Theory Simulation v300.30 (vbox64_theory) windows_x86_64 |
Peak working set size | 84.37 MB |
Peak swap size | 76.32 MB |
Peak disk usage | 1.43 GB |
<core_client_version>7.24.1</core_client_version> <![CDATA[ <stderr_txt> ainer 'runc'. 2024-07-03 23:58:22 (30980): Guest Log: job: htmld=/shared/html/job 2024-07-03 23:58:22 (30980): Guest Log: job: unpack exitcode=0 2024-07-03 23:58:22 (30980): Guest Log: INFO: activated the work-around for ld: 2024-07-03 23:58:22 (30980): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 20:34 /tmp/tmp.cTZKNjw5OE/ld -> /usr/bin/ld.bfd 2024-07-03 23:58:22 (30980): Guest Log: 22:34:29 CEST +02:00 2024-07-03: cranky: [INFO] ===> [runRivet] Wed Jul 3 20:34:27 UTC 2024 [boinc pp jets 7000 150,-,2160 - pythia6 6.428 z1 40000 287] 2024-07-03 23:58:22 (30980): Starting VM using VBoxManage interface. (boinc_27ecd44048826e3e, slot#2) 2024-07-03 23:58:33 (30980): Successfully started VM. (PID = '29548') 2024-07-03 23:58:33 (30980): Reporting VM Process ID to BOINC. 2024-07-03 23:58:33 (30980): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-03 23:58:33 (30980): Detected: Web Application Enabled (http://localhost:53106) 2024-07-03 23:58:34 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:58:51 (30980): Preference change detected 2024-07-03 23:58:51 (30980): Setting CPU throttle for VM. (100%) 2024-07-03 23:58:52 (30980): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-03 23:58:52 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 23:58:58 (30980): Guest Log: 00:05:01.731988 timesync vgsvcTimeSyncWorker: Radical host time change: 4 319 590 000 000ns (HostNow=1 720 043 938 237 000 000 ns HostLast=1 720 039 618 647 000 000 ns) 2024-07-03 23:59:02 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:59:22 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 23:59:28 (30980): Guest Log: 00:05:11.763345 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 893 032 901 000ns (GuestNow=1 720 043 948 272 193 000 ns GuestLast=1 720 039 055 239 292 000 ns fSetTimeLastLoop=true ) 2024-07-03 23:59:32 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:59:52 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:00:02 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:00:22 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:00:32 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:00:52 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:01:02 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:01:22 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:01:32 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:01:52 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:02:02 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:02:22 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:02:33 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:02:53 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:03:04 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:03:23 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:03:34 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:03:52 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:04:04 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:04:23 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:04:34 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:04:53 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:05:03 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:05:23 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:05:33 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:05:53 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:06:03 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:06:22 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:06:34 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:06:53 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:07:04 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:07:23 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:07:34 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:07:53 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:08:04 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:08:23 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:08:36 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:08:54 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:09:05 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:09:24 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:09:36 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:09:54 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:10:05 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:10:24 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:10:35 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:10:54 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:11:05 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:11:24 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:12:27 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:12:54 (30980): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:13:44 (30980): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:13:48 (30980): Stopping VM. 2024-07-04 16:25:06 (23304): vboxwrapper version 26207 2024-07-04 16:25:06 (23304): BOINC client version: 7.24.1 2024-07-04 16:25:07 (23304): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-04 16:25:07 (23304): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-04 16:25:09 (23304): Guest Log: 00:05:01.731988 timesync vgsvcTimeSyncWorker: Radical host time change: 4 319 590 000 000ns (HostNow=1 720 043 938 237 000 000 ns HostLast=1 720 039 618 647 000 000 ns) 2024-07-04 16:25:09 (23304): Guest Log: 00:05:11.763345 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 893 032 901 000ns (GuestNow=1 720 043 948 272 193 000 ns GuestLast=1 720 039 055 239 292 000 ns fSetTimeLastLoop=true ) 2024-07-04 16:25:09 (23304): Starting VM using VBoxManage interface. (boinc_27ecd44048826e3e, slot#2) 2024-07-04 16:25:23 (23304): Successfully started VM. (PID = '37668') 2024-07-04 16:25:23 (23304): Reporting VM Process ID to BOINC. 2024-07-04 16:25:23 (23304): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-04 16:25:23 (23304): Guest Log: CPUID EDX: 0x178bfbff 2024-07-04 16:25:23 (23304): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-04 16:25:23 (23304): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-04 16:25:23 (23304): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-04 16:25:23 (23304): Detected: Web Application Enabled (http://localhost:53106) 2024-07-04 16:25:24 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:25:57 (23304): Preference change detected 2024-07-04 16:25:57 (23304): Setting CPU throttle for VM. (100%) 2024-07-04 16:25:57 (23304): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-04 16:25:58 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:25:59 (23304): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-04 16:25:59 (23304): Guest Log: BIOS: Booting from Hard Disk... 2024-07-04 16:26:01 (23304): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-04 16:26:01 (23304): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-04 16:26:08 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:26:28 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:26:38 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:26:58 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:27:02 (23304): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-04 16:27:02 (23304): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-04 16:27:06 (23304): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.000109 main Log opened 2024-07-04T14:26:48.922959000Z 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.000270 main OS Product: Linux 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.000334 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.000376 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.000419 main Executable: /usr/sbin/VBoxService 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.000420 main Process ID: 3216 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.000420 main Package type: LINUX_64BITS_GENERIC 2024-07-04 16:27:06 (23304): Guest Log: 00:00:00.004253 main 5.2.6 r120293 started. Verbose level = 0 2024-07-04 16:27:08 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:27:28 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:27:38 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:27:58 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:28:01 (23304): Guest Log: 16:27:04 CEST +02:00 2024-07-04: cranky: [INFO] Detected Theory App 2024-07-04 16:28:01 (23304): Guest Log: 16:27:04 CEST +02:00 2024-07-04: cranky: [INFO] Checking CVMFS. 2024-07-04 16:28:01 (23304): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-04 16:28:02 (23304): 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-07-04 16:28:02 (23304): Guest Log: 2.5.2.0 4062 0 28624 29848 3 1 1049554 4096000 0 65024 0 0 n/a 5 11 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-04 16:28:02 (23304): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-04 16:28:03 (23304): 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-07-04 16:28:03 (23304): Guest Log: 2.5.2.0 4082 0 27680 24631 3 2 1049554 4096000 0 65024 0 2 0 5818 12565 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-04 16:28:03 (23304): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-04 16:28:04 (23304): 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-07-04 16:28:04 (23304): Guest Log: 2.5.2.0 4106 0 27176 272 3 1 1049554 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-04 16:28:04 (23304): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-04 16:28:05 (23304): 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-07-04 16:28:05 (23304): Guest Log: 2.5.2.0 4039 0 39648 19062 3 1 1049554 4096000 0 65024 0 0 n/a 5563 16655 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-04 16:28:05 (23304): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Checking runc. 2024-07-04 16:28:05 (23304): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Creating the filesystem. 2024-07-04 16:28:05 (23304): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-04 16:28:05 (23304): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Updating config.json. 2024-07-04 16:28:05 (23304): Guest Log: 16:27:09 CEST +02:00 2024-07-04: cranky: [INFO] Running Container 'runc'. 2024-07-04 16:28:06 (23304): Guest Log: job: htmld=/shared/html/job 2024-07-04 16:28:06 (23304): Guest Log: job: unpack exitcode=0 2024-07-04 16:28:06 (23304): Guest Log: INFO: activated the work-around for ld: 2024-07-04 16:28:06 (23304): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 4 14:27 /tmp/tmp.njjlmq0Rzr/ld -> /usr/bin/ld.bfd 2024-07-04 16:28:07 (23304): Guest Log: 16:27:11 CEST +02:00 2024-07-04: cranky: [INFO] ===> [runRivet] Thu Jul 4 14:27:09 UTC 2024 [boinc pp jets 7000 150,-,2160 - pythia6 6.428 z1 40000 287] 2024-07-04 16:28:09 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:28:47 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:28:57 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:29:17 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:29:28 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:29:48 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:29:58 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:30:18 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:30:28 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:30:48 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:30:58 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:31:18 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:31:28 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:31:48 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:31:58 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:32:18 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:32:28 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:32:48 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:32:58 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:33:18 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:33:28 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:33:48 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:33:58 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:34:18 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:34:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:34:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:34:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:35:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:35:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:35:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:35:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:36:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:36:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:36:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:36:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:37:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:37:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:37:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:37:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:38:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:38:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:38:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:38:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:39:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:39:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:39:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:39:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:40:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:40:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:40:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:40:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:41:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:41:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:41:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:41:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:42:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:42:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:42:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:42:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:43:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:43:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:43:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:43:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:44:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:44:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:44:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:44:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:45:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:45:30 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:45:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:45:59 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:46:19 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:46:29 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:46:49 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:47:00 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:47:20 (23304): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:47:31 (23304): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:47:45 (23304): Stopping VM. 2024-07-04 16:47:50 (23304): Successfully stopped VM. 2024-07-04 21:12:51 (23856): vboxwrapper version 26207 2024-07-04 21:12:51 (23856): BOINC client version: 7.24.1 2024-07-04 21:12:52 (23856): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-04 21:12:52 (23856): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-04 21:12:53 (23856): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-04 21:12:53 (23856): Guest Log: CPUID EDX: 0x178bfbff 2024-07-04 21:12:53 (23856): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-04 21:12:53 (23856): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-04 21:12:53 (23856): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-04 21:12:53 (23856): Guest Log: BIOS: Booting from Hard Disk... 2024-07-04 21:12:53 (23856): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-04 21:12:53 (23856): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-04 21:12:53 (23856): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-04 21:12:53 (23856): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-04 21:12:53 (23856): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.000109 main Log opened 2024-07-04T14:26:48.922959000Z 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.000270 main OS Product: Linux 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.000334 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.000376 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.000419 main Executable: /usr/sbin/VBoxService 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.000420 main Process ID: 3216 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.000420 main Package type: LINUX_64BITS_GENERIC 2024-07-04 21:12:53 (23856): Guest Log: 00:00:00.004253 main 5.2.6 r120293 started. Verbose level = 0 2024-07-04 21:12:53 (23856): Guest Log: 16:27:04 CEST +02:00 2024-07-04: cranky: [INFO] Detected Theory App 2024-07-04 21:12:53 (23856): Guest Log: 16:27:04 CEST +02:00 2024-07-04: cranky: [INFO] Checking CVMFS. 2024-07-04 21:12:53 (23856): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-04 21:12:53 (23856): 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-07-04 21:12:53 (23856): Guest Log: 2.5.2.0 4062 0 28624 29848 3 1 1049554 4096000 0 65024 0 0 n/a 5 11 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-04 21:12:53 (23856): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-04 21:12:53 (23856): 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-07-04 21:12:53 (23856): Guest Log: 2.5.2.0 4082 0 27680 24631 3 2 1049554 4096000 0 65024 0 2 0 5818 12565 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-04 21:12:53 (23856): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-04 21:12:53 (23856): 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-07-04 21:12:53 (23856): Guest Log: 2.5.2.0 4106 0 27176 272 3 1 1049554 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-04 21:12:53 (23856): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-04 21:12:53 (23856): 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-07-04 21:12:53 (23856): Guest Log: 2.5.2.0 4039 0 39648 19062 3 1 1049554 4096000 0 65024 0 0 n/a 5563 16655 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-04 21:12:53 (23856): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Checking runc. 2024-07-04 21:12:53 (23856): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Creating the filesystem. 2024-07-04 21:12:53 (23856): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-04 21:12:53 (23856): Guest Log: 16:27:08 CEST +02:00 2024-07-04: cranky: [INFO] Updating config.json. 2024-07-04 21:12:53 (23856): Guest Log: 16:27:09 CEST +02:00 2024-07-04: cranky: [INFO] Running Container 'runc'. 2024-07-04 21:12:53 (23856): Guest Log: job: htmld=/shared/html/job 2024-07-04 21:12:53 (23856): Guest Log: job: unpack exitcode=0 2024-07-04 21:12:53 (23856): Guest Log: INFO: activated the work-around for ld: 2024-07-04 21:12:53 (23856): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 4 14:27 /tmp/tmp.njjlmq0Rzr/ld -> /usr/bin/ld.bfd 2024-07-04 21:12:53 (23856): Guest Log: 16:27:11 CEST +02:00 2024-07-04: cranky: [INFO] ===> [runRivet] Thu Jul 4 14:27:09 UTC 2024 [boinc pp jets 7000 150,-,2160 - pythia6 6.428 z1 40000 287] 2024-07-04 21:12:53 (23856): Starting VM using VBoxManage interface. (boinc_27ecd44048826e3e, slot#2) 2024-07-04 21:13:03 (23856): Successfully started VM. (PID = '31800') 2024-07-04 21:13:03 (23856): Reporting VM Process ID to BOINC. 2024-07-04 21:13:03 (23856): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-04 21:13:03 (23856): Detected: Web Application Enabled (http://localhost:53106) 2024-07-04 21:13:04 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:13:22 (23856): Preference change detected 2024-07-04 21:13:22 (23856): Setting CPU throttle for VM. (100%) 2024-07-04 21:13:23 (23856): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-04 21:13:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:13:30 (23856): Guest Log: 00:07:10.312433 timesync vgsvcTimeSyncWorker: Radical host time change: 15 959 616 000 000ns (HostNow=1 720 120 409 960 000 000 ns HostLast=1 720 104 450 344 000 000 ns) 2024-07-04 21:13:33 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:13:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:14:00 (23856): Guest Log: 00:07:20.342467 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 780 838 397 000ns (GuestNow=1 720 120 420 014 413 000 ns GuestLast=1 720 103 639 176 016 000 ns fSetTimeLastLoop=true ) 2024-07-04 21:14:03 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:14:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:14:33 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:14:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:15:04 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:15:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:15:34 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:15:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:16:05 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:16:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:16:34 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:16:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:17:03 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:17:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:17:33 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:17:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:18:05 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:18:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:18:34 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:18:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:19:03 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:19:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:19:33 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:19:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:20:04 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:20:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:20:35 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:20:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:21:04 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:21:24 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:21:34 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:21:54 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:22:04 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:22:24 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:22:34 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:22:54 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:23:05 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:23:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:23:33 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:23:53 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:24:04 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:24:23 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:24:35 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:24:54 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:25:06 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:25:24 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:25:38 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:25:54 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:26:06 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:26:24 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:26:36 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:26:54 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:27:06 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:27:25 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:27:37 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:27:55 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:28:07 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:28:25 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:28:55 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:29:15 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:29:27 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:29:44 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:29:55 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:30:15 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:30:27 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:30:45 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:30:55 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:31:15 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:31:26 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:31:45 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:31:57 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:32:15 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:32:26 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:32:45 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:32:55 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:33:14 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:33:26 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:33:45 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:33:56 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:34:14 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:34:24 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:34:45 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:34:58 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:35:16 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:35:59 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:36:26 (23856): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:37:33 (23856): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:37:33 (23856): Stopping VM. 2024-07-04 21:37:39 (23856): Successfully stopped VM. 2024-07-04 23:29:38 (8936): vboxwrapper version 26207 2024-07-04 23:29:38 (8936): BOINC client version: 7.24.1 2024-07-04 23:29:39 (8936): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-04 23:29:39 (8936): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-04 23:29:40 (8936): Guest Log: 00:07:10.312433 timesync vgsvcTimeSyncWorker: Radical host time change: 15 959 616 000 000ns (HostNow=1 720 120 409 960 000 000 ns HostLast=1 720 104 450 344 000 000 ns) 2024-07-04 23:29:40 (8936): Guest Log: 00:07:20.342467 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 780 838 397 000ns (GuestNow=1 720 120 420 014 413 000 ns GuestLast=1 720 103 639 176 016 000 ns fSetTimeLastLoop=true ) 2024-07-04 23:29:40 (8936): Starting VM using VBoxManage interface. (boinc_27ecd44048826e3e, slot#2) 2024-07-04 23:29:49 (8936): Successfully started VM. (PID = '8088') 2024-07-04 23:29:49 (8936): Reporting VM Process ID to BOINC. 2024-07-04 23:29:49 (8936): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-04 23:29:49 (8936): Detected: Web Application Enabled (http://localhost:53106) 2024-07-04 23:29:50 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:30:09 (8936): Preference change detected 2024-07-04 23:30:09 (8936): Setting CPU throttle for VM. (100%) 2024-07-04 23:30:10 (8936): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-04 23:30:10 (8936): Guest Log: 00:17:50.654328 timesync vgsvcTimeSyncWorker: Radical host time change: 6 764 550 000 000ns (HostNow=1 720 128 610 297 000 000 ns HostLast=1 720 121 845 747 000 000 ns) 2024-07-04 23:30:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:30:20 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:30:40 (8936): Guest Log: 00:18:00.668692 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 569 985 114 000ns (GuestNow=1 720 128 620 311 373 000 ns GuestLast=1 720 121 050 326 259 000 ns fSetTimeLastLoop=true ) 2024-07-04 23:30:40 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:30:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:31:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:31:23 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:31:41 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:31:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:32:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:32:20 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:32:40 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:32:50 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:33:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:33:21 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:33:41 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:33:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:34:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:34:20 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:34:40 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:34:50 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:35:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:35:20 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:35:40 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:35:50 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:36:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:36:20 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:36:40 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:36:50 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:37:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:37:20 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:37:40 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:37:50 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:38:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:38:21 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:38:41 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:38:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:39:11 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:39:21 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:39:41 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:39:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:40:10 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:40:21 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:40:41 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:40:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:41:11 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:41:21 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:41:41 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:41:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:42:11 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:42:21 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:42:41 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:42:51 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:43:11 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:43:22 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:43:42 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:43:52 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:44:12 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:44:22 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:44:42 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:44:52 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 23:45:11 (8936): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 23:45:21 (8936): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:52:15 (2480): vboxwrapper version 26207 2024-07-05 13:52:15 (2480): BOINC client version: 7.24.1 2024-07-05 13:52:16 (2480): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-05 13:52:16 (2480): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-05 13:52:17 (2480): Guest Log: 00:17:50.654328 timesync vgsvcTimeSyncWorker: Radical host time change: 6 764 550 000 000ns (HostNow=1 720 128 610 297 000 000 ns HostLast=1 720 121 845 747 000 000 ns) 2024-07-05 13:52:17 (2480): Guest Log: 00:18:00.668692 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 569 985 114 000ns (GuestNow=1 720 128 620 311 373 000 ns GuestLast=1 720 121 050 326 259 000 ns fSetTimeLastLoop=true ) 2024-07-05 13:52:17 (2480): Starting VM using VBoxManage interface. (boinc_27ecd44048826e3e, slot#2) 2024-07-05 13:52:25 (2480): Successfully started VM. (PID = '12332') 2024-07-05 13:52:25 (2480): Reporting VM Process ID to BOINC. 2024-07-05 13:52:25 (2480): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-05 13:52:25 (2480): Guest Log: CPUID EDX: 0x178bfbff 2024-07-05 13:52:25 (2480): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-05 13:52:25 (2480): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-05 13:52:25 (2480): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-05 13:52:25 (2480): Detected: Web Application Enabled (http://localhost:53106) 2024-07-05 13:52:25 (2480): Preference change detected 2024-07-05 13:52:25 (2480): Setting CPU throttle for VM. (100%) 2024-07-05 13:52:25 (2480): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-05 13:52:27 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:53:07 (2480): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-05 13:53:07 (2480): Guest Log: BIOS: Booting from Hard Disk... 2024-07-05 13:53:07 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:53:09 (2480): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-05 13:53:09 (2480): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-05 13:53:17 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:53:37 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:53:56 (2480): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-05 13:53:56 (2480): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-05 13:53:58 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:54:17 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:54:19 (2480): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.000137 main Log opened 2024-07-05T11:53:45.892308000Z 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.000314 main OS Product: Linux 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.000360 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.000385 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.000409 main Executable: /usr/sbin/VBoxService 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.000409 main Process ID: 3213 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.000410 main Package type: LINUX_64BITS_GENERIC 2024-07-05 13:54:19 (2480): Guest Log: 00:00:00.006974 main 5.2.6 r120293 started. Verbose level = 0 2024-07-05 13:54:27 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:54:47 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:54:57 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:55:37 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:55:41 (2480): Guest Log: 13:54:08 CEST +02:00 2024-07-05: cranky: [INFO] Detected Theory App 2024-07-05 13:55:41 (2480): Guest Log: 13:54:08 CEST +02:00 2024-07-05: cranky: [INFO] Checking CVMFS. 2024-07-05 13:55:41 (2480): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-05 13:55:41 (2480): 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-07-05 13:55:41 (2480): Guest Log: 2.5.2.0 4038 0 28444 29856 3 1 1076190 4096000 0 65024 0 0 n/a 5 10 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-05 13:55:42 (2480): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-05 13:55:42 (2480): 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-07-05 13:55:42 (2480): Guest Log: 2.5.2.0 4061 0 27620 24639 3 2 1076190 4096000 0 65024 0 2 0 5818 5540 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-05 13:55:42 (2480): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-05 13:55:42 (2480): 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-07-05 13:55:42 (2480): Guest Log: 2.5.2.0 4086 0 28400 272 3 1 1076190 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-05 13:55:43 (2480): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-05 13:55:43 (2480): 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-07-05 13:55:43 (2480): Guest Log: 2.5.2.0 4111 0 40528 19068 3 1 1076190 4096000 0 65024 0 0 n/a 5565 9244 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-05 13:55:43 (2480): Guest Log: 13:54:10 CEST +02:00 2024-07-05: cranky: [INFO] Checking runc. 2024-07-05 13:55:43 (2480): Guest Log: 13:54:10 CEST +02:00 2024-07-05: cranky: [INFO] Creating the filesystem. 2024-07-05 13:55:43 (2480): Guest Log: 13:54:10 CEST +02:00 2024-07-05: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-05 13:55:43 (2480): Guest Log: 13:54:11 CEST +02:00 2024-07-05: cranky: [INFO] Updating config.json. 2024-07-05 13:55:43 (2480): Guest Log: 13:54:11 CEST +02:00 2024-07-05: cranky: [INFO] Running Container 'runc'. 2024-07-05 13:55:44 (2480): Guest Log: job: htmld=/shared/html/job 2024-07-05 13:55:44 (2480): Guest Log: job: unpack exitcode=0 2024-07-05 13:55:44 (2480): Guest Log: INFO: activated the work-around for ld: 2024-07-05 13:55:44 (2480): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 5 11:54 /tmp/tmp.knSBWeysYH/ld -> /usr/bin/ld.bfd 2024-07-05 13:55:45 (2480): Guest Log: 13:54:13 CEST +02:00 2024-07-05: cranky: [INFO] ===> [runRivet] Fri Jul 5 11:54:11 UTC 2024 [boinc pp jets 7000 150,-,2160 - pythia6 6.428 z1 40000 287] 2024-07-05 13:55:47 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:56:07 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:56:17 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:56:57 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:57:07 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:57:27 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:57:37 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:57:57 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 13:58:07 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 13:58:27 (2480): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 14:05:28 (2480): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 14:05:31 (2480): Stopping VM. 2024-07-05 14:05:36 (2480): Successfully stopped VM. 2024-07-05 18:18:46 (35516): vboxwrapper version 26207 2024-07-05 18:18:46 (35516): BOINC client version: 7.24.1 2024-07-05 18:18:47 (35516): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-05 18:18:47 (35516): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-05 18:18:48 (35516): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-05 18:18:48 (35516): Guest Log: CPUID EDX: 0x178bfbff 2024-07-05 18:18:48 (35516): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-05 18:18:48 (35516): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-05 18:18:48 (35516): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-05 18:18:48 (35516): Guest Log: BIOS: Booting from Hard Disk... 2024-07-05 18:18:48 (35516): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-05 18:18:48 (35516): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-05 18:18:48 (35516): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-05 18:18:48 (35516): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-05 18:18:48 (35516): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.000137 main Log opened 2024-07-05T11:53:45.892308000Z 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.000314 main OS Product: Linux 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.000360 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.000385 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.000409 main Executable: /usr/sbin/VBoxService 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.000409 main Process ID: 3213 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.000410 main Package type: LINUX_64BITS_GENERIC 2024-07-05 18:18:48 (35516): Guest Log: 00:00:00.006974 main 5.2.6 r120293 started. Verbose level = 0 2024-07-05 18:18:48 (35516): Guest Log: 13:54:08 CEST +02:00 2024-07-05: cranky: [INFO] Detected Theory App 2024-07-05 18:18:48 (35516): Guest Log: 13:54:08 CEST +02:00 2024-07-05: cranky: [INFO] Checking CVMFS. 2024-07-05 18:18:48 (35516): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-05 18:18:48 (35516): 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-07-05 18:18:48 (35516): Guest Log: 2.5.2.0 4038 0 28444 29856 3 1 1076190 4096000 0 65024 0 0 n/a 5 10 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-05 18:18:48 (35516): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-05 18:18:48 (35516): 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-07-05 18:18:48 (35516): Guest Log: 2.5.2.0 4061 0 27620 24639 3 2 1076190 4096000 0 65024 0 2 0 5818 5540 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-05 18:18:48 (35516): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-05 18:18:48 (35516): 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-07-05 18:18:48 (35516): Guest Log: 2.5.2.0 4086 0 28400 272 3 1 1076190 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-05 18:18:48 (35516): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-05 18:18:48 (35516): 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-07-05 18:18:48 (35516): Guest Log: 2.5.2.0 4111 0 40528 19068 3 1 1076190 4096000 0 65024 0 0 n/a 5565 9244 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-05 18:18:48 (35516): Guest Log: 13:54:10 CEST +02:00 2024-07-05: cranky: [INFO] Checking runc. 2024-07-05 18:18:48 (35516): Guest Log: 13:54:10 CEST +02:00 2024-07-05: cranky: [INFO] Creating the filesystem. 2024-07-05 18:18:48 (35516): Guest Log: 13:54:10 CEST +02:00 2024-07-05: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-05 18:18:48 (35516): Guest Log: 13:54:11 CEST +02:00 2024-07-05: cranky: [INFO] Updating config.json. 2024-07-05 18:18:48 (35516): Guest Log: 13:54:11 CEST +02:00 2024-07-05: cranky: [INFO] Running Container 'runc'. 2024-07-05 18:18:48 (35516): Guest Log: job: htmld=/shared/html/job 2024-07-05 18:18:48 (35516): Guest Log: job: unpack exitcode=0 2024-07-05 18:18:48 (35516): Guest Log: INFO: activated the work-around for ld: 2024-07-05 18:18:48 (35516): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 5 11:54 /tmp/tmp.knSBWeysYH/ld -> /usr/bin/ld.bfd 2024-07-05 18:18:48 (35516): Guest Log: 13:54:13 CEST +02:00 2024-07-05: cranky: [INFO] ===> [runRivet] Fri Jul 5 11:54:11 UTC 2024 [boinc pp jets 7000 150,-,2160 - pythia6 6.428 z1 40000 287] 2024-07-05 18:18:48 (35516): Starting VM using VBoxManage interface. (boinc_27ecd44048826e3e, slot#2) 2024-07-05 18:18:58 (35516): Successfully started VM. (PID = '27980') 2024-07-05 18:18:58 (35516): Reporting VM Process ID to BOINC. 2024-07-05 18:18:58 (35516): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-05 18:18:58 (35516): Detected: Web Application Enabled (http://localhost:53106) 2024-07-05 18:18:59 (35516): Guest Log: 00:08:11.966807 timesync vgsvcTimeSyncWorker: Radical host time change: 15 219 180 000 000ns (HostNow=1 720 196 338 093 000 000 ns HostLast=1 720 181 118 913 000 000 ns) 2024-07-05 18:18:59 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:19:17 (35516): Preference change detected 2024-07-05 18:19:17 (35516): Setting CPU throttle for VM. (100%) 2024-07-05 18:19:17 (35516): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-05 18:19:18 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:19:27 (35516): Guest Log: 00:08:22.008179 timesync vgsvcTimeSyncWorker: Radical guest time change: 15 430 397 472 000ns (GuestNow=1 720 196 348 147 260 000 ns GuestLast=1 720 180 917 749 788 000 ns fSetTimeLastLoop=true ) 2024-07-05 18:19:28 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:19:48 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:21:58 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:22:18 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:23:29 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:23:49 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:28:59 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:29:19 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:29:39 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:29:59 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:30:29 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:30:49 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:31:09 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:31:29 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:31:59 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:32:19 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:33:09 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:33:29 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:33:39 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:33:59 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:34:09 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:34:29 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:34:39 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:34:59 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:35:09 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:35:29 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:35:39 (35516): VM state change detected. (old = 'running', new = 'paused') 2024-07-05 18:35:59 (35516): VM state change detected. (old = 'paused', new = 'running') 2024-07-05 18:35:59 (35516): Stopping VM. 2024-07-05 18:36:01 (35516): Successfully stopped VM. 2024-07-06 21:18:53 (41908): vboxwrapper version 26207 2024-07-06 21:18:53 (41908): BOINC client version: 7.24.1 2024-07-06 21:18:54 (41908): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-06 21:18:54 (41908): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-06 21:18:55 (41908): Guest Log: 00:08:11.966807 timesync vgsvcTimeSyncWorker: Radical host time change: 15 219 180 000 000ns (HostNow=1 720 196 338 093 000 000 ns HostLast=1 720 181 118 913 000 000 ns) 2024-07-06 21:18:55 (41908): Guest Log: 00:08:22.008179 timesync vgsvcTimeSyncWorker: Radical guest time change: 15 430 397 472 000ns (GuestNow=1 720 196 348 147 260 000 ns GuestLast=1 720 180 917 749 788 000 ns fSetTimeLastLoop=true ) 2024-07-06 21:18:55 (41908): Starting VM using VBoxManage interface. (boinc_27ecd44048826e3e, slot#2) 2024-07-06 21:19:04 (41908): Successfully started VM. (PID = '31712') 2024-07-06 21:19:04 (41908): Reporting VM Process ID to BOINC. 2024-07-06 21:19:04 (41908): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-06 21:19:04 (41908): Detected: Web Application Enabled (http://localhost:53106) 2024-07-06 21:19:05 (41908): VM state change detected. (old = 'running', new = 'paused') 2024-07-06 21:19:24 (41908): Preference change detected 2024-07-06 21:19:24 (41908): Setting CPU throttle for VM. (100%) 2024-07-06 21:19:24 (41908): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-06 21:19:25 (41908): VM state change detected. (old = 'paused', new = 'running') 2024-07-06 21:19:30 (41908): Guest Log: 00:20:22.376258 timesync vgsvcTimeSyncWorker: Radical host time change: 96 233 070 000 000ns (HostNow=1 720 293 569 366 000 000 ns HostLast=1 720 197 336 296 000 000 ns) 2024-07-06 21:19:35 (41908): VM state change detected. (old = 'running', new = 'paused') 2024-07-06 21:19:55 (41908): VM state change detected. (old = 'paused', new = 'running') 2024-07-06 21:20:00 (41908): Guest Log: 00:20:32.379933 timesync vgsvcTimeSyncWorker: Radical guest time change: 96 510 855 571 000ns (GuestNow=1 720 293 579 378 028 000 ns GuestLast=1 720 197 068 522 457 000 ns fSetTimeLastLoop=true ) 2024-07-06 21:20:05 (41908): VM state change detected. (old = 'running', new = 'paused') 2024-07-06 21:20:25 (41908): VM state change detected. (old = 'paused', new = 'running') 2024-07-06 21:20:45 (41908): VM state change detected. (old = 'running', new = 'paused') 2024-07-06 21:21:05 (41908): VM state change detected. (old = 'paused', new = 'running') 2024-07-06 21:22:51 (41908): Guest Log: job: run exitcode=0 2024-07-06 21:22:51 (41908): Guest Log: job: diskusage=2968 2024-07-06 21:22:51 (41908): Guest Log: job: logsize=40 k 2024-07-06 21:22:51 (41908): Guest Log: job: times= 2024-07-06 21:22:51 (41908): Guest Log: 0m0.003s 0m0.007s 2024-07-06 21:22:51 (41908): Guest Log: 12m56.470s 0m8.067s 2024-07-06 21:22:51 (41908): Guest Log: job: cpuusage=785 2024-07-06 21:22:51 (41908): Guest Log: 21:21:50 CEST +02:00 2024-07-06: cranky: [INFO] Container 'runc' finished with status code 0. 2024-07-06 21:22:51 (41908): Guest Log: 21:21:50 CEST +02:00 2024-07-06: cranky: [INFO] Preparing output. 2024-07-06 21:22:51 (41908): Guest Log: [INFO] Job Finished 2024-07-06 21:22:51 (41908):
©2024 CERN