| Name | Theory_2743-2699089-286_1 |
| Workunit | 223868114 |
| Created | 3 Jul 2024, 14:14:14 UTC |
| Sent | 3 Jul 2024, 16:32:24 UTC |
| Report deadline | 14 Jul 2024, 16:32:24 UTC |
| Received | 4 Jul 2024, 21:29:39 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10677116 |
| Run time | 14 min 41 sec |
| CPU time | 10 min 57 sec |
| Validate state | Valid |
| Credit | 11.23 |
| Device peak FLOPS | 5.50 GFLOPS |
| Application version | Theory Simulation v300.30 (vbox64_theory) windows_x86_64 |
| Peak working set size | 85.37 MB |
| Peak swap size | 77.38 MB |
| Peak disk usage | 1.12 GB |
Stderr output
<core_client_version>7.24.1</core_client_version> <![CDATA[ <stderr_txt> 2024-07-03 22:45:49 (37024): vboxwrapper version 26207 2024-07-03 22:45:49 (37024): BOINC client version: 7.24.1 2024-07-03 22:45:50 (37024): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-03 22:45:50 (37024): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-03 22:45:50 (37024): Successfully copied 'init_data.xml' to the shared directory. 2024-07-03 22:45:50 (37024): Successfully copied 'input' to the shared directory. 2024-07-03 22:45:50 (37024): Create VM. (boinc_3405013711a2bbdf, slot#14) 2024-07-03 22:45:51 (37024): Setting Memory Size for VM. (630MB) 2024-07-03 22:45:51 (37024): Setting CPU Count for VM. (1) 2024-07-03 22:45:52 (37024): Setting Chipset Options for VM. 2024-07-03 22:45:52 (37024): Setting Graphics Controller Options for VM. 2024-07-03 22:45:52 (37024): Setting Boot Options for VM. 2024-07-03 22:45:53 (37024): Setting Network Configuration for NAT. 2024-07-03 22:45:53 (37024): Enabling VM Network Access. 2024-07-03 22:45:53 (37024): Disabling USB Support for VM. 2024-07-03 22:45:54 (37024): Disabling COM Port Support for VM. 2024-07-03 22:45:54 (37024): Disabling LPT Port Support for VM. 2024-07-03 22:45:54 (37024): Disabling Audio Support for VM. 2024-07-03 22:45:55 (37024): Disabling Clipboard Support for VM. 2024-07-03 22:45:55 (37024): Disabling Drag and Drop Support for VM. 2024-07-03 22:45:55 (37024): Adding storage controller(s) to VM. 2024-07-03 22:45:56 (37024): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi) 2024-07-03 22:45:56 (37024): Adding VirtualBox Guest Additions to VM. 2024-07-03 22:45:57 (37024): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-07-03 22:45:57 (37024): forwarding host port 53635 to guest port 80 2024-07-03 22:45:57 (37024): Enabling remote desktop for VM. 2024-07-03 22:45:58 (37024): Required extension pack not installed, remote desktop not enabled. 2024-07-03 22:45:58 (37024): Enabling shared directory for VM. 2024-07-03 22:45:58 (37024): Starting VM using VBoxManage interface. (boinc_3405013711a2bbdf, slot#14) 2024-07-03 22:46:04 (37024): Successfully started VM. (PID = '31172') 2024-07-03 22:46:04 (37024): Reporting VM Process ID to BOINC. 2024-07-03 22:46:04 (37024): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-03 22:46:04 (37024): Guest Log: CPUID EDX: 0x178bfbff 2024-07-03 22:46:04 (37024): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-03 22:46:04 (37024): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-03 22:46:04 (37024): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-03 22:46:04 (37024): Detected: Web Application Enabled (http://localhost:53635) 2024-07-03 22:46:05 (37024): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:46:19 (37024): Preference change detected 2024-07-03 22:46:19 (37024): Setting CPU throttle for VM. (100%) 2024-07-03 22:46:20 (37024): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-03 22:46:20 (37024): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:46:21 (37024): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-03 22:46:21 (37024): Guest Log: BIOS: Booting from Hard Disk... 2024-07-03 22:46:24 (37024): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-03 22:46:24 (37024): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-03 22:46:30 (37024): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:46:50 (37024): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:47:00 (37024): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:47:02 (37024): Stopping VM. 2024-07-03 22:47:04 (37024): Successfully stopped VM. 2024-07-03 23:58:20 (32436): vboxwrapper version 26207 2024-07-03 23:58:20 (32436): BOINC client version: 7.24.1 2024-07-03 23:58:21 (32436): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-03 23:58:22 (32436): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-03 23:58:22 (32436): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-03 23:58:22 (32436): Guest Log: CPUID EDX: 0x178bfbff 2024-07-03 23:58:22 (32436): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-03 23:58:22 (32436): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-03 23:58:22 (32436): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-03 23:58:22 (32436): Guest Log: BIOS: Booting from Hard Disk... 2024-07-03 23:58:22 (32436): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-03 23:58:22 (32436): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-03 23:58:22 (32436): Starting VM using VBoxManage interface. (boinc_3405013711a2bbdf, slot#14) 2024-07-03 23:58:32 (32436): Successfully started VM. (PID = '37416') 2024-07-03 23:58:32 (32436): Reporting VM Process ID to BOINC. 2024-07-03 23:58:32 (32436): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-03 23:58:32 (32436): Detected: Web Application Enabled (http://localhost:53635) 2024-07-03 23:58:33 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:58:51 (32436): Preference change detected 2024-07-03 23:58:51 (32436): Setting CPU throttle for VM. (100%) 2024-07-03 23:58:52 (32436): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-03 23:58:52 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 23:59:02 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:59:22 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 23:59:28 (32436): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-03 23:59:28 (32436): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-03 23:59:31 (32436): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.000148 main Log opened 2024-07-03T20:47:22.713404000Z 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.000258 main OS Product: Linux 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.000299 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.000332 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.000362 main Executable: /usr/sbin/VBoxService 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.000363 main Process ID: 3226 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.000364 main Package type: LINUX_64BITS_GENERIC 2024-07-03 23:59:31 (32436): Guest Log: 00:00:00.017475 main 5.2.6 r120293 started. Verbose level = 0 2024-07-03 23:59:32 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:59:52 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:00:01 (32436): Guest Log: 00:00:10.028242 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 338 559 784 000ns (GuestNow=1 720 043 981 300 082 000 ns GuestLast=1 720 039 642 740 298 000 ns fSetTimeLastLoop=true ) 2024-07-04 00:00:02 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:00:22 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:00:32 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:00:52 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:00:56 (32436): Guest Log: 23:59:57 CEST +02:00 2024-07-03: cranky: [INFO] Detected Theory App 2024-07-04 00:00:56 (32436): Guest Log: 23:59:57 CEST +02:00 2024-07-03: cranky: [INFO] Checking CVMFS. 2024-07-04 00:00:56 (32436): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-04 00:00:57 (32436): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 00:00:57 (32436): Guest Log: 2.5.2.0 4098 0 28276 29841 3 1 272454 4096000 0 65024 0 0 n/a 5 5 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-04 00:00:57 (32436): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-04 00:00:58 (32436): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 00:00:58 (32436): Guest Log: 2.5.2.0 4077 0 27400 24625 3 2 272454 4096000 0 65024 0 2 -100 7959 2596 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-04 00:00:58 (32436): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-04 00:00:59 (32436): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 00:00:59 (32436): Guest Log: 2.5.2.0 4052 0 27236 272 3 1 272454 4096000 0 65024 0 0 n/a 4 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-04 00:00:59 (32436): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-04 00:01:00 (32436): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 00:01:00 (32436): Guest Log: 2.5.2.0 4125 0 39996 19054 3 1 272454 4096000 0 65024 0 0 n/a 5555 1385 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-04 00:01:00 (32436): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Checking runc. 2024-07-04 00:01:00 (32436): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Creating the filesystem. 2024-07-04 00:01:00 (32436): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-04 00:01:00 (32436): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Updating config.json. 2024-07-04 00:01:00 (32436): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Running Container 'runc'. 2024-07-04 00:01:02 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:01:22 (32436): Guest Log: job: htmld=/shared/html/job 2024-07-04 00:01:22 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:01:23 (32436): Guest Log: job: unpack exitcode=0 2024-07-04 00:01:23 (32436): Guest Log: INFO: activated the work-around for ld: 2024-07-04 00:01:23 (32436): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 22:00 /tmp/tmp.p7BOxeKjfw/ld -> /usr/bin/ld.bfd 2024-07-04 00:01:24 (32436): Guest Log: 00:00:05 CEST +02:00 2024-07-04: cranky: [INFO] ===> [runRivet] Wed Jul 3 22:00:04 UTC 2024 [boinc ppbar mb-nsd 200 - - pythia6 6.426 z1-lep 100000 286] 2024-07-04 00:01:32 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:01:52 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:02:02 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:02:22 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:02:32 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:02:52 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:03:04 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:03:23 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:03:34 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:03:52 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:04:04 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:04:23 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:04:34 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:04:53 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:05:03 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:05:23 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:05:33 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:05:53 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:06:03 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:06:23 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:06:34 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:06:53 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:07:04 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:07:23 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:07:34 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:07:53 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:08:04 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:08:23 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:08:36 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:08:54 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:09:05 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:09:24 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:09:36 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:09:54 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:10:05 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:10:24 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:10:35 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:10:54 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:11:04 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:11:24 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:12:27 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:13:15 (32436): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:13:43 (32436): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:13:47 (32436): Stopping VM. 2024-07-04 00:13:51 (32436): Successfully stopped VM. 2024-07-04 16:25:06 (8280): vboxwrapper version 26207 2024-07-04 16:25:06 (8280): BOINC client version: 7.24.1 2024-07-04 16:25:07 (8280): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-04 16:25:07 (8280): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-04 16:25:08 (8280): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-04 16:25:08 (8280): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-04 16:25:08 (8280): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.000148 main Log opened 2024-07-03T20:47:22.713404000Z 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.000258 main OS Product: Linux 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.000299 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.000332 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.000362 main Executable: /usr/sbin/VBoxService 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.000363 main Process ID: 3226 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.000364 main Package type: LINUX_64BITS_GENERIC 2024-07-04 16:25:08 (8280): Guest Log: 00:00:00.017475 main 5.2.6 r120293 started. Verbose level = 0 2024-07-04 16:25:08 (8280): Guest Log: 00:00:10.028242 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 338 559 784 000ns (GuestNow=1 720 043 981 300 082 000 ns GuestLast=1 720 039 642 740 298 000 ns fSetTimeLastLoop=true ) 2024-07-04 16:25:09 (8280): Guest Log: 23:59:57 CEST +02:00 2024-07-03: cranky: [INFO] Detected Theory App 2024-07-04 16:25:09 (8280): Guest Log: 23:59:57 CEST +02:00 2024-07-03: cranky: [INFO] Checking CVMFS. 2024-07-04 16:25:09 (8280): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-04 16:25:09 (8280): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 16:25:09 (8280): Guest Log: 2.5.2.0 4098 0 28276 29841 3 1 272454 4096000 0 65024 0 0 n/a 5 5 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-04 16:25:09 (8280): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-04 16:25:09 (8280): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 16:25:09 (8280): Guest Log: 2.5.2.0 4077 0 27400 24625 3 2 272454 4096000 0 65024 0 2 -100 7959 2596 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-04 16:25:09 (8280): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-04 16:25:09 (8280): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 16:25:09 (8280): Guest Log: 2.5.2.0 4052 0 27236 272 3 1 272454 4096000 0 65024 0 0 n/a 4 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-04 16:25:09 (8280): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-04 16:25:09 (8280): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2024-07-04 16:25:09 (8280): Guest Log: 2.5.2.0 4125 0 39996 19054 3 1 272454 4096000 0 65024 0 0 n/a 5555 1385 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-04 16:25:09 (8280): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Checking runc. 2024-07-04 16:25:09 (8280): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Creating the filesystem. 2024-07-04 16:25:09 (8280): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-04 16:25:09 (8280): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Updating config.json. 2024-07-04 16:25:09 (8280): Guest Log: 00:00:01 CEST +02:00 2024-07-04: cranky: [INFO] Running Container 'runc'. 2024-07-04 16:25:09 (8280): Guest Log: job: htmld=/shared/html/job 2024-07-04 16:25:09 (8280): Guest Log: job: unpack exitcode=0 2024-07-04 16:25:09 (8280): Guest Log: INFO: activated the work-around for ld: 2024-07-04 16:25:09 (8280): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 22:00 /tmp/tmp.p7BOxeKjfw/ld -> /usr/bin/ld.bfd 2024-07-04 16:25:09 (8280): Guest Log: 00:00:05 CEST +02:00 2024-07-04: cranky: [INFO] ===> [runRivet] Wed Jul 3 22:00:04 UTC 2024 [boinc ppbar mb-nsd 200 - - pythia6 6.426 z1-lep 100000 286] 2024-07-04 16:25:09 (8280): Starting VM using VBoxManage interface. (boinc_3405013711a2bbdf, slot#14) 2024-07-04 16:25:23 (8280): Successfully started VM. (PID = '25660') 2024-07-04 16:25:23 (8280): Reporting VM Process ID to BOINC. 2024-07-04 16:25:23 (8280): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-04 16:25:23 (8280): Detected: Web Application Enabled (http://localhost:53635) 2024-07-04 16:25:24 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:25:56 (8280): Preference change detected 2024-07-04 16:25:56 (8280): Setting CPU throttle for VM. (100%) 2024-07-04 16:25:57 (8280): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-04 16:25:57 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:26:02 (8280): Guest Log: 00:06:10.356368 timesync vgsvcTimeSyncWorker: Radical host time change: 58 341 570 000 000ns (HostNow=1 720 103 162 563 000 000 ns HostLast=1 720 044 820 993 000 000 ns) 2024-07-04 16:26:07 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:26:27 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:26:32 (8280): Guest Log: 00:06:20.362035 timesync vgsvcTimeSyncWorker: Radical guest time change: 58 830 957 195 000ns (GuestNow=1 720 103 172 577 062 000 ns GuestLast=1 720 044 341 619 867 000 ns fSetTimeLastLoop=true ) 2024-07-04 16:26:37 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:26:57 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:27:08 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:27:27 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:27:38 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:27:58 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:28:09 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:28:47 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:28:57 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:29:17 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:29:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:29:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:29:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:30:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:30:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:30:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:30:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:31:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:31:29 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:31:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:31:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:32:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:32:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:32:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:32:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:33:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:33:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:33:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:33:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:34:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:34:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:34:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:34:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:35:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:35:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:35:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:35:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:36:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:36:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:36:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:36:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:37:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:37:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:37:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:37:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:38:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:38:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:38:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:38:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:39:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:39:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:39:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:39:58 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:40:18 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:40:28 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:40:48 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:40:59 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:41:19 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:41:29 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:41:49 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:41:59 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:42:19 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:42:29 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:42:49 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:42:59 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:43:19 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:43:29 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:43:49 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:43:59 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:44:19 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:44:29 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:44:49 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:44:59 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:45:19 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:45:30 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:45:49 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:45:59 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:46:19 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:46:29 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:46:49 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:47:00 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:47:19 (8280): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:47:31 (8280): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:47:45 (8280): Stopping VM. 2024-07-04 16:47:52 (8280): Successfully stopped VM. 2024-07-04 21:12:51 (36968): vboxwrapper version 26207 2024-07-04 21:12:51 (36968): BOINC client version: 7.24.1 2024-07-04 21:12:52 (36968): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-04 21:12:52 (36968): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-04 21:12:53 (36968): Guest Log: 00:06:10.356368 timesync vgsvcTimeSyncWorker: Radical host time change: 58 341 570 000 000ns (HostNow=1 720 103 162 563 000 000 ns HostLast=1 720 044 820 993 000 000 ns) 2024-07-04 21:12:53 (36968): Guest Log: 00:06:20.362035 timesync vgsvcTimeSyncWorker: Radical guest time change: 58 830 957 195 000ns (GuestNow=1 720 103 172 577 062 000 ns GuestLast=1 720 044 341 619 867 000 ns fSetTimeLastLoop=true ) 2024-07-04 21:12:53 (36968): Starting VM using VBoxManage interface. (boinc_3405013711a2bbdf, slot#14) 2024-07-04 21:13:03 (36968): Successfully started VM. (PID = '17644') 2024-07-04 21:13:03 (36968): Reporting VM Process ID to BOINC. 2024-07-04 21:13:03 (36968): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-04 21:13:03 (36968): Detected: Web Application Enabled (http://localhost:53635) 2024-07-04 21:13:04 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:13:22 (36968): Preference change detected 2024-07-04 21:13:22 (36968): Setting CPU throttle for VM. (100%) 2024-07-04 21:13:23 (36968): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-04 21:13:23 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:13:29 (36968): Guest Log: 00:13:50.714212 timesync vgsvcTimeSyncWorker: Radical host time change: 15 959 575 000 000ns (HostNow=1 720 120 409 642 000 000 ns HostLast=1 720 104 450 067 000 000 ns) 2024-07-04 21:13:33 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:13:53 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:13:59 (36968): Guest Log: 00:14:00.720377 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 796 718 916 000ns (GuestNow=1 720 120 419 648 170 000 ns GuestLast=1 720 103 622 929 254 000 ns fSetTimeLastLoop=true ) 2024-07-04 21:14:03 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:14:23 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:14:33 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:14:53 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:15:04 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:15:23 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:15:34 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:15:53 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:16:05 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:16:23 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:16:33 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:16:53 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:17:03 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:17:22 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:17:32 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:17:53 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:18:05 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:18:23 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:18:33 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:18:53 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:19:03 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:19:23 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:19:33 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:19:54 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:20:04 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:20:23 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:20:35 (36968): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:20:53 (36968): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:21:01 (36968): Guest Log: job: run exitcode=0 2024-07-04 21:21:01 (36968): Guest Log: job: diskusage=3104 2024-07-04 21:21:01 (36968): Guest Log: job: logsize=56 k 2024-07-04 21:21:01 (36968): Guest Log: job: times= 2024-07-04 21:21:01 (36968): Guest Log: 0m0.010s 0m0.011s 2024-07-04 21:21:01 (36968): Guest Log: 10m3.541s 0m9.192s 2024-07-04 21:21:01 (36968): Guest Log: job: cpuusage=613 2024-07-04 21:21:02 (36968): Guest Log: 21:16:21 CEST +02:00 2024-07-04: cranky: [INFO] Container 'runc' finished with status code 0. 2024-07-04 21:21:02 (36968): Guest Log: 21:16:21 CEST +02:00 2024-07-04: cranky: [INFO] Preparing output. 2024-07-04 21:21:02 (36968): Guest Log: [INFO] Job Finished 2024-07-04 21:21:02 (36968): Guest Log: [INFO] Shutting Down. 2024-07-04 21:21:02 (36968): VM Completion File Detected. 2024-07-04 21:21:03 (36968): VM Completion Message: Job Finished . 2024-07-04 21:21:03 (36968): Powering off VM. 2024-07-04 21:21:04 (36968): Successfully stopped VM. 2024-07-04 21:21:04 (36968): Deregistering VM. (boinc_3405013711a2bbdf, slot#14) 2024-07-04 21:21:04 (36968): Removing network bandwidth throttle group from VM. 2024-07-04 21:21:04 (36968): Removing VM from VirtualBox. 2024-07-04 21:21:10 (36968): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN