Name Theory_2773-2921186-410_1
Workunit 229900518
Created 23 Jan 2025, 2:49:15 UTC
Sent 23 Jan 2025, 7:10:09 UTC
Report deadline 3 Feb 2025, 7:10:09 UTC
Received 24 Jan 2025, 19:34:08 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10373676
Run time 11 hours 49 min 14 sec
CPU time 11 hours 12 min 17 sec
Validate state Valid
Credit 400.56
Device peak FLOPS 4.07 GFLOPS
Application version Theory Simulation v300.60 (vbox64_theory)
windows_x86_64
Peak working set size 71.91 MB
Peak swap size 74.39 MB
Peak disk usage 2.13 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2025-01-23 08:05:28 (17516): vboxwrapper version 26208
2025-01-23 08:05:28 (17516): BOINC client version: 8.0.2
2025-01-23 08:05:29 (17516): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2025-01-23 08:05:29 (17516): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-23 08:05:29 (17516): Successfully copied 'init_data.xml' to the shared directory.
2025-01-23 08:05:29 (17516): Successfully copied 'input' to the shared directory.
2025-01-23 08:05:29 (17516): Create VM. (boinc_2a736e65c14c9ce8, slot#0)
2025-01-23 08:05:30 (17516): Setting Memory Size for VM. (630MB)
2025-01-23 08:05:30 (17516): Setting CPU Count for VM. (1)
2025-01-23 08:05:30 (17516): Setting Chipset Options for VM.
2025-01-23 08:05:31 (17516): Setting Graphics Controller Options for VM.
2025-01-23 08:05:31 (17516): Setting Boot Options for VM.
2025-01-23 08:05:31 (17516): Setting Network Configuration for NAT.
2025-01-23 08:05:32 (17516): Enabling VM Network Access.
2025-01-23 08:05:32 (17516): Disabling USB Support for VM.
2025-01-23 08:05:32 (17516): Disabling COM Port Support for VM.
2025-01-23 08:05:32 (17516): Disabling LPT Port Support for VM.
2025-01-23 08:05:33 (17516): Disabling Audio Support for VM.
2025-01-23 08:05:33 (17516): Disabling Clipboard Support for VM.
2025-01-23 08:05:33 (17516): Disabling Drag and Drop Support for VM.
2025-01-23 08:05:33 (17516): Adding storage controller(s) to VM.
2025-01-23 08:05:34 (17516): Adding virtual disk drive to VM. (Theory_2025_01_16_prod.vdi)
2025-01-23 08:05:34 (17516): Adding VirtualBox Guest Additions to VM.
2025-01-23 08:05:35 (17516): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-01-23 08:05:35 (17516): forwarding host port 56474 to guest port 80
2025-01-23 08:05:35 (17516): Enabling remote desktop for VM.
2025-01-23 08:05:35 (17516): Required extension pack not installed, remote desktop not enabled.
2025-01-23 08:05:35 (17516): Enabling shared directory for VM.
2025-01-23 08:05:36 (17516): Starting VM using VBoxManage interface. (boinc_2a736e65c14c9ce8, slot#0)
2025-01-23 08:05:40 (17516): Successfully started VM. (PID = '20588')
2025-01-23 08:05:40 (17516): Reporting VM Process ID to BOINC.
2025-01-23 08:05:40 (17516): Guest Log: BIOS: VirtualBox 6.1.34
2025-01-23 08:05:40 (17516): Guest Log: CPUID EDX: 0x178bfbff
2025-01-23 08:05:40 (17516): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-23 08:05:40 (17516): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-23 08:05:40 (17516): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-23 08:05:40 (17516): Detected: Web Application Enabled (http://localhost:56474)
2025-01-23 08:05:41 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 08:05:56 (17516): Preference change detected
2025-01-23 08:05:56 (17516): Setting CPU throttle for VM. (75%)
2025-01-23 08:05:57 (17516): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-23 08:05:57 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 08:05:58 (17516): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-23 08:05:58 (17516): Guest Log: BIOS: Booting from Hard Disk...
2025-01-23 08:06:00 (17516): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-23 08:06:00 (17516): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-23 08:06:20 (17516): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-23 08:06:20 (17516): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-23 08:06:23 (17516): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.000397 main     Log opened 2025-01-23T13:06:25.512495000Z
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.001119 main     OS Product: Linux
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.001172 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.001206 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.001236 main     Executable: /usr/sbin/VBoxService
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.001237 main     Process ID: 3217
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.001238 main     Package type: LINUX_64BITS_GENERIC
2025-01-23 08:06:23 (17516): Guest Log: 00:00:00.003118 main     5.2.6 r120293 started. Verbose level = 0
2025-01-23 08:06:57 (17516): Guest Log: 08:06:59 EST -05:00 2025-01-23: cranky: [INFO] Detected Theory App
2025-01-23 08:06:57 (17516): Guest Log: 08:06:59 EST -05:00 2025-01-23: cranky: [INFO] Checking CVMFS.
2025-01-23 08:06:58 (17516): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-23 08:06:59 (17516): 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
2025-01-23 08:06:59 (17516): Guest Log: 2.5.2.0 4089 0 28508 31546 3 1 278956 4096000 0 65024 0 0 n/a 5 2 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-23 08:07:00 (17516): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-23 08:07:01 (17516): 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
2025-01-23 08:07:01 (17516): Guest Log: 2.5.2.0 4132 0 27428 26297 3 2 278956 4096000 0 65024 0 2 -100 10085 1477 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-23 08:07:02 (17516): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-23 08:07:03 (17516): 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
2025-01-23 08:07:03 (17516): Guest Log: 2.5.2.0 4067 0 25188 272 3 1 278956 4096000 0 65024 0 0 n/a 4 2 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-23 08:07:04 (17516): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-23 08:07:05 (17516): 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
2025-01-23 08:07:05 (17516): Guest Log: 2.5.2.0 4111 0 42168 20949 3 1 278956 4096000 0 65024 0 0 n/a 6595 1340 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-23 08:07:05 (17516): Guest Log: 08:07:07 EST -05:00 2025-01-23: cranky: [INFO] Checking runc.
2025-01-23 08:07:05 (17516): Guest Log: 08:07:07 EST -05:00 2025-01-23: cranky: [INFO] Creating the filesystem.
2025-01-23 08:07:05 (17516): Guest Log: 08:07:07 EST -05:00 2025-01-23: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-23 08:07:05 (17516): Guest Log: 08:07:07 EST -05:00 2025-01-23: cranky: [INFO] Updating config.json.
2025-01-23 08:07:05 (17516): Guest Log: 08:07:07 EST -05:00 2025-01-23: cranky: [INFO] Running Container 'runc'.
2025-01-23 08:07:20 (17516): Guest Log: job: htmld=/shared/html/job
2025-01-23 08:07:21 (17516): Guest Log: job: unpack exitcode=0
2025-01-23 08:07:22 (17516): Guest Log: INFO: activated the work-around for ld:
2025-01-23 08:07:22 (17516): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 23 13:07 /tmp/tmp.DKxX33qq9w/ld -> /usr/bin/ld.bfd
2025-01-23 08:07:23 (17516): Guest Log: 08:07:25 EST -05:00 2025-01-23: cranky: [INFO] ===> [runRivet] Thu Jan 23 13:07:24 UTC 2025 [boinc pp jets 13000 150 - powheg-box r3744 pthard2 100000 410]
2025-01-23 08:59:43 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:00:03 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:25:25 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:25:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:25:56 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:26:16 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:26:46 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:27:06 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:27:16 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:27:36 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:27:56 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:28:16 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:28:26 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:28:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:28:56 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:29:16 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:29:36 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:29:56 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:30:16 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:30:36 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:30:56 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:31:16 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:31:26 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:31:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:32:06 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:32:26 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:32:36 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:32:56 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:33:16 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:33:36 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:33:56 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:34:16 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:34:36 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:34:56 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:35:16 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:35:36 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:35:56 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:36:16 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:36:36 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:36:56 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:37:36 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:37:56 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:38:16 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:38:36 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:39:06 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:39:27 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:39:46 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:40:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:40:36 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:40:56 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:41:06 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:41:27 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:41:46 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:42:06 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:42:26 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:42:47 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:43:07 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:43:26 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:43:37 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:43:57 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:44:07 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:44:27 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:44:48 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:45:08 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:45:18 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:45:38 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:45:48 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:46:08 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:46:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:46:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:47:08 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:47:09 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:47:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:48:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:48:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:48:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:48:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:49:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:49:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:49:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:49:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:50:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:50:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:50:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:50:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:51:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:51:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:51:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:51:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:52:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:52:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:52:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:52:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:53:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:53:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:53:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:53:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:54:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:54:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:54:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:54:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:55:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:55:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:55:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:55:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:56:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:56:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:56:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:56:58 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:57:18 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:57:29 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:57:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:57:59 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:58:19 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:58:29 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:58:49 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:58:59 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:59:19 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:59:29 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 09:59:49 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 09:59:59 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:00:19 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:00:29 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:00:49 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:00:59 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:01:20 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:01:29 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:01:49 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:01:59 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:02:20 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:02:29 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:02:50 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:03:00 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:03:20 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:03:30 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:03:50 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:04:00 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:04:01 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:06:51 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:07:11 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:07:31 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:07:51 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:08:01 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:08:21 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:08:31 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:08:52 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:09:11 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:09:31 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:09:41 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:10:01 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:10:11 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:10:32 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:10:51 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:11:11 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:11:31 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:11:52 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:12:11 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:12:31 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:12:52 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:13:13 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:13:32 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:13:52 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:13:56 (17516): Status Report: Job Duration: '864000.000000'
2025-01-23 10:13:56 (17516): Status Report: Elapsed Time: '6000.000000'
2025-01-23 10:13:56 (17516): Status Report: CPU Time: '3853.468750'
2025-01-23 10:14:12 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:14:33 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:14:52 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:15:12 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:15:22 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:15:42 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:16:22 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:16:43 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:17:12 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:17:32 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:17:43 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:18:03 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:25:23 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:25:43 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:26:13 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:26:33 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:28:13 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:28:33 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:31:13 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:31:33 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:32:24 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:32:44 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:33:54 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:34:14 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:35:24 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:35:45 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:39:15 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:39:35 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:39:55 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:40:15 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:40:55 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:41:15 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:41:35 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:41:55 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:42:25 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:42:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:43:05 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:43:26 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:43:45 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:44:05 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:44:25 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:44:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:45:15 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:45:35 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:45:55 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:46:15 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:46:55 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:47:15 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:48:15 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:48:35 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:48:55 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:49:15 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:49:35 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:49:55 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:50:15 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:50:35 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:51:45 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:52:05 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:53:56 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:54:16 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:55:26 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:55:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:56:26 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:56:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:59:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 10:59:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 10:59:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:00:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:00:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:00:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:00:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:01:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:01:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:01:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:01:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:02:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:02:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:02:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:02:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:03:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:03:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:03:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:03:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:04:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:04:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:04:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:04:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:05:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:05:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:05:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:05:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:06:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:06:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:06:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:06:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:07:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:07:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:07:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:07:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:08:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:08:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:08:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:08:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:09:07 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:09:17 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:09:37 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 11:09:47 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 11:09:48 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 12:12:43 (17516): Status Report: Job Duration: '864000.000000'
2025-01-23 12:12:43 (17516): Status Report: Elapsed Time: '12000.000000'
2025-01-23 12:12:43 (17516): Status Report: CPU Time: '8398.250000'
2025-01-23 13:52:49 (17516): Status Report: Job Duration: '864000.000000'
2025-01-23 13:52:49 (17516): Status Report: Elapsed Time: '18000.000000'
2025-01-23 13:52:49 (17516): Status Report: CPU Time: '12904.187500'
2025-01-23 14:30:03 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 16:54:06 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 16:54:07 (17516): Guest Log: 05:39:43.896680 timesync vgsvcTimeSyncWorker: Radical host time change: 8 652 455 000 000ns (HostNow=1 737 669 247 346 000 000 ns HostLast=1 737 660 594 891 000 000 ns)
2025-01-23 16:54:13 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 16:54:33 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 16:54:37 (17516): Guest Log: 05:39:53.950486 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 866 682 595 000ns (GuestNow=1 737 669 257 475 014 000 ns GuestLast=1 737 660 390 792 419 000 ns fSetTimeLastLoop=true )
2025-01-23 16:55:23 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 16:55:44 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 16:55:55 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 16:56:14 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 17:58:02 (17516): Status Report: Job Duration: '864000.000000'
2025-01-23 17:58:02 (17516): Status Report: Elapsed Time: '24000.000000'
2025-01-23 17:58:02 (17516): Status Report: CPU Time: '17413.703125'
2025-01-23 19:09:31 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 19:09:51 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 19:11:51 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 19:12:11 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-23 19:13:13 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 06:13:31 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 06:13:35 (17516): Guest Log: 07:57:17.782107 timesync vgsvcTimeSyncWorker: Radical host time change: 39 627 360 000 000ns (HostNow=1 737 717 214 345 000 000 ns HostLast=1 737 677 586 985 000 000 ns)
2025-01-24 06:13:38 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 06:13:59 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 06:14:06 (17516): Guest Log: 07:57:27.814932 timesync vgsvcTimeSyncWorker: Radical guest time change: 39 723 071 204 000ns (GuestNow=1 737 717 224 377 823 000 ns GuestLast=1 737 677 501 306 619 000 ns fSetTimeLastLoop=true )
2025-01-24 06:23:08 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 06:23:28 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 06:39:51 (17516): Status Report: Job Duration: '864000.000000'
2025-01-24 06:39:51 (17516): Status Report: Elapsed Time: '30000.000000'
2025-01-24 06:39:51 (17516): Status Report: CPU Time: '21921.656250'
2025-01-24 08:01:05 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 08:01:25 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 08:02:25 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 08:02:46 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 08:05:46 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 08:06:06 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 08:21:01 (17516): Status Report: Job Duration: '864000.000000'
2025-01-24 08:21:01 (17516): Status Report: Elapsed Time: '36000.000000'
2025-01-24 08:21:01 (17516): Status Report: CPU Time: '26426.531250'
2025-01-24 10:01:06 (17516): Status Report: Job Duration: '864000.000000'
2025-01-24 10:01:06 (17516): Status Report: Elapsed Time: '42000.000000'
2025-01-24 10:01:06 (17516): Status Report: CPU Time: '30936.734375'
2025-01-24 10:20:28 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 10:20:49 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 10:22:39 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 10:22:59 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 10:23:09 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 10:23:29 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 10:24:41 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 10:25:01 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 11:23:06 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 11:23:26 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 11:42:58 (17516): Status Report: Job Duration: '864000.000000'
2025-01-24 11:42:58 (17516): Status Report: Elapsed Time: '48000.000000'
2025-01-24 11:42:58 (17516): Status Report: CPU Time: '35438.734375'
2025-01-24 12:21:20 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 12:21:40 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 12:33:53 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 12:34:13 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 12:36:43 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 12:36:44 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 12:40:24 (17516): VM state change detected. (old = 'running', new = 'paused')
2025-01-24 12:40:43 (17516): VM state change detected. (old = 'paused', new = 'running')
2025-01-24 13:24:08 (17516): Status Report: Job Duration: '864000.000000'
2025-01-24 13:24:08 (17516): Status Report: Elapsed Time: '54000.000000'
2025-01-24 13:24:08 (17516): Status Report: CPU Time: '39944.765625'
2025-01-24 13:32:57 (17516): Guest Log: job: run exitcode=0
2025-01-24 13:32:57 (17516): Guest Log: job: diskusage=107188
2025-01-24 13:32:57 (17516): Guest Log: job: logsize=128 k
2025-01-24 13:32:57 (17516): Guest Log: job: times=
2025-01-24 13:32:57 (17516): Guest Log: 0m0.013s 0m0.025s
2025-01-24 13:32:57 (17516): Guest Log: 877m24.883s 3m51.056s
2025-01-24 13:32:57 (17516): Guest Log: job: cpuusage=52876
2025-01-24 13:32:58 (17516): Guest Log: 13:28:49 EST -05:00 2025-01-24: cranky: [INFO] Container 'runc' finished with status code 0.
2025-01-24 13:32:58 (17516): Guest Log: 13:28:49 EST -05:00 2025-01-24: cranky: [INFO] Preparing output.
2025-01-24 13:33:00 (17516): Guest Log: [INFO] Job Finished
2025-01-24 13:33:00 (17516): Guest Log: [INFO] Shutting Down.
2025-01-24 13:33:00 (17516): VM Completion File Detected.
2025-01-24 13:33:00 (17516): VM Completion Message: Job Finished
.
2025-01-24 13:33:00 (17516): Powering off VM.
2025-01-24 13:33:01 (17516): Successfully stopped VM.
2025-01-24 13:33:01 (17516): Deregistering VM. (boinc_2a736e65c14c9ce8, slot#0)
2025-01-24 13:33:01 (17516): Removing network bandwidth throttle group from VM.
2025-01-24 13:33:01 (17516): Removing VM from VirtualBox.
2025-01-24 13:33:06 (17516): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN