| Name | Theory_2390-1129091-504_1 |
| Workunit | 212849227 |
| Created | 17 Jul 2023, 16:12:24 UTC |
| Sent | 17 Jul 2023, 19:34:21 UTC |
| Report deadline | 28 Jul 2023, 19:34:21 UTC |
| Received | 29 Jul 2023, 6:20:36 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10682171 |
| Run time | 4 hours 26 min 54 sec |
| CPU time | 4 hours 18 min 8 sec |
| Validate state | Valid |
| Credit | 225.95 |
| Device peak FLOPS | 6.10 GFLOPS |
| Application version | Theory Simulation v300.07 (vbox64_theory) windows_x86_64 |
| Peak working set size | 84.74 MB |
| Peak swap size | 76.97 MB |
| Peak disk usage | 1.83 GB |
Stderr output
<core_client_version>7.22.2</core_client_version> <![CDATA[ <stderr_txt> 2023-07-27 14:27:56 (180): Detected: vboxwrapper 26206 2023-07-27 14:27:56 (180): Detected: BOINC client v7.22.2 2023-07-27 14:27:57 (180): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2023-07-27 14:27:57 (180): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-07-27 14:27:57 (180): Successfully copied 'init_data.xml' to the shared directory. 2023-07-27 14:27:57 (180): Successfully copied 'input' to the shared directory. 2023-07-27 14:27:59 (180): Create VM. (boinc_7f376b9b0972046d, slot#12) 2023-07-27 14:28:00 (180): Setting Memory Size for VM. (630MB) 2023-07-27 14:28:00 (180): Setting CPU Count for VM. (1) 2023-07-27 14:28:01 (180): Setting Chipset Options for VM. 2023-07-27 14:28:02 (180): Setting Graphics Controller Options for VM. 2023-07-27 14:28:02 (180): Setting Boot Options for VM. 2023-07-27 14:28:03 (180): Setting Network Configuration for NAT. 2023-07-27 14:28:03 (180): Enabling VM Network Access. 2023-07-27 14:28:03 (180): Disabling USB Support for VM. 2023-07-27 14:28:04 (180): Disabling COM Port Support for VM. 2023-07-27 14:28:04 (180): Disabling LPT Port Support for VM. 2023-07-27 14:28:04 (180): Disabling Audio Support for VM. 2023-07-27 14:28:04 (180): Disabling Clipboard Support for VM. 2023-07-27 14:28:05 (180): Disabling Drag and Drop Support for VM. 2023-07-27 14:28:05 (180): Adding storage controller(s) to VM. 2023-07-27 14:28:06 (180): Adding virtual disk drive to VM. (vm_image.vdi) 2023-07-27 14:28:07 (180): Adding VirtualBox Guest Additions to VM. 2023-07-27 14:28:07 (180): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2023-07-27 14:28:07 (180): forwarding host port 50996 to guest port 80 2023-07-27 14:28:08 (180): Enabling remote desktop for VM. 2023-07-27 14:28:08 (180): Required extension pack not installed, remote desktop not enabled. 2023-07-27 14:28:08 (180): Enabling shared directory for VM. 2023-07-27 14:28:08 (180): Starting VM using VBoxManage interface. (boinc_7f376b9b0972046d, slot#12) 2023-07-27 14:28:28 (180): Successfully started VM. (PID = '19324') 2023-07-27 14:28:28 (180): Reporting VM Process ID to BOINC. 2023-07-27 14:28:28 (180): Guest Log: BIOS: VirtualBox 7.0.6 2023-07-27 14:28:28 (180): Guest Log: CPUID EDX: 0x178bfbff 2023-07-27 14:28:28 (180): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-07-27 14:28:28 (180): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-07-27 14:28:28 (180): VM state change detected. (old = 'poweredoff', new = 'running') 2023-07-27 14:28:28 (180): Detected: Web Application Enabled (http://localhost:50996) 2023-07-27 14:28:28 (180): Preference change detected 2023-07-27 14:28:28 (180): Setting CPU throttle for VM. (100%) 2023-07-27 14:28:28 (180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-07-27 14:28:30 (180): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-07-27 14:28:30 (180): Guest Log: BIOS: Booting from Hard Disk... 2023-07-27 14:28:33 (180): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-07-27 14:28:33 (180): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-07-27 14:28:49 (180): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-07-27 14:28:49 (180): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-07-27 14:28:51 (180): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.000112 main Log opened 2023-07-27T12:28:51.470096000Z 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.000260 main OS Product: Linux 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.000303 main OS Release: 4.14.76-13.cernvm.x86_64 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.000336 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.000371 main Executable: /usr/sbin/VBoxService 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.000372 main Process ID: 3216 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.000372 main Package type: LINUX_64BITS_GENERIC 2023-07-27 14:28:51 (180): Guest Log: 00:00:00.001923 main 5.2.6 r120293 started. Verbose level = 0 2023-07-27 14:29:20 (180): Guest Log: 14:29:20 CEST +02:00 2023-07-27: cranky: [INFO] Detected Theory App 2023-07-27 14:29:20 (180): Guest Log: 14:29:20 CEST +02:00 2023-07-27: cranky: [INFO] Checking CVMFS. 2023-07-27 14:29:21 (180): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-07-27 14:29:21 (180): 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 2023-07-27 14:29:21 (180): Guest Log: 2.5.2.0 4053 0 28288 26575 3 1 268524 4096000 0 65024 0 0 n/a 5 11 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-07-27 14:29:22 (180): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-07-27 14:29:22 (180): 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 2023-07-27 14:29:22 (180): Guest Log: 2.5.2.0 4051 0 27424 21823 3 2 268524 4096000 0 65024 0 2 -100 7812 1741 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-07-27 14:29:23 (180): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-07-27 14:29:23 (180): 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 2023-07-27 14:29:23 (180): Guest Log: 2.5.2.0 4115 0 27192 268 3 1 268524 4096000 0 65024 0 0 n/a 4 13 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-07-27 14:29:24 (180): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-07-27 14:29:24 (180): 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 2023-07-27 14:29:24 (180): Guest Log: 2.5.2.0 4093 0 35532 16213 3 1 268524 4096000 0 65024 0 0 n/a 4236 910 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2023-07-27 14:29:24 (180): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Checking runc. 2023-07-27 14:29:24 (180): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Creating the filesystem. 2023-07-27 14:29:24 (180): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-07-27 14:29:25 (180): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Updating config.json. 2023-07-27 14:29:25 (180): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Running Container 'runc'. 2023-07-27 14:29:49 (180): Guest Log: job: htmld=/shared/html/job 2023-07-27 14:29:50 (180): Guest Log: job: unpack exitcode=0 2023-07-27 14:29:51 (180): Guest Log: 14:29:50 CEST +02:00 2023-07-27: cranky: [INFO] ===> [runRivet] Thu Jul 27 12:29:50 UTC 2023 [boinc pp jets 7000 80,-,1760 - pythia8 8.235 fischerPP2 100000 504] 2023-07-27 14:36:36 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:36:56 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:38:57 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:39:17 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:39:38 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:39:58 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:40:07 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:40:28 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:40:37 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:40:57 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:41:07 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:41:27 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:41:37 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:41:57 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:42:07 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:42:27 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:42:37 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:42:57 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:43:08 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:43:28 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:43:38 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:43:58 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:44:08 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:44:28 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:44:38 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:44:58 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:45:07 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:45:28 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:45:47 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:46:07 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:46:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:46:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:46:48 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:47:08 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:47:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:47:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:47:48 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:48:08 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:48:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:48:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:48:58 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:49:18 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:49:28 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:49:48 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:49:58 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:50:18 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:50:28 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:50:48 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:50:58 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:51:18 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:51:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:51:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:52:09 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:52:29 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:52:38 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:52:58 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:53:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:53:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:53:48 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:54:08 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:54:28 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:54:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:54:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:55:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:55:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:55:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:55:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:56:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:56:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:56:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:56:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:57:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:57:28 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:57:48 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:57:58 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:58:18 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:58:28 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:58:48 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:58:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:59:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:59:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 14:59:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 14:59:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:00:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:00:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:00:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:00:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:01:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:01:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:01:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:01:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:02:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:02:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:02:50 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:03:00 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:03:20 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:03:30 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:03:50 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:03:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:04:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:04:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:04:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:04:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:05:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:05:29 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:05:49 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:05:59 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:06:19 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:12:21 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:12:41 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:17:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:17:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:19:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:19:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:20:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 15:20:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 15:29:44 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:16:37 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:16:39 (180): Guest Log: 00:41:31.741993 timesync vgsvcTimeSyncWorker: Radical host time change: 2 822 878 000 000ns (HostNow=1 690 467 398 537 000 000 ns HostLast=1 690 464 575 659 000 000 ns) 2023-07-27 16:16:46 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:17:06 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:17:09 (180): Guest Log: 00:41:41.770677 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 985 402 467 000ns (GuestNow=1 690 467 408 590 048 000 ns GuestLast=1 690 463 423 187 581 000 ns fSetTimeLastLoop=true ) 2023-07-27 16:20:07 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:20:27 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:22:07 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:22:27 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:23:58 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:24:18 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:24:28 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:24:48 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:24:58 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:25:18 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:25:47 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:26:07 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:27:08 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:27:28 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:27:38 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:27:58 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:28:17 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:28:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:28:58 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:29:18 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:29:37 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:29:58 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:30:08 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:30:28 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:30:38 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:30:58 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:31:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:31:39 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:31:48 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:32:09 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:32:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:32:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:32:48 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:33:08 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:33:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:33:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:33:48 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:34:08 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:34:18 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:34:38 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:34:48 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:35:08 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:35:19 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:35:39 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:36:09 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:36:29 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:36:39 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:36:59 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:37:09 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:37:29 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:37:40 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:38:00 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:38:09 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:38:30 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:38:39 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:39:00 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:39:10 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:39:30 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:39:40 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:40:00 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:40:10 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:40:50 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:41:00 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:42:40 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:43:10 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:43:30 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:43:40 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:44:01 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:44:11 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:44:31 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:44:41 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:45:00 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:45:10 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:45:30 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:45:50 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:46:10 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:46:30 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:46:50 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:47:11 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:47:31 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:47:41 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:48:01 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:48:11 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:48:31 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:48:41 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:49:00 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:49:10 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:49:30 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:49:51 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:50:11 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:50:21 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:50:41 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:50:51 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:51:11 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:51:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:51:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:52:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:52:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:52:30 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:52:50 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:53:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:53:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:53:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:53:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:54:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:54:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:54:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:54:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:55:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:55:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:55:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:55:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:56:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:56:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:56:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:56:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:57:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:57:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:57:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:57:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:58:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:58:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:58:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:58:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:59:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:59:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 16:59:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 16:59:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:00:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:00:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:00:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:00:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:01:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:01:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:01:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:01:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:02:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:02:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:02:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:02:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:03:01 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:03:21 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:03:31 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:03:51 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:04:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:04:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:04:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:04:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:05:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:05:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:05:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:05:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:06:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:06:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:06:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:06:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:07:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:07:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:07:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:07:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:08:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:08:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:08:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:08:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:09:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:09:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:09:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:09:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:10:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:10:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:10:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:10:52 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:11:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:11:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:11:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:11:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:12:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:12:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:12:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:12:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:13:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:13:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:13:32 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:13:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:14:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:14:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:14:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:14:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:15:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:15:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:15:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:15:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:16:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:16:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:16:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:16:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:17:02 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:17:22 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:17:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:17:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:18:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:18:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:18:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:18:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:19:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:19:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:19:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:19:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:20:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:20:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:20:34 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:20:54 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:21:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:21:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:21:34 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:21:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:22:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:22:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:22:33 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:22:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:23:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:23:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:23:34 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:23:53 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:24:03 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:24:23 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:24:34 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:24:54 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:25:04 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:25:24 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:25:34 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:25:54 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:26:44 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:27:04 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:30:24 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:30:44 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:34:55 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:35:15 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:38:16 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:38:36 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:39:16 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:39:36 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:43:36 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:43:56 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:48:37 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:48:57 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:49:26 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:49:46 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:50:37 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:50:57 (180): VM state change detected. (old = 'paused', new = 'running') 2023-07-27 17:52:57 (180): VM state change detected. (old = 'running', new = 'paused') 2023-07-27 17:52:58 (180): Stopping VM. 2023-07-27 17:52:59 (180): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_7f376b9b0972046d" savestate Output: 2023-07-27 17:52:59 (180): VM did not stop when requested. 2023-07-27 17:52:59 (180): VM was successfully terminated. 2023-07-29 05:15:11 (17960): Detected: vboxwrapper 26206 2023-07-29 05:15:11 (17960): Detected: BOINC client v7.22.2 2023-07-29 05:15:12 (17960): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2023-07-29 05:15:12 (17960): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-07-29 05:15:16 (17960): Guest Log: BIOS: VirtualBox 7.0.6 2023-07-29 05:15:16 (17960): Guest Log: CPUID EDX: 0x178bfbff 2023-07-29 05:15:16 (17960): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-07-29 05:15:16 (17960): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-07-29 05:15:16 (17960): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-07-29 05:15:16 (17960): Guest Log: BIOS: Booting from Hard Disk... 2023-07-29 05:15:16 (17960): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-07-29 05:15:16 (17960): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-07-29 05:15:16 (17960): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-07-29 05:15:16 (17960): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-07-29 05:15:16 (17960): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-07-29 05:15:16 (17960): Guest Log: 00:00:00.000112 main Log opened 2023-07-27T12:28:51.470096000Z 2023-07-29 05:15:16 (17960): Guest Log: 00:00:00.000260 main OS Product: Linux 2023-07-29 05:15:16 (17960): Guest Log: 00:00:00.000303 main OS Release: 4.14.76-13.cernvm.x86_64 2023-07-29 05:15:16 (17960): Guest Log: 00:00:00.000336 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-07-29 05:15:16 (17960): Guest Log: 00:00:00.000371 main Executable: /usr/sbin/VBoxService 2023-07-29 05:15:17 (17960): Guest Log: 00:00:00.000372 main Process ID: 3216 2023-07-29 05:15:17 (17960): Guest Log: 00:00:00.000372 main Package type: LINUX_64BITS_GENERIC 2023-07-29 05:15:17 (17960): Guest Log: 00:00:00.001923 main 5.2.6 r120293 started. Verbose level = 0 2023-07-29 05:15:17 (17960): Guest Log: 14:29:20 CEST +02:00 2023-07-27: cranky: [INFO] Detected Theory App 2023-07-29 05:15:17 (17960): Guest Log: 14:29:20 CEST +02:00 2023-07-27: cranky: [INFO] Checking CVMFS. 2023-07-29 05:15:17 (17960): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-07-29 05:15:17 (17960): 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 2023-07-29 05:15:17 (17960): Guest Log: 2.5.2.0 4053 0 28288 26575 3 1 268524 4096000 0 65024 0 0 n/a 5 11 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-07-29 05:15:17 (17960): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-07-29 05:15:17 (17960): 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 2023-07-29 05:15:17 (17960): Guest Log: 2.5.2.0 4051 0 27424 21823 3 2 268524 4096000 0 65024 0 2 -100 7812 1741 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-07-29 05:15:17 (17960): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-07-29 05:15:17 (17960): 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 2023-07-29 05:15:17 (17960): Guest Log: 2.5.2.0 4115 0 27192 268 3 1 268524 4096000 0 65024 0 0 n/a 4 13 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-07-29 05:15:17 (17960): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-07-29 05:15:17 (17960): 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 2023-07-29 05:15:17 (17960): Guest Log: 2.5.2.0 4093 0 35532 16213 3 1 268524 4096000 0 65024 0 0 n/a 4236 910 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2023-07-29 05:15:17 (17960): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Checking runc. 2023-07-29 05:15:17 (17960): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Creating the filesystem. 2023-07-29 05:15:17 (17960): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-07-29 05:15:17 (17960): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Updating config.json. 2023-07-29 05:15:17 (17960): Guest Log: 14:29:24 CEST +02:00 2023-07-27: cranky: [INFO] Running Container 'runc'. 2023-07-29 05:15:17 (17960): Guest Log: job: htmld=/shared/html/job 2023-07-29 05:15:17 (17960): Guest Log: job: unpack exitcode=0 2023-07-29 05:15:17 (17960): Guest Log: 14:29:50 CEST +02:00 2023-07-27: cranky: [INFO] ===> [runRivet] Thu Jul 27 12:29:50 UTC 2023 [boinc pp jets 7000 80,-,1760 - pythia8 8.235 fischerPP2 100000 504] 2023-07-29 05:15:17 (17960): Guest Log: 00:41:31.741993 timesync vgsvcTimeSyncWorker: Radical host time change: 2 822 878 000 000ns (HostNow=1 690 467 398 537 000 000 ns HostLast=1 690 464 575 659 000 000 ns) 2023-07-29 05:15:17 (17960): Guest Log: 00:41:41.770677 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 985 402 467 000ns (GuestNow=1 690 467 408 590 048 000 ns GuestLast=1 690 463 423 187 581 000 ns fSetTimeLastLoop=true ) 2023-07-29 05:15:17 (17960): Starting VM using VBoxManage interface. (boinc_7f376b9b0972046d, slot#12) 2023-07-29 05:15:24 (17960): Successfully started VM. (PID = '21028') 2023-07-29 05:15:24 (17960): Reporting VM Process ID to BOINC. 2023-07-29 05:15:24 (17960): Guest Log: BIOS: VirtualBox 7.0.6 2023-07-29 05:15:24 (17960): Guest Log: CPUID EDX: 0x178bfbff 2023-07-29 05:15:24 (17960): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-07-29 05:15:24 (17960): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-07-29 05:15:24 (17960): VM state change detected. (old = 'poweredoff', new = 'running') 2023-07-29 05:15:24 (17960): Detected: Web Application Enabled (http://localhost:50996) 2023-07-29 05:15:25 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:15:43 (17960): Preference change detected 2023-07-29 05:15:43 (17960): Setting CPU throttle for VM. (100%) 2023-07-29 05:15:43 (17960): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-07-29 05:15:43 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:15:44 (17960): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-07-29 05:15:44 (17960): Guest Log: BIOS: Booting from Hard Disk... 2023-07-29 05:15:46 (17960): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-07-29 05:15:46 (17960): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-07-29 05:16:05 (17960): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-07-29 05:16:05 (17960): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-07-29 05:16:08 (17960): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.000089 main Log opened 2023-07-29T03:16:09.139864000Z 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.000194 main OS Product: Linux 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.000246 main OS Release: 4.14.76-13.cernvm.x86_64 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.000276 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.000317 main Executable: /usr/sbin/VBoxService 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.000318 main Process ID: 3216 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.000318 main Package type: LINUX_64BITS_GENERIC 2023-07-29 05:16:08 (17960): Guest Log: 00:00:00.002169 main 5.2.6 r120293 started. Verbose level = 0 2023-07-29 05:16:36 (17960): Guest Log: 05:16:37 CEST +02:00 2023-07-29: cranky: [INFO] Detected Theory App 2023-07-29 05:16:36 (17960): Guest Log: 05:16:37 CEST +02:00 2023-07-29: cranky: [INFO] Checking CVMFS. 2023-07-29 05:16:37 (17960): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2023-07-29 05:16:38 (17960): 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 2023-07-29 05:16:38 (17960): Guest Log: 2.5.2.0 4091 0 27192 26584 3 1 1068962 4096001 0 65024 0 0 n/a 5 20 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2023-07-29 05:16:38 (17960): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2023-07-29 05:16:38 (17960): 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 2023-07-29 05:16:38 (17960): Guest Log: 2.5.2.0 4042 0 27468 21837 3 2 1068962 4096001 0 65024 0 2 0 5675 5154 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2023-07-29 05:16:39 (17960): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2023-07-29 05:16:39 (17960): 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 2023-07-29 05:16:39 (17960): Guest Log: 2.5.2.0 4063 0 25180 268 3 1 1068962 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2023-07-29 05:16:40 (17960): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2023-07-29 05:16:40 (17960): 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 2023-07-29 05:16:40 (17960): Guest Log: 2.5.2.0 4120 0 37572 16227 3 1 1068962 4096001 0 65024 0 0 n/a 4242 661 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2023-07-29 05:16:40 (17960): Guest Log: 05:16:40 CEST +02:00 2023-07-29: cranky: [INFO] Checking runc. 2023-07-29 05:16:40 (17960): Guest Log: 05:16:40 CEST +02:00 2023-07-29: cranky: [INFO] Creating the filesystem. 2023-07-29 05:16:40 (17960): Guest Log: 05:16:40 CEST +02:00 2023-07-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2023-07-29 05:16:40 (17960): Guest Log: 05:16:40 CEST +02:00 2023-07-29: cranky: [INFO] Updating config.json. 2023-07-29 05:16:40 (17960): Guest Log: 05:16:41 CEST +02:00 2023-07-29: cranky: [INFO] Running Container 'runc'. 2023-07-29 05:16:40 (17960): Guest Log: job: htmld=/shared/html/job 2023-07-29 05:16:40 (17960): Guest Log: job: unpack exitcode=0 2023-07-29 05:16:42 (17960): Guest Log: 05:16:43 CEST +02:00 2023-07-29: cranky: [INFO] ===> [runRivet] Sat Jul 29 03:16:41 UTC 2023 [boinc pp jets 7000 80,-,1760 - pythia8 8.235 fischerPP2 100000 504] 2023-07-29 05:22:54 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:23:14 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:23:24 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:23:44 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:24:15 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:24:35 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:25:04 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:25:24 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:25:35 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:25:55 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:26:54 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:27:15 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:27:30 (17960): Status Report: Job Duration: '864000.000000' 2023-07-29 05:27:30 (17960): Status Report: Elapsed Time: '6000.594444' 2023-07-29 05:27:30 (17960): Status Report: CPU Time: '5763.078125' 2023-07-29 05:27:35 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:27:55 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:29:55 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:30:15 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:35:26 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:35:46 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:37:46 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:38:06 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:42:37 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:42:57 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:48:47 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 05:49:07 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 05:59:58 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:00:18 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:05:19 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:05:39 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:10:30 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:10:50 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:21:21 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:21:41 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:32:32 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:32:52 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:44:04 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:44:24 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:46:54 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:47:14 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:55:45 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:56:05 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 06:57:06 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 06:57:26 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:05:46 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:06:06 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:07:06 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:07:26 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:11:07 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:11:28 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:12:27 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:12:47 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:15:08 (17960): Status Report: Job Duration: '864000.000000' 2023-07-29 07:15:08 (17960): Status Report: Elapsed Time: '12000.594444' 2023-07-29 07:15:08 (17960): Status Report: CPU Time: '11809.750000' 2023-07-29 07:16:38 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:16:58 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:17:58 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:18:18 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:28:20 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:28:40 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:39:11 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:39:31 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:40:31 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:40:51 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 07:49:52 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 07:50:12 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 08:00:33 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 08:00:53 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 08:08:34 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 08:08:54 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 08:11:44 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 08:12:04 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 08:13:05 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 08:13:25 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 08:16:55 (17960): VM state change detected. (old = 'running', new = 'paused') 2023-07-29 08:17:15 (17960): VM state change detected. (old = 'paused', new = 'running') 2023-07-29 08:20:21 (17960): Guest Log: job: run exitcode=0 2023-07-29 08:20:21 (17960): Guest Log: job: diskusage=2108 2023-07-29 08:20:21 (17960): Guest Log: job: logsize=68 k 2023-07-29 08:20:21 (17960): Guest Log: job: times= 2023-07-29 08:20:21 (17960): Guest Log: 0m0.004s 0m0.007s 2023-07-29 08:20:21 (17960): Guest Log: 169m46.633s 0m48.595s 2023-07-29 08:20:21 (17960): Guest Log: job: cpuusage=10235 2023-07-29 08:20:22 (17960): Guest Log: 08:08:25 CEST +02:00 2023-07-29: cranky: [INFO] Container 'runc' finished with status code 0. 2023-07-29 08:20:22 (17960): Guest Log: 08:08:25 CEST +02:00 2023-07-29: cranky: [INFO] Preparing output. 2023-07-29 08:20:22 (17960): Guest Log: [INFO] Job Finished 2023-07-29 08:20:22 (17960): Guest Log: [INFO] Shutting Down. 2023-07-29 08:20:22 (17960): VM Completion File Detected. 2023-07-29 08:20:22 (17960): VM Completion Message: Job Finished . 2023-07-29 08:20:22 (17960): Powering off VM. 2023-07-29 08:20:23 (17960): Successfully stopped VM. 2023-07-29 08:20:23 (17960): Deregistering VM. (boinc_7f376b9b0972046d, slot#12) 2023-07-29 08:20:23 (17960): Removing network bandwidth throttle group from VM. 2023-07-29 08:20:23 (17960): Removing VM from VirtualBox. 08:20:29 (17960): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN