Name Theory_2390-1132359-194_1
Workunit 2108256
Created 23 Jul 2021, 14:49:23 UTC
Sent 25 Jul 2021, 14:24:27 UTC
Report deadline 4 Aug 2021, 14:24:27 UTC
Received 4 Aug 2021, 16:59:23 UTC
Server state Over
Outcome Computation error
Client state Aborted by user
Exit status 203 (0x000000CB) EXIT_ABORTED_VIA_GUI
Computer ID 832
Run time 8 days 0 hours 41 min 10 sec
CPU time 6 days 12 hours 24 min 22 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 2.51 GFLOPS
Application version Theory Simulation v5.21 (vbox64_theory)
windows_x86_64
Peak working set size 76.08 MB
Peak swap size 71.58 MB
Peak disk usage 3.16 GB

Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<message>
aborted by user</message>
<stderr_txt>
ly started VM. (PID = '232')
2021-08-03 12:48:06 (10448): Reporting VM Process ID to BOINC.
2021-08-03 12:48:06 (10448): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 12:48:06 (10448): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 12:48:06 (10448): Status Report: Job Duration: '864000.000000'
2021-08-03 12:48:06 (10448): Status Report: Elapsed Time: '569229.329156'
2021-08-03 12:48:06 (10448): Status Report: CPU Time: '550325.703125'
2021-08-03 12:48:06 (10448): Preference change detected
2021-08-03 12:48:06 (10448): Setting CPU throttle for VM. (90%)
2021-08-03 12:48:07 (10448): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 12:48:09 (10448): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-08-03 12:48:17 (10448): 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

2021-08-03 12:48:17 (10448): Guest Log: 2.5.2.0 4067 0 25416 15875 3 2 1461449 4096000 0 65024 0 2 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 0

2021-08-03 12:48:22 (10448): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2021-08-03 12:48:24 (10448): 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

2021-08-03 12:48:24 (10448): Guest Log: 2.5.2.0 4111 7 27184 267 -3 1 1461449 4096000 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2021-08-03 12:48:28 (10448): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2021-08-03 12:48:31 (10448): 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

2021-08-03 12:48:31 (10448): Guest Log: 2.5.2.0 4138 7 34604 9909 -3 1 1461449 4096000 0 65024 0 0 n/a 5168 3298 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2021-08-03 12:48:31 (10448): Guest Log: 12:48:30 EDT -04:00 2021-08-03: cranky: [INFO] Checking runc.

2021-08-03 12:48:31 (10448): Guest Log: 12:48:30 EDT -04:00 2021-08-03: cranky: [INFO] Creating the filesystem.

2021-08-03 12:48:31 (10448): Guest Log: 12:48:30 EDT -04:00 2021-08-03: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2021-08-03 12:48:32 (10448): Guest Log: 12:48:31 EDT -04:00 2021-08-03: cranky: [INFO] Updating config.json.

2021-08-03 12:48:32 (10448): Guest Log: 12:48:31 EDT -04:00 2021-08-03: cranky: [INFO] Running Container 'runc'.

2021-08-03 12:48:33 (10448): Guest Log: job: htmld=/shared/html/job

2021-08-03 12:48:33 (10448): Guest Log: job: unpack exitcode=0

2021-08-03 12:48:34 (10448): Guest Log: 12:48:34 EDT -04:00 2021-08-03: cranky: [INFO] ===> [runRivet] Tue Aug  3 16:48:33 UTC 2021 [boinc pp jets 8000 180,-,3560 - pythia8 8.301 dire-default 43000 194]

2021-08-03 12:51:51 (10448): Stopping VM.
2021-08-03 12:52:52 (9760): Detected: vboxwrapper 26197
2021-08-03 12:52:52 (9760): Detected: BOINC client v7.7
2021-08-03 12:52:53 (9760): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 12:52:53 (9760): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 12:52:54 (9760): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 12:53:13 (9760): Successfully started VM. (PID = '8508')
2021-08-03 12:53:13 (9760): Reporting VM Process ID to BOINC.
2021-08-03 12:53:13 (9760): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 12:53:13 (9760): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 12:53:13 (9760): Status Report: Job Duration: '864000.000000'
2021-08-03 12:53:13 (9760): Status Report: Elapsed Time: '569437.329156'
2021-08-03 12:53:13 (9760): Status Report: CPU Time: '550518.953125'
2021-08-03 12:53:13 (9760): Preference change detected
2021-08-03 12:53:13 (9760): Setting CPU throttle for VM. (90%)
2021-08-03 12:53:15 (9760): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 12:54:53 (9760): Stopping VM.
2021-08-03 12:56:56 (5308): Detected: vboxwrapper 26197
2021-08-03 12:56:56 (5308): Detected: BOINC client v7.7
2021-08-03 12:56:56 (5308): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 12:56:57 (5308): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 12:56:57 (5308): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 12:57:13 (5308): Successfully started VM. (PID = '11076')
2021-08-03 12:57:13 (5308): Reporting VM Process ID to BOINC.
2021-08-03 12:57:13 (5308): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 12:57:13 (5308): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 12:57:13 (5308): Status Report: Job Duration: '864000.000000'
2021-08-03 12:57:13 (5308): Status Report: Elapsed Time: '569525.027904'
2021-08-03 12:57:13 (5308): Status Report: CPU Time: '550611.234375'
2021-08-03 12:57:13 (5308): Preference change detected
2021-08-03 12:57:13 (5308): Setting CPU throttle for VM. (90%)
2021-08-03 12:57:14 (5308): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 13:00:57 (5308): Stopping VM.
2021-08-03 13:01:58 (3608): Detected: vboxwrapper 26197
2021-08-03 13:01:58 (3608): Detected: BOINC client v7.7
2021-08-03 13:01:59 (3608): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 13:02:00 (3608): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 13:02:00 (3608): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 13:02:14 (3608): Successfully started VM. (PID = '10812')
2021-08-03 13:02:14 (3608): Reporting VM Process ID to BOINC.
2021-08-03 13:02:14 (3608): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 13:02:14 (3608): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 13:02:14 (3608): Status Report: Job Duration: '864000.000000'
2021-08-03 13:02:14 (3608): Status Report: Elapsed Time: '569731.524559'
2021-08-03 13:02:14 (3608): Status Report: CPU Time: '550816.828125'
2021-08-03 13:02:14 (3608): Preference change detected
2021-08-03 13:02:14 (3608): Setting CPU throttle for VM. (90%)
2021-08-03 13:02:15 (3608): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 13:03:59 (3608): Stopping VM.
2021-08-03 13:05:01 (6384): Detected: vboxwrapper 26197
2021-08-03 13:05:01 (6384): Detected: BOINC client v7.7
2021-08-03 13:05:02 (6384): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 13:05:02 (6384): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 13:05:03 (6384): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 13:05:18 (6384): Successfully started VM. (PID = '2960')
2021-08-03 13:05:18 (6384): Reporting VM Process ID to BOINC.
2021-08-03 13:05:18 (6384): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 13:05:18 (6384): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 13:05:18 (6384): Status Report: Job Duration: '864000.000000'
2021-08-03 13:05:18 (6384): Status Report: Elapsed Time: '569825.524559'
2021-08-03 13:05:18 (6384): Status Report: CPU Time: '550917.500000'
2021-08-03 13:05:18 (6384): Preference change detected
2021-08-03 13:05:18 (6384): Setting CPU throttle for VM. (90%)
2021-08-03 13:05:19 (6384): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 13:06:01 (6384): Stopping VM.
2021-08-03 13:07:02 (7300): Detected: vboxwrapper 26197
2021-08-03 13:07:02 (7300): Detected: BOINC client v7.7
2021-08-03 13:07:03 (7300): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 13:07:03 (7300): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 13:07:04 (7300): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 13:07:18 (7300): Successfully started VM. (PID = '9440')
2021-08-03 13:07:18 (7300): Reporting VM Process ID to BOINC.
2021-08-03 13:07:18 (7300): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 13:07:18 (7300): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 13:07:18 (7300): Status Report: Job Duration: '864000.000000'
2021-08-03 13:07:18 (7300): Status Report: Elapsed Time: '569865.870867'
2021-08-03 13:07:18 (7300): Status Report: CPU Time: '550966.937500'
2021-08-03 13:07:18 (7300): Preference change detected
2021-08-03 13:07:18 (7300): Setting CPU throttle for VM. (90%)
2021-08-03 13:07:19 (7300): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 13:25:04 (7300): Stopping VM.
2021-08-03 13:27:04 (10596): Detected: vboxwrapper 26197
2021-08-03 13:27:04 (10596): Detected: BOINC client v7.7
2021-08-03 13:27:05 (10596): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 13:27:05 (10596): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 13:27:06 (10596): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 13:27:22 (10596): Successfully started VM. (PID = '1172')
2021-08-03 13:27:22 (10596): Reporting VM Process ID to BOINC.
2021-08-03 13:27:22 (10596): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 13:27:22 (10596): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 13:27:22 (10596): Status Report: Job Duration: '864000.000000'
2021-08-03 13:27:22 (10596): Status Report: Elapsed Time: '570865.870867'
2021-08-03 13:27:22 (10596): Status Report: CPU Time: '551931.859375'
2021-08-03 13:27:22 (10596): Preference change detected
2021-08-03 13:27:22 (10596): Setting CPU throttle for VM. (90%)
2021-08-03 13:27:23 (10596): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 14:01:20 (10596): Preference change detected
2021-08-03 14:01:20 (10596): Setting CPU throttle for VM. (90%)
2021-08-03 14:01:21 (10596): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:00:38 (10596): Stopping VM.
2021-08-03 15:05:43 (5984): Detected: vboxwrapper 26197
2021-08-03 15:05:43 (5984): Detected: BOINC client v7.7
2021-08-03 15:05:44 (5984): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:05:44 (5984): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:05:45 (5984): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:06:01 (5984): Successfully started VM. (PID = '10492')
2021-08-03 15:06:01 (5984): Reporting VM Process ID to BOINC.
2021-08-03 15:06:01 (5984): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:06:01 (5984): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:06:01 (5984): Status Report: Job Duration: '864000.000000'
2021-08-03 15:06:01 (5984): Status Report: Elapsed Time: '576163.509930'
2021-08-03 15:06:01 (5984): Status Report: CPU Time: '556953.250000'
2021-08-03 15:06:01 (5984): Preference change detected
2021-08-03 15:06:01 (5984): Setting CPU throttle for VM. (90%)
2021-08-03 15:06:02 (5984): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:06:43 (5984): Stopping VM.
2021-08-03 15:08:46 (7476): Detected: vboxwrapper 26197
2021-08-03 15:08:46 (7476): Detected: BOINC client v7.7
2021-08-03 15:08:47 (7476): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:08:47 (7476): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:08:47 (7476): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:09:03 (7476): Successfully started VM. (PID = '6904')
2021-08-03 15:09:03 (7476): Reporting VM Process ID to BOINC.
2021-08-03 15:09:03 (7476): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:09:03 (7476): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:09:04 (7476): Status Report: Job Duration: '864000.000000'
2021-08-03 15:09:04 (7476): Status Report: Elapsed Time: '576198.509930'
2021-08-03 15:09:04 (7476): Status Report: CPU Time: '556995.562500'
2021-08-03 15:09:04 (7476): Preference change detected
2021-08-03 15:09:04 (7476): Setting CPU throttle for VM. (90%)
2021-08-03 15:09:05 (7476): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:09:46 (7476): Stopping VM.
2021-08-03 15:11:48 (2972): Detected: vboxwrapper 26197
2021-08-03 15:11:48 (2972): Detected: BOINC client v7.7
2021-08-03 15:11:49 (2972): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:11:50 (2972): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:11:50 (2972): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:12:06 (2972): Successfully started VM. (PID = '10492')
2021-08-03 15:12:06 (2972): Reporting VM Process ID to BOINC.
2021-08-03 15:12:06 (2972): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:12:06 (2972): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:12:06 (2972): Status Report: Job Duration: '864000.000000'
2021-08-03 15:12:06 (2972): Status Report: Elapsed Time: '576237.770319'
2021-08-03 15:12:06 (2972): Status Report: CPU Time: '557036.468750'
2021-08-03 15:12:06 (2972): Preference change detected
2021-08-03 15:12:06 (2972): Setting CPU throttle for VM. (90%)
2021-08-03 15:12:07 (2972): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:12:48 (2972): Stopping VM.
2021-08-03 15:13:50 (12056): Detected: vboxwrapper 26197
2021-08-03 15:13:50 (12056): Detected: BOINC client v7.7
2021-08-03 15:13:51 (12056): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:13:52 (12056): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:13:52 (12056): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:14:08 (12056): Successfully started VM. (PID = '10260')
2021-08-03 15:14:08 (12056): Reporting VM Process ID to BOINC.
2021-08-03 15:14:08 (12056): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:14:08 (12056): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:14:08 (12056): Status Report: Job Duration: '864000.000000'
2021-08-03 15:14:08 (12056): Status Report: Elapsed Time: '576271.770319'
2021-08-03 15:14:08 (12056): Status Report: CPU Time: '557080.140625'
2021-08-03 15:14:08 (12056): Preference change detected
2021-08-03 15:14:08 (12056): Setting CPU throttle for VM. (90%)
2021-08-03 15:14:10 (12056): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:14:50 (12056): Stopping VM.
2021-08-03 15:18:54 (2580): Detected: vboxwrapper 26197
2021-08-03 15:18:54 (2580): Detected: BOINC client v7.7
2021-08-03 15:18:55 (2580): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:18:56 (2580): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:18:56 (2580): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:19:14 (2580): Successfully started VM. (PID = '9496')
2021-08-03 15:19:14 (2580): Reporting VM Process ID to BOINC.
2021-08-03 15:19:14 (2580): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:19:14 (2580): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:19:14 (2580): Status Report: Job Duration: '864000.000000'
2021-08-03 15:19:14 (2580): Status Report: Elapsed Time: '576308.885941'
2021-08-03 15:19:14 (2580): Status Report: CPU Time: '557123.000000'
2021-08-03 15:19:14 (2580): Preference change detected
2021-08-03 15:19:14 (2580): Setting CPU throttle for VM. (90%)
2021-08-03 15:19:15 (2580): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:20:56 (2580): Stopping VM.
2021-08-03 15:28:02 (2728): Detected: vboxwrapper 26197
2021-08-03 15:28:02 (2728): Detected: BOINC client v7.7
2021-08-03 15:28:06 (2728): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:28:07 (2728): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:28:07 (2728): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:28:23 (2728): Successfully started VM. (PID = '12180')
2021-08-03 15:28:23 (2728): Reporting VM Process ID to BOINC.
2021-08-03 15:28:23 (2728): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:28:23 (2728): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:28:23 (2728): Status Report: Job Duration: '864000.000000'
2021-08-03 15:28:23 (2728): Status Report: Elapsed Time: '576388.885941'
2021-08-03 15:28:23 (2728): Status Report: CPU Time: '557223.437500'
2021-08-03 15:28:23 (2728): Preference change detected
2021-08-03 15:28:23 (2728): Setting CPU throttle for VM. (90%)
2021-08-03 15:28:26 (2728): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:30:04 (2728): Stopping VM.
2021-08-03 15:31:05 (9992): Detected: vboxwrapper 26197
2021-08-03 15:31:05 (9992): Detected: BOINC client v7.7
2021-08-03 15:31:09 (9992): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:31:09 (9992): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:31:10 (9992): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:31:28 (9992): Successfully started VM. (PID = '9320')
2021-08-03 15:31:28 (9992): Reporting VM Process ID to BOINC.
2021-08-03 15:31:28 (9992): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:31:28 (9992): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:31:28 (9992): Status Report: Job Duration: '864000.000000'
2021-08-03 15:31:28 (9992): Status Report: Elapsed Time: '576474.408679'
2021-08-03 15:31:28 (9992): Status Report: CPU Time: '557316.562500'
2021-08-03 15:31:28 (9992): Preference change detected
2021-08-03 15:31:28 (9992): Setting CPU throttle for VM. (90%)
2021-08-03 15:31:30 (9992): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:32:06 (9992): Stopping VM.
2021-08-03 15:39:12 (11760): Detected: vboxwrapper 26197
2021-08-03 15:39:12 (11760): Detected: BOINC client v7.7
2021-08-03 15:39:15 (11760): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:39:16 (11760): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:39:16 (11760): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:39:34 (11760): Successfully started VM. (PID = '8420')
2021-08-03 15:39:34 (11760): Reporting VM Process ID to BOINC.
2021-08-03 15:39:34 (11760): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:39:34 (11760): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:39:34 (11760): Status Report: Job Duration: '864000.000000'
2021-08-03 15:39:34 (11760): Status Report: Elapsed Time: '576502.469630'
2021-08-03 15:39:34 (11760): Status Report: CPU Time: '557352.140625'
2021-08-03 15:39:34 (11760): Preference change detected
2021-08-03 15:39:34 (11760): Setting CPU throttle for VM. (90%)
2021-08-03 15:39:35 (11760): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:43:13 (11760): Stopping VM.
2021-08-03 15:44:15 (7664): Detected: vboxwrapper 26197
2021-08-03 15:44:15 (7664): Detected: BOINC client v7.7
2021-08-03 15:44:18 (7664): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:44:18 (7664): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:44:19 (7664): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:44:32 (7664): Successfully started VM. (PID = '2652')
2021-08-03 15:44:32 (7664): Reporting VM Process ID to BOINC.
2021-08-03 15:44:32 (7664): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:44:32 (7664): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:44:32 (7664): Status Report: Job Duration: '864000.000000'
2021-08-03 15:44:32 (7664): Status Report: Elapsed Time: '576707.469630'
2021-08-03 15:44:32 (7664): Status Report: CPU Time: '557553.312500'
2021-08-03 15:44:32 (7664): Preference change detected
2021-08-03 15:44:32 (7664): Setting CPU throttle for VM. (90%)
2021-08-03 15:44:33 (7664): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:46:31 (7664): Stopping VM.
2021-08-03 15:47:33 (10512): Detected: vboxwrapper 26197
2021-08-03 15:47:33 (10512): Detected: BOINC client v7.7
2021-08-03 15:47:36 (10512): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:47:37 (10512): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:47:37 (10512): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:47:51 (10512): Successfully started VM. (PID = '1768')
2021-08-03 15:47:51 (10512): Reporting VM Process ID to BOINC.
2021-08-03 15:47:51 (10512): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:47:51 (10512): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:47:51 (10512): Status Report: Job Duration: '864000.000000'
2021-08-03 15:47:51 (10512): Status Report: Elapsed Time: '576817.469630'
2021-08-03 15:47:51 (10512): Status Report: CPU Time: '557669.328125'
2021-08-03 15:47:51 (10512): Preference change detected
2021-08-03 15:47:51 (10512): Setting CPU throttle for VM. (90%)
2021-08-03 15:47:52 (10512): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:49:34 (10512): Stopping VM.
2021-08-03 15:49:41 (10512): Error in stop VM for VM: -2147024891
Command:
VBoxManage -q controlvm "boinc_051222e202cc8b92" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...
Progress state: E_ACCESSDENIED
VBoxManage.exe: error: Failed to save machine state
VBoxManage.exe: error: Assertion failed: [SUCCEEDED(rc)] at 'F:\tinderbox\win-6.1\src\VBox\Main\src-server\MachineImpl.cpp' (10350) in long __cdecl Machine::i_saveStorageControllers(struct settings::Storage &).
VBoxManage.exe: error: COM RC=E_ACCESSDENIED (0x80070005).
VBoxManage.exe: error: Please contact the product vendor!
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface IMachine
VBoxManage.exe: error: Context: "enum RTEXITCODE __cdecl handleControlVM(struct HandlerArg *)" at line 664 of file VBoxManageControlVM.cpp

2021-08-03 15:49:41 (10512): VM did not stop when requested.
2021-08-03 15:49:41 (10512): VM was NOT successfully terminated.
2021-08-03 15:49:42 (10960): Detected: vboxwrapper 26197
2021-08-03 15:49:42 (10960): Detected: BOINC client v7.7
2021-08-03 15:49:42 (10960): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:49:43 (10960): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:49:43 (10960): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:49:58 (10960): Successfully started VM. (PID = '7568')
2021-08-03 15:49:58 (10960): Reporting VM Process ID to BOINC.
2021-08-03 15:49:58 (10960): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:49:58 (10960): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:49:58 (10960): Status Report: Job Duration: '864000.000000'
2021-08-03 15:49:58 (10960): Status Report: Elapsed Time: '576910.469630'
2021-08-03 15:49:58 (10960): Status Report: CPU Time: '557766.765625'
2021-08-03 15:49:58 (10960): Preference change detected
2021-08-03 15:49:58 (10960): Setting CPU throttle for VM. (90%)
2021-08-03 15:49:58 (10960): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:50:42 (10960): Stopping VM.
2021-08-03 15:56:48 (1184): Detected: vboxwrapper 26197
2021-08-03 15:56:48 (1184): Detected: BOINC client v7.7
2021-08-03 15:56:53 (1184): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:56:53 (1184): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:56:54 (1184): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 15:57:11 (1184): Successfully started VM. (PID = '5332')
2021-08-03 15:57:11 (1184): Reporting VM Process ID to BOINC.
2021-08-03 15:57:11 (1184): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 15:57:11 (1184): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 15:57:11 (1184): Status Report: Job Duration: '864000.000000'
2021-08-03 15:57:11 (1184): Status Report: Elapsed Time: '576949.469630'
2021-08-03 15:57:11 (1184): Status Report: CPU Time: '557808.046875'
2021-08-03 15:57:11 (1184): Preference change detected
2021-08-03 15:57:11 (1184): Setting CPU throttle for VM. (90%)
2021-08-03 15:57:14 (1184): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 15:57:49 (1184): Stopping VM.
2021-08-03 15:59:51 (7820): Detected: vboxwrapper 26197
2021-08-03 15:59:51 (7820): Detected: BOINC client v7.7
2021-08-03 15:59:55 (7820): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 15:59:55 (7820): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 15:59:56 (7820): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 16:00:10 (7820): Successfully started VM. (PID = '4684')
2021-08-03 16:00:10 (7820): Reporting VM Process ID to BOINC.
2021-08-03 16:00:10 (7820): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 16:00:10 (7820): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 16:00:10 (7820): Status Report: Job Duration: '864000.000000'
2021-08-03 16:00:10 (7820): Status Report: Elapsed Time: '576982.230304'
2021-08-03 16:00:10 (7820): Status Report: CPU Time: '557853.750000'
2021-08-03 16:00:10 (7820): Preference change detected
2021-08-03 16:00:10 (7820): Setting CPU throttle for VM. (90%)
2021-08-03 16:00:10 (7820): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 16:02:51 (7820): Stopping VM.
2021-08-03 16:03:53 (5692): Detected: vboxwrapper 26197
2021-08-03 16:03:53 (5692): Detected: BOINC client v7.7
2021-08-03 16:03:56 (5692): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 16:03:57 (5692): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 16:03:57 (5692): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 16:04:10 (5692): Successfully started VM. (PID = '11076')
2021-08-03 16:04:10 (5692): Reporting VM Process ID to BOINC.
2021-08-03 16:04:10 (5692): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 16:04:10 (5692): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 16:04:10 (5692): Status Report: Job Duration: '864000.000000'
2021-08-03 16:04:10 (5692): Status Report: Elapsed Time: '577133.230304'
2021-08-03 16:04:10 (5692): Status Report: CPU Time: '558006.000000'
2021-08-03 16:04:10 (5692): Preference change detected
2021-08-03 16:04:10 (5692): Setting CPU throttle for VM. (90%)
2021-08-03 16:04:11 (5692): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 16:07:54 (5692): Stopping VM.
2021-08-03 16:08:55 (7356): Detected: vboxwrapper 26197
2021-08-03 16:08:55 (7356): Detected: BOINC client v7.7
2021-08-03 16:08:58 (7356): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 16:08:58 (7356): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 16:08:59 (7356): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 16:09:12 (7356): Successfully started VM. (PID = '6880')
2021-08-03 16:09:12 (7356): Reporting VM Process ID to BOINC.
2021-08-03 16:09:12 (7356): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 16:09:12 (7356): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 16:09:12 (7356): Status Report: Job Duration: '864000.000000'
2021-08-03 16:09:12 (7356): Status Report: Elapsed Time: '577337.230304'
2021-08-03 16:09:12 (7356): Status Report: CPU Time: '558212.859375'
2021-08-03 16:09:12 (7356): Preference change detected
2021-08-03 16:09:12 (7356): Setting CPU throttle for VM. (90%)
2021-08-03 16:09:13 (7356): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 16:15:56 (7356): Stopping VM.
2021-08-03 16:16:58 (12196): Detected: vboxwrapper 26197
2021-08-03 16:16:58 (12196): Detected: BOINC client v7.7
2021-08-03 16:17:01 (12196): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 16:17:01 (12196): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 16:17:01 (12196): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 16:17:17 (12196): Successfully started VM. (PID = '9520')
2021-08-03 16:17:17 (12196): Reporting VM Process ID to BOINC.
2021-08-03 16:17:17 (12196): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 16:17:17 (12196): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 16:17:17 (12196): Status Report: Job Duration: '864000.000000'
2021-08-03 16:17:17 (12196): Status Report: Elapsed Time: '577713.230304'
2021-08-03 16:17:17 (12196): Status Report: CPU Time: '558579.406250'
2021-08-03 16:17:17 (12196): Preference change detected
2021-08-03 16:17:17 (12196): Setting CPU throttle for VM. (90%)
2021-08-03 16:17:18 (12196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 16:26:05 (12196): Stopping VM.
2021-08-03 16:27:06 (5140): Detected: vboxwrapper 26197
2021-08-03 16:27:06 (5140): Detected: BOINC client v7.7
2021-08-03 16:27:09 (5140): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 16:27:09 (5140): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 16:27:10 (5140): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 16:27:24 (5140): Successfully started VM. (PID = '8644')
2021-08-03 16:27:24 (5140): Reporting VM Process ID to BOINC.
2021-08-03 16:27:24 (5140): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 16:27:24 (5140): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 16:27:24 (5140): Status Report: Job Duration: '864000.000000'
2021-08-03 16:27:24 (5140): Status Report: Elapsed Time: '578205.243692'
2021-08-03 16:27:24 (5140): Status Report: CPU Time: '559051.343750'
2021-08-03 16:27:24 (5140): Preference change detected
2021-08-03 16:27:24 (5140): Setting CPU throttle for VM. (90%)
2021-08-03 16:27:24 (5140): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 16:28:06 (5140): Stopping VM.
2021-08-03 16:28:14 (5140): Error in stop VM for VM: -2147024891
Command:
VBoxManage -q controlvm "boinc_051222e202cc8b92" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...
Progress state: E_ACCESSDENIED
VBoxManage.exe: error: Failed to save machine state
VBoxManage.exe: error: Assertion failed: [SUCCEEDED(rc)] at 'F:\tinderbox\win-6.1\src\VBox\Main\src-server\MachineImpl.cpp' (10350) in long __cdecl Machine::i_saveStorageControllers(struct settings::Storage &).
VBoxManage.exe: error: COM RC=E_ACCESSDENIED (0x80070005).
VBoxManage.exe: error: Please contact the product vendor!
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface IMachine
VBoxManage.exe: error: Context: "enum RTEXITCODE __cdecl handleControlVM(struct HandlerArg *)" at line 664 of file VBoxManageControlVM.cpp

2021-08-03 16:28:14 (5140): VM did not stop when requested.
2021-08-03 16:28:14 (5140): VM was NOT successfully terminated.
2021-08-03 16:29:15 (6928): Detected: vboxwrapper 26197
2021-08-03 16:29:15 (6928): Detected: BOINC client v7.7
2021-08-03 16:29:18 (6928): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 16:29:18 (6928): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 16:29:19 (6928): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 16:29:28 (6928): Successfully started VM. (PID = '1144')
2021-08-03 16:29:28 (6928): Reporting VM Process ID to BOINC.
2021-08-03 16:29:28 (6928): Guest Log: BIOS: VirtualBox 6.1.12

2021-08-03 16:29:28 (6928): Guest Log: CPUID EDX: 0x178bfbff

2021-08-03 16:29:28 (6928): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-08-03 16:29:28 (6928): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 16:29:28 (6928): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 16:29:28 (6928): Status Report: Job Duration: '864000.000000'
2021-08-03 16:29:28 (6928): Status Report: Elapsed Time: '578244.243692'
2021-08-03 16:29:28 (6928): Status Report: CPU Time: '559089.031250'
2021-08-03 16:29:28 (6928): Preference change detected
2021-08-03 16:29:28 (6928): Setting CPU throttle for VM. (90%)
2021-08-03 16:29:29 (6928): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 16:29:30 (6928): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-08-03 16:29:30 (6928): Guest Log: BIOS: Booting from Hard Disk...

2021-08-03 16:29:33 (6928): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-08-03 16:29:33 (6928): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-08-03 16:30:10 (6928): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-08-03 16:30:10 (6928): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-08-03 16:30:20 (6928): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.000286 main     Log opened 2021-08-03T20:26:07.133195000Z

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.000665 main     OS Product: Linux

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.002704 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.002869 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.002978 main     Executable: /usr/sbin/VBoxService

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.002981 main     Process ID: 3209

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.002983 main     Package type: LINUX_64BITS_GENERIC

2021-08-03 16:30:20 (6928): Guest Log: 00:00:00.019724 main     5.2.6 r120293 started. Verbose level = 0

2021-08-03 16:31:19 (6928): Guest Log: 16:27:06 EDT -04:00 2021-08-03: cranky: [INFO] Detected Theory App

2021-08-03 16:31:19 (6928): Guest Log: 16:27:06 EDT -04:00 2021-08-03: cranky: [INFO] Checking CVMFS.

2021-08-03 16:31:23 (6928): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2021-08-03 16:31:25 (6928): 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

2021-08-03 16:31:25 (6928): Guest Log: 2.5.2.0 4134 0 27144 20715 3 1 1469817 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2021-08-03 16:31:31 (6928): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-08-03 16:31:33 (6928): 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

2021-08-03 16:31:33 (6928): Guest Log: 2.5.2.0 4089 0 25484 15877 3 2 1469817 4096000 0 65024 0 2 0 4276 1885 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2021-08-03 16:31:38 (6928): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2021-08-03 16:31:40 (6928): 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

2021-08-03 16:31:40 (6928): Guest Log: 2.5.2.0 4067 0 27204 267 3 1 1469817 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2021-08-03 16:31:45 (6928): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2021-08-03 16:31:48 (6928): 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

2021-08-03 16:31:48 (6928): Guest Log: 2.5.2.0 4110 0 34116 9909 3 1 1469817 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2021-08-03 16:31:48 (6928): Guest Log: 16:27:34 EDT -04:00 2021-08-03: cranky: [INFO] Checking runc.

2021-08-03 16:31:48 (6928): Guest Log: 16:27:35 EDT -04:00 2021-08-03: cranky: [INFO] Creating the filesystem.

2021-08-03 16:31:48 (6928): Guest Log: 16:27:35 EDT -04:00 2021-08-03: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2021-08-03 16:31:49 (6928): Guest Log: 16:27:35 EDT -04:00 2021-08-03: cranky: [INFO] Updating config.json.

2021-08-03 16:31:49 (6928): Guest Log: 16:27:36 EDT -04:00 2021-08-03: cranky: [INFO] Running Container 'runc'.

2021-08-03 16:31:50 (6928): Guest Log: job: htmld=/shared/html/job

2021-08-03 16:31:50 (6928): Guest Log: job: unpack exitcode=0

2021-08-03 16:31:51 (6928): Guest Log: 16:27:38 EDT -04:00 2021-08-03: cranky: [INFO] ===> [runRivet] Tue Aug  3 20:27:37 UTC 2021 [boinc pp jets 8000 180,-,3560 - pythia8 8.301 dire-default 43000 194]

2021-08-03 16:51:06 (6928): Stopping VM.
2021-08-03 16:52:08 (1048): Detected: vboxwrapper 26197
2021-08-03 16:52:08 (1048): Detected: BOINC client v7.7
2021-08-03 16:52:11 (1048): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 16:52:12 (1048): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 16:52:12 (1048): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 16:52:28 (1048): Successfully started VM. (PID = '12264')
2021-08-03 16:52:28 (1048): Reporting VM Process ID to BOINC.
2021-08-03 16:52:28 (1048): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 16:52:28 (1048): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 16:52:28 (1048): Status Report: Job Duration: '864000.000000'
2021-08-03 16:52:28 (1048): Status Report: Elapsed Time: '579469.397668'
2021-08-03 16:52:28 (1048): Status Report: CPU Time: '560209.843750'
2021-08-03 16:52:28 (1048): Preference change detected
2021-08-03 16:52:28 (1048): Setting CPU throttle for VM. (90%)
2021-08-03 16:52:30 (1048): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:00:09 (1048): Stopping VM.
2021-08-03 17:01:11 (9628): Detected: vboxwrapper 26197
2021-08-03 17:01:11 (9628): Detected: BOINC client v7.7
2021-08-03 17:01:14 (9628): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:01:14 (9628): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:01:14 (9628): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:01:29 (9628): Successfully started VM. (PID = '6920')
2021-08-03 17:01:29 (9628): Reporting VM Process ID to BOINC.
2021-08-03 17:01:29 (9628): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:01:29 (9628): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:01:29 (9628): Status Report: Job Duration: '864000.000000'
2021-08-03 17:01:29 (9628): Status Report: Elapsed Time: '579901.640487'
2021-08-03 17:01:29 (9628): Status Report: CPU Time: '560627.468750'
2021-08-03 17:01:29 (9628): Preference change detected
2021-08-03 17:01:29 (9628): Setting CPU throttle for VM. (90%)
2021-08-03 17:01:29 (9628): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:27:15 (9628): Stopping VM.
2021-08-03 17:30:18 (11356): Detected: vboxwrapper 26197
2021-08-03 17:30:18 (11356): Detected: BOINC client v7.7
2021-08-03 17:30:22 (11356): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:30:23 (11356): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:30:23 (11356): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:30:39 (11356): Successfully started VM. (PID = '5656')
2021-08-03 17:30:39 (11356): Reporting VM Process ID to BOINC.
2021-08-03 17:30:39 (11356): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:30:39 (11356): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:30:39 (11356): Status Report: Job Duration: '864000.000000'
2021-08-03 17:30:39 (11356): Status Report: Elapsed Time: '581350.640487'
2021-08-03 17:30:39 (11356): Status Report: CPU Time: '561974.500000'
2021-08-03 17:30:39 (11356): Preference change detected
2021-08-03 17:30:39 (11356): Setting CPU throttle for VM. (90%)
2021-08-03 17:30:40 (11356): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:31:18 (11356): Stopping VM.
2021-08-03 17:35:22 (11528): Detected: vboxwrapper 26197
2021-08-03 17:35:22 (11528): Detected: BOINC client v7.7
2021-08-03 17:35:26 (11528): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:35:26 (11528): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:35:27 (11528): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:35:43 (11528): Successfully started VM. (PID = '8588')
2021-08-03 17:35:43 (11528): Reporting VM Process ID to BOINC.
2021-08-03 17:35:43 (11528): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:35:43 (11528): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:35:43 (11528): Status Report: Job Duration: '864000.000000'
2021-08-03 17:35:43 (11528): Status Report: Elapsed Time: '581379.952625'
2021-08-03 17:35:43 (11528): Status Report: CPU Time: '562007.671875'
2021-08-03 17:35:43 (11528): Preference change detected
2021-08-03 17:35:43 (11528): Setting CPU throttle for VM. (90%)
2021-08-03 17:35:44 (11528): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:36:22 (11528): Stopping VM.
2021-08-03 17:38:25 (2828): Detected: vboxwrapper 26197
2021-08-03 17:38:25 (2828): Detected: BOINC client v7.7
2021-08-03 17:38:28 (2828): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:38:29 (2828): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:38:29 (2828): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:38:49 (2828): Successfully started VM. (PID = '7672')
2021-08-03 17:38:49 (2828): Reporting VM Process ID to BOINC.
2021-08-03 17:38:50 (2828): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:38:50 (2828): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:38:50 (2828): Status Report: Job Duration: '864000.000000'
2021-08-03 17:38:50 (2828): Status Report: Elapsed Time: '581416.114406'
2021-08-03 17:38:50 (2828): Status Report: CPU Time: '562045.218750'
2021-08-03 17:38:50 (2828): Preference change detected
2021-08-03 17:38:50 (2828): Setting CPU throttle for VM. (90%)
2021-08-03 17:38:52 (2828): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:39:25 (2828): Stopping VM.
2021-08-03 17:40:48 (8732): Detected: vboxwrapper 26197
2021-08-03 17:40:48 (8732): Detected: BOINC client v7.7
2021-08-03 17:40:52 (8732): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:40:53 (8732): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:40:53 (8732): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:41:09 (8732): Successfully started VM. (PID = '3020')
2021-08-03 17:41:09 (8732): Reporting VM Process ID to BOINC.
2021-08-03 17:41:09 (8732): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:41:09 (8732): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:41:09 (8732): Status Report: Job Duration: '864000.000000'
2021-08-03 17:41:09 (8732): Status Report: Elapsed Time: '581449.333516'
2021-08-03 17:41:09 (8732): Status Report: CPU Time: '562087.359375'
2021-08-03 17:41:09 (8732): Preference change detected
2021-08-03 17:41:09 (8732): Setting CPU throttle for VM. (90%)
2021-08-03 17:41:10 (8732): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:41:48 (8732): Stopping VM.
2021-08-03 17:42:49 (9920): Detected: vboxwrapper 26197
2021-08-03 17:42:49 (9920): Detected: BOINC client v7.7
2021-08-03 17:42:53 (9920): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:42:53 (9920): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:42:54 (9920): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:43:09 (9920): Successfully started VM. (PID = '12156')
2021-08-03 17:43:09 (9920): Reporting VM Process ID to BOINC.
2021-08-03 17:43:09 (9920): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:43:09 (9920): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:43:09 (9920): Status Report: Job Duration: '864000.000000'
2021-08-03 17:43:09 (9920): Status Report: Elapsed Time: '581486.333516'
2021-08-03 17:43:09 (9920): Status Report: CPU Time: '562126.000000'
2021-08-03 17:43:09 (9920): Preference change detected
2021-08-03 17:43:09 (9920): Setting CPU throttle for VM. (90%)
2021-08-03 17:43:10 (9920): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:44:52 (9920): Stopping VM.
2021-08-03 17:45:00 (9920): Error in stop VM for VM: -2147024891
Command:
VBoxManage -q controlvm "boinc_051222e202cc8b92" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...
Progress state: E_ACCESSDENIED
VBoxManage.exe: error: Failed to save machine state
VBoxManage.exe: error: Assertion failed: [SUCCEEDED(rc)] at 'F:\tinderbox\win-6.1\src\VBox\Main\src-server\MachineImpl.cpp' (10350) in long __cdecl Machine::i_saveStorageControllers(struct settings::Storage &).
VBoxManage.exe: error: COM RC=E_ACCESSDENIED (0x80070005).
VBoxManage.exe: error: Please contact the product vendor!
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface IMachine
VBoxManage.exe: error: Context: "enum RTEXITCODE __cdecl handleControlVM(struct HandlerArg *)" at line 664 of file VBoxManageControlVM.cpp

2021-08-03 17:45:00 (9920): VM did not stop when requested.
2021-08-03 17:45:00 (9920): VM was successfully terminated.
2021-08-03 17:46:01 (7476): Detected: vboxwrapper 26197
2021-08-03 17:46:01 (7476): Detected: BOINC client v7.7
2021-08-03 17:46:05 (7476): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:46:05 (7476): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:46:06 (7476): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:46:17 (7476): Successfully started VM. (PID = '6408')
2021-08-03 17:46:17 (7476): Reporting VM Process ID to BOINC.
2021-08-03 17:46:17 (7476): Guest Log: BIOS: VirtualBox 6.1.12

2021-08-03 17:46:17 (7476): Guest Log: CPUID EDX: 0x178bfbff

2021-08-03 17:46:17 (7476): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-08-03 17:46:17 (7476): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:46:17 (7476): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:46:17 (7476): Status Report: Job Duration: '864000.000000'
2021-08-03 17:46:17 (7476): Status Report: Elapsed Time: '581573.333516'
2021-08-03 17:46:17 (7476): Status Report: CPU Time: '562216.750000'
2021-08-03 17:46:17 (7476): Preference change detected
2021-08-03 17:46:17 (7476): Setting CPU throttle for VM. (90%)
2021-08-03 17:46:17 (7476): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:46:19 (7476): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-08-03 17:46:19 (7476): Guest Log: BIOS: Booting from Hard Disk...

2021-08-03 17:46:22 (7476): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-08-03 17:46:22 (7476): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-08-03 17:46:59 (7476): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-08-03 17:46:59 (7476): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-08-03 17:47:02 (7476): Stopping VM.
2021-08-03 17:48:03 (8304): Detected: vboxwrapper 26197
2021-08-03 17:48:03 (8304): Detected: BOINC client v7.7
2021-08-03 17:48:07 (8304): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:48:08 (8304): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:48:08 (8304): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:48:24 (8304): Successfully started VM. (PID = '4404')
2021-08-03 17:48:24 (8304): Reporting VM Process ID to BOINC.
2021-08-03 17:48:24 (8304): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:48:24 (8304): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:48:24 (8304): Status Report: Job Duration: '864000.000000'
2021-08-03 17:48:24 (8304): Status Report: Elapsed Time: '581615.333516'
2021-08-03 17:48:24 (8304): Status Report: CPU Time: '562245.328125'
2021-08-03 17:48:24 (8304): Preference change detected
2021-08-03 17:48:24 (8304): Setting CPU throttle for VM. (90%)
2021-08-03 17:48:25 (8304): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:48:29 (8304): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.000341 main     Log opened 2021-08-03T21:42:57.596466000Z

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.001335 main     OS Product: Linux

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.003668 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.003834 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.003941 main     Executable: /usr/sbin/VBoxService

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.003944 main     Process ID: 3204

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.003947 main     Package type: LINUX_64BITS_GENERIC

2021-08-03 17:48:29 (8304): Guest Log: 00:00:00.008318 main     5.2.6 r120293 started. Verbose level = 0

2021-08-03 17:49:03 (8304): Stopping VM.
2021-08-03 17:49:09 (8304): Error in stop VM for VM: -2147024891
Command:
VBoxManage -q controlvm "boinc_051222e202cc8b92" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...
Progress state: E_ACCESSDENIED
VBoxManage.exe: error: Failed to save machine state
VBoxManage.exe: error: Assertion failed: [SUCCEEDED(rc)] at 'F:\tinderbox\win-6.1\src\VBox\Main\src-server\MachineImpl.cpp' (10350) in long __cdecl Machine::i_saveStorageControllers(struct settings::Storage &).
VBoxManage.exe: error: COM RC=E_ACCESSDENIED (0x80070005).
VBoxManage.exe: error: Please contact the product vendor!
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface IMachine
VBoxManage.exe: error: Context: "enum RTEXITCODE __cdecl handleControlVM(struct HandlerArg *)" at line 664 of file VBoxManageControlVM.cpp

2021-08-03 17:49:09 (8304): VM did not stop when requested.
2021-08-03 17:49:09 (8304): VM was successfully terminated.
2021-08-03 17:50:29 (5864): Detected: vboxwrapper 26197
2021-08-03 17:50:29 (5864): Detected: BOINC client v7.7
2021-08-03 17:50:32 (5864): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:50:33 (5864): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:50:34 (5864): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:50:44 (5864): Successfully started VM. (PID = '7044')
2021-08-03 17:50:44 (5864): Reporting VM Process ID to BOINC.
2021-08-03 17:50:44 (5864): Guest Log: BIOS: VirtualBox 6.1.12

2021-08-03 17:50:44 (5864): Guest Log: CPUID EDX: 0x178bfbff

2021-08-03 17:50:44 (5864): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-08-03 17:50:44 (5864): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:50:44 (5864): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:50:44 (5864): Status Report: Job Duration: '864000.000000'
2021-08-03 17:50:44 (5864): Status Report: Elapsed Time: '581648.725707'
2021-08-03 17:50:44 (5864): Status Report: CPU Time: '562286.734375'
2021-08-03 17:50:44 (5864): Preference change detected
2021-08-03 17:50:44 (5864): Setting CPU throttle for VM. (90%)
2021-08-03 17:50:45 (5864): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:50:46 (5864): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-08-03 17:50:46 (5864): Guest Log: BIOS: Booting from Hard Disk...

2021-08-03 17:50:49 (5864): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-08-03 17:50:49 (5864): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-08-03 17:51:27 (5864): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-08-03 17:51:28 (5864): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-08-03 17:51:30 (5864): Stopping VM.
2021-08-03 17:53:33 (12276): Detected: vboxwrapper 26197
2021-08-03 17:53:33 (12276): Detected: BOINC client v7.7
2021-08-03 17:53:36 (12276): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2021-08-03 17:53:36 (12276): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2021-08-03 17:53:37 (12276): Starting VM using VBoxManage interface. (boinc_051222e202cc8b92, slot#2)
2021-08-03 17:53:49 (12276): Successfully started VM. (PID = '5308')
2021-08-03 17:53:49 (12276): Reporting VM Process ID to BOINC.
2021-08-03 17:53:49 (12276): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-08-03 17:53:49 (12276): Detected: Web Application Enabled (http://localhost:55460)
2021-08-03 17:53:49 (12276): Status Report: Job Duration: '864000.000000'
2021-08-03 17:53:49 (12276): Status Report: Elapsed Time: '581690.725707'
2021-08-03 17:53:49 (12276): Status Report: CPU Time: '562318.921875'
2021-08-03 17:53:49 (12276): Preference change detected
2021-08-03 17:53:49 (12276): Setting CPU throttle for VM. (90%)
2021-08-03 17:53:50 (12276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 17:53:53 (12276): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.000406 main     Log opened 2021-08-03T21:47:22.631837000Z

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.002282 main     OS Product: Linux

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.002449 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.002572 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.002675 main     Executable: /usr/sbin/VBoxService

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.002678 main     Process ID: 3204

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.002681 main     Package type: LINUX_64BITS_GENERIC

2021-08-03 17:53:53 (12276): Guest Log: 00:00:00.009404 main     5.2.6 r120293 started. Verbose level = 0

2021-08-03 17:54:14 (12276): Guest Log: 17:47:44 EDT -04:00 2021-08-03: cranky: [INFO] Detected Theory App

2021-08-03 17:54:14 (12276): Guest Log: 17:47:44 EDT -04:00 2021-08-03: cranky: [INFO] Checking CVMFS.

2021-08-03 17:54:16 (12276): Guest Log: cvmfs2: /home/sftnight/jenkins/workspace/CvmfsFullBuildDocker/CVMFS_BUILD_ARCH/docker-x86_64/CVMFS_BUILD_PLATFORM/cc7/build/BUILD/cvmfs-2.5.2/cvmfs/options.cc:320: void loader::OptionsManager::PopulateParameter(const string&, loader::OptionsManager::ConfigValue): Assertion `retval == 0' failed.

2021-08-03 17:54:17 (12276): Guest Log: cvmfs2: /home/sftnight/jenkins/workspace/CvmfsFullBuildDocker/CVMFS_BUILD_ARCH/docker-x86_64/CVMFS_BUILD_PLATFORM/cc7/build/BUILD/cvmfs-2.5.2/cvmfs/options.cc:320: void loader::OptionsManager::PopulateParameter(const string&, loader::OptionsManager::ConfigValue): Assertion `retval == 0' failed.

2021-08-03 17:54:17 (12276): Guest Log: cvmfs2: /home/sftnight/jenkins/workspace/CvmfsFullBuildDocker/CVMFS_BUILD_ARCH/docker-x86_64/CVMFS_BUILD_PLATFORM/cc7/build/BUILD/cvmfs-2.5.2/cvmfs/options.cc:320: void loader::OptionsManager::PopulateParameter(const string&, loader::OptionsManager::ConfigValue): Assertion `retval == 0' failed.

2021-08-03 17:54:17 (12276): Guest Log: Probing /sft.cern.ch... Failed!

2021-08-03 17:54:17 (12276): Guest Log: 17:47:47 EDT -04:00 2021-08-03: cranky: [ERROR] 'cvmfs_config probe sft.cern.ch' failed.

2021-08-03 18:01:22 (12276): Preference change detected
2021-08-03 18:01:22 (12276): Setting CPU throttle for VM. (90%)
2021-08-03 18:01:23 (12276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 19:35:27 (12276): Status Report: Job Duration: '864000.000000'
2021-08-03 19:35:27 (12276): Status Report: Elapsed Time: '587690.725707'
2021-08-03 19:35:27 (12276): Status Report: CPU Time: '562417.375000'
2021-08-03 21:18:48 (12276): Status Report: Job Duration: '864000.000000'
2021-08-03 21:18:48 (12276): Status Report: Elapsed Time: '593690.725707'
2021-08-03 21:18:48 (12276): Status Report: CPU Time: '562483.968750'
2021-08-03 22:01:25 (12276): Preference change detected
2021-08-03 22:01:25 (12276): Setting CPU throttle for VM. (90%)
2021-08-03 22:01:25 (12276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-03 23:01:19 (12276): Status Report: Job Duration: '864000.000000'
2021-08-03 23:01:19 (12276): Status Report: Elapsed Time: '599690.725707'
2021-08-03 23:01:19 (12276): Status Report: CPU Time: '562545.968750'
2021-08-04 00:50:04 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 00:50:04 (12276): Status Report: Elapsed Time: '605690.725707'
2021-08-04 00:50:04 (12276): Status Report: CPU Time: '562623.140625'
2021-08-04 02:01:28 (12276): Preference change detected
2021-08-04 02:01:28 (12276): Setting CPU throttle for VM. (90%)
2021-08-04 02:01:30 (12276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-04 02:36:50 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 02:36:50 (12276): Status Report: Elapsed Time: '611690.766581'
2021-08-04 02:36:50 (12276): Status Report: CPU Time: '562691.406250'
2021-08-04 04:19:06 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 04:19:06 (12276): Status Report: Elapsed Time: '617690.766581'
2021-08-04 04:19:06 (12276): Status Report: CPU Time: '562754.359375'
2021-08-04 06:01:31 (12276): Preference change detected
2021-08-04 06:01:31 (12276): Setting CPU throttle for VM. (90%)
2021-08-04 06:01:32 (12276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-04 06:02:16 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 06:02:16 (12276): Status Report: Elapsed Time: '623690.766581'
2021-08-04 06:02:16 (12276): Status Report: CPU Time: '562817.781250'
2021-08-04 07:43:44 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 07:43:44 (12276): Status Report: Elapsed Time: '629690.766581'
2021-08-04 07:43:44 (12276): Status Report: CPU Time: '562875.484375'
2021-08-04 09:25:04 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 09:25:04 (12276): Status Report: Elapsed Time: '635690.766581'
2021-08-04 09:25:04 (12276): Status Report: CPU Time: '562932.937500'
2021-08-04 10:01:34 (12276): Preference change detected
2021-08-04 10:01:34 (12276): Setting CPU throttle for VM. (90%)
2021-08-04 10:01:34 (12276): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2021-08-04 11:06:56 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 11:06:56 (12276): Status Report: Elapsed Time: '641691.597987'
2021-08-04 11:06:56 (12276): Status Report: CPU Time: '562994.453125'
2021-08-04 12:48:15 (12276): Status Report: Job Duration: '864000.000000'
2021-08-04 12:48:15 (12276): Status Report: Elapsed Time: '647691.597987'
2021-08-04 12:48:15 (12276): Status Report: CPU Time: '563054.640625'
2021-08-04 13:01:36 (12276): Capturing screenshot.
2021-08-04 13:01:39 (12276): Screenshot completed.
2021-08-04 13:01:39 (12276): Powering off VM.

</stderr_txt>
]]>


©2024 CERN