1)
Message boards :
Number crunching :
Peer certificate cannot be authenticated with given CA certificates
(Message 42790)
Posted 3 Jun 2020 by broz69 Post: found this on another thread - it worked for me. Hi, I did this and it solved the issue. No need to update BOINC client (but I guess that updating is the prefered long term solution). If you don't want to update then just delete the expired root CA from ca-bundle.crt and it'll be OK. |
2)
Message boards :
Number crunching :
Peer certificate cannot be authenticated with given CA certificates
(Message 42723)
Posted 31 May 2020 by broz69 Post: Thank you. I found it in a directory where boinc.exe is situated. I changed the one with the one from github, restarted the BOINC client and the same result: 31/05/2020 17:43:20 | LHC@home | Sending scheduler request: Requested by user. 31/05/2020 17:43:20 | LHC@home | Reporting 73 completed tasks 31/05/2020 17:43:20 | LHC@home | Requesting new tasks for CPU and AMD/ATI GPU 31/05/2020 17:43:21 | LHC@home | Scheduler request failed: Peer certificate cannot be authenticated with given CA certificates 31/05/2020 17:43:23 | | Project communication failed: attempting access to reference site 31/05/2020 17:43:25 | | Internet access OK - project servers may be temporarily down. 31/05/2020 17:44:42 | LHC@home | Fetching scheduler list 31/05/2020 17:44:44 | | Project communication failed: attempting access to reference site 31/05/2020 17:44:45 | | Internet access OK - project servers may be temporarily down. I compared the two ca-bundle.crt files and the content is exactly the same (apart from date and time modified). |
3)
Message boards :
Number crunching :
Peer certificate cannot be authenticated with given CA certificates
(Message 42721)
Posted 31 May 2020 by broz69 Post: OK. I downloaded the file ca-bundle.crt from github, put it in BOINC direcotry, restarted BOINC client and still get the same error "31/05/2020 13:47:03 | LHC@home | Scheduler request failed: Peer certificate cannot be authenticated with given CA certificates" 31/05/2020 13:46:50 | | Starting BOINC client version 7.16.5 for windows_x86_64 31/05/2020 13:46:50 | | log flags: file_xfer, sched_ops, task 31/05/2020 13:46:50 | | Libraries: libcurl/7.47.1 OpenSSL/1.0.2s zlib/1.2.8 What else can I do? |
4)
Message boards :
Number crunching :
Peer certificate cannot be authenticated with given CA certificates
(Message 42719)
Posted 31 May 2020 by broz69 Post: Hi, I don't have ca-bundle.crt on my Windows 10 computer in BOINC directory. So where do root certificates come from in this case? What is wierd is that some ATLAS jobs uploaded the results to LHC but the job in BOINC still shows "Ready to report"... So what else can I do? |
5)
Message boards :
CMS Application :
CMS&Atlas host disk problem
(Message 41834)
Posted 6 Mar 2020 by broz69 Post: Hello, I still have problems with LHC@Home. Mainly with Atlas and CMS VBox tasks. The problem lies in how a combination of Boinc and LHC tasks works with different disks. Computer ID: 10570926 8 processors allowed (meaning 8 simultaneous tasks with single processor) Here's what I've found so far. I broke down the whole process in some steps: 1. Boinc contacts the server and downloads tasks (in case of LHC it downloads many tasks - like 8 or so - at the same time) 2. Boinc starts the task or tasks (depending if they are multi-threaded or not) 3. the LHC first copies the disk image to the BOINC/slots/ directory 4. after image is copied it registers a VM in VBox Manager and sets up parameters (base memory, processors, attaches disks etc) 5. VM starts the boot-up process 6. VM starts and does it's work 7. VM finishes the work and the VM shuts-down 8. after VM shuts down there is an extra 5-6 min that I don't know exactly what's going on (there's very little CPU activity but no disk nor ethernet activity... I think some kind of result preparation?) 9. then follows VM deregistration from VBox Manager and a computational error comes up in Boinc Manager (this error is not so important right now) 10. reporting result to the LHC server In my case: step 1 is not critical as the internet connection is slower than disk data speed step 2 - after jobs downloaded Boinc Manager started 8 CMS tasks at the same time (see below for detailed analysis) Atlas disk image is around 2,54 GB, CMS disk image is around 2,8 GB. Starting eight Atlas or CMS jobs at the same time is not advisable in my case as writing 8 VM disk images to BOINC/slots/ directory completly overwhelms the disk for a long time. The disk cannot handle so many write requests. As is seen below different disks have different write queues. SSDs and even SD cards can handle 8 write requests, but HDDs cannot. Is it possible to do one of the following:
|
6)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41610)
Posted 17 Feb 2020 by broz69 Post: Hi, Another thing that I noticed - ATLAS job needs more than 160 sec from the moment I resume the job in BOINC Manager to start running. In this time the disk is active 100% of time. Since the BOINC setup is that it reads the image from BOINC\projects\lhcathome.cern.ch_lhcathome and copies them to BOINC\slots. All the read and write operations are on one phisycal disk. The disk is WDC WD3200BEVT-22ZCT0. The solution for me would also be if somehow I could say to VBox/BOINC that the repository of LHC images is on one disk and working set of disks are somewhere else. I have other three hard disks that I could use to spread the disk load... Best regards. |
7)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41608)
Posted 16 Feb 2020 by broz69 Post: Hello, Correction - it seems like ATLAS job needed almost 20 min to get the data and while I was writing the answer above it started crunching numbers. So it's not stalled... |
8)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41607)
Posted 16 Feb 2020 by broz69 Post: Hello, Thank you for your answer. This behaviour is exactly what I've seen in the last 4 hours; with a test machine on - no shutdown. BOINC Manager was starting some VBox VMs, stopping others and in the mean time made a bit of a mess. I have 2 Theory jobs that have status "Postponed" and in the VBox manager they are defined/created but just partially - both of them have no disk attached - under "Storage" the disk part is empty. Then at certain point BOINC Manager decided to switch jobs from Theory to ATLAS. So it paused all Theory jobs and started an ATLAS job. I have now one ATLAS job (d4HODmjyBNwn9Rq4apoT9bVoABFKDmABFKDmbQmVDmABFKDmypIWIn_1) that is defined in VBox and when it's running I can see three different screens in BOINC Manager in VM console using alt+F1, alt+F2 and alt+F3. The only problem is that alt+F2 (ATLAS Event Progress Monitoring) is showing a progress screen where all the numbers are shown as N/A. It seems that VM started but somehow failed to trigger the start of calculations. BOINC Manager shows job as running. I can't say that what you are saying about the behaviour of BOINC Manager is desirable. But at least I know I have to be careful when shutting down the computer. Thank you for your effort and explaining this to me. |
9)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41605)
Posted 16 Feb 2020 by broz69 Post: 2020-02-16 03:04:18 (9184): Required extension pack not installed, remote desktop not enabled. Hi again, Last weekend I observed the following behaviour on computer ID 10570926. The computer was shutdown and the next morning I turned it on. The shutdown procedure was nothing special (I didn't do anything special to running LHC jobs through VBox). There were some Theory and CMS jobs running at the time when I initiated a shutdown. When the machine came up all the VMs started at the same time. I checked VM console and all of them were in emergency shell. I aborted the jobs (all of them at the same time). That's when ATLAS jobs started, all at the same time. After a while I checked VM console in BOINC and all of them were in emergency shell. I aborted the jobs. This was Feb 9. This weekend I activated my testing machine ID: 10616627. I installed new Win10 1903 build 18362.657, BOINC 7.14.2 (x64) and VBox 6.1.2 r135662 (Qt5.6.2). When I pressed Allow new tasks, BOINC downloaded cca 16 Theory jobs and 4 ATLAS jobs. It started 4 Theory jobs at the same time. I checked VM console in BOINC and 4 jobs were in emergency shell: * Welcome to micro-Cern-VM * Release 2018.10-1.cernvm.x86_64 [INF] Loading predefined modules... check [INF] Starting networking... check [INF] Getting time from pool.ntp.org... check [INF] Mounting root filesystem...mount: mounting /dev/disk/by-label/UROOT on /root.rw failed: Input/output error [ERR] Unable to mount root device /dev/disk/by-label/UROOT! [INF] Entering rescue console etc... And this was exactly the same behaviour on both machines! Both machines have SATA disk for LHC. One has 750GB WD Black and the other 320GB WD Blue (on Standard SATA AHCI Controler, driver from Microsoft ver. 10.0.18362.1). My guess is that starting many VMs at the same time produces some kind of IO errors and then VMs simply stay in that state. And BOINC doesn't know it and simply lets them run forever. Is there any setting that I can use to delay starting the VMs? It seems that starting many VMs at the same time produces IO errors. Now would be interesting to know if it's VBox or is it that OS in VM has some time-outs that are too low... On my test machine Theory VM needs around 60-80 sec to copy the VDI image and then another 10-20 sec to start running. So in my case 120 sec time between starting different VMs would be OK. On the other hand ATLAS has bigger VM image so it takes a bit more time. The only thing is I don't know where to set it up - if it's even possible. I know it's possible to do it in Hyper-V but I don't know how to do it in BOINC/VBox combo... |
10)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41500)
Posted 9 Feb 2020 by broz69 Post: This logfile states that your VMs use only 2241MB although a 4-core setup requires 6600MB: Hi, I have another 2 ATLAS jobs that seem to be stalled - running but no CPU used - WU IDs 132365983 and 132365606. Last night I shutdown the machine. This morning I switched it back on and I checked LHC jobs. At the moment there seem to be 5 Theory jobs running and two ATLAS (2 CPUs) jobs. That would mean that BOINC is using 9 CPUs. Which is a bit funny as I only allow 8 CPUs to be used and this hasn't changed since friday. current app_config (last changed 6-2-2020 12:13): <app_config> <app> <name>ATLAS</name> <max_concurrent>4</max_concurrent> </app> <app_version> <app_name>ATLAS</app_name> <plan_class>vbox64_mt_mcore_atlas</plan_class> <avg_ncpus>2.0</avg_ncpus> <cmdline>--nthreads 2</cmdline> </app_version> </app_config> current ATLAS_vbox_2.00_job (last changed 7-2-2020 10:09): <vbox_job> <os_name>Linux26_64</os_name> <memory_size_mb>5120</memory_size_mb> <enable_network/> <enable_remotedesktop/> <enable_shared_directory/> <copy_to_shared>init_data.xml</copy_to_shared> <completion_trigger_file>atlas_done</completion_trigger_file> <disable_automatic_checkpoints/> <enable_vm_savestate_usage/> <minimum_checkpoint_interval>900</minimum_checkpoint_interval> <pf_guest_port>80</pf_guest_port> </vbox_job> |
11)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41498)
Posted 8 Feb 2020 by broz69 Post: This logfile states that your VMs use only 2241MB although a 4-core setup requires 6600MB: Hi, I figured out what was wrong. It happened this morning with WU ID 132365918. My computer is not on 24/7. Every evening instead of shutting it down I use sleep function. This morning after I turned the computer on I've checked the BOINC queue and all the machines that were running (there were 8 of them, all LHC jobs). The ATLAS job for WU ID 132365918 was in emergency mode. BOINC manager was showing it as running but VM console showed a lot of I/O error, dev sda. The host disk (physical disk in host system) seems OK, no errors there. So it must have been something connected with how VM reacts on waking from sleep. Maybe the host disk was not ready yet when BOINC or VBox were already waking up the machine with ATLAS job? The funny part was that it happend only to ATLAS job, 7 Theory jobs seem to be OK. |
12)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41488)
Posted 6 Feb 2020 by broz69 Post: This logfile states that your VMs use only 2241MB although a 4-core setup requires 6600MB: Hello, Thank you for your answer. And sorry for this mess. My Linux machine was even worse - it had Extension 5.2.10 and VBox 5.2.34... No comment... Seems I'm becoming a lazy Windows user - just waiting that somebody else fixes my problems with IT... For WU ID 132298221 - I thought I fixed that. It must have been a job that started while I was playing with settings... Now it should have been 4 CPUs and 7168 MB RAM. Thank you for your patientce. |
13)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41479)
Posted 5 Feb 2020 by broz69 Post: 2020-02-03 15:19:10 (10108): Setting Memory Size for VM. (2241MB) Hi, I checked and for the WU IDs 130921208 and 131084784 - I have this in my boinc_959537d37d2ec3c6.vbox and boinc_241d70e82b605c8a.vbox files in <Hardware> section: <CPU count="8"> <PAE enabled="true"/> <LongMode enabled="true"/> <X2APIC enabled="true"/> <HardwareVirtExLargePages enabled="true"/> </CPU> <Memory RAMSize="10200"/> It matches requirements from Yeti's checklist. When I downgraded VBox to version 6.0.16 I did a fresh install - uninstalled 6.1.2 and installed 6.0.16. At the moment there are a couple of ATLAS jobs that completed successfuly. |
14)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41475)
Posted 5 Feb 2020 by broz69 Post: In the meantime I discovered this in vbox_trace.txt: Hi, I tested a bit and this is what I found so far: WU ID: 131869350 - I tested it with VBox 6.1.2 and it ran for cca 4h+. It reached around 46% and started to exibit the same behaviour - CPUs down to 1%. This is where are I discovered this --clipboard option which I don't think is responsible for the CPU behaviour... I aborted the job. I downgraded VBox to version 6.0.16 (Qt5.6.2). WU ID: 131909275 - I tested with VBox 6.0.16 and after running 23h+ it reached 99,906% - CPU is down to 1%. The normal running time would be between 4-10h. From other ATLAS jobs I see that they are mainly crunched by Xeon processors on Linux. I see that my other machine that is running Linux on Intel has only occasional problems with ATLAS jobs but I guess nothing serious. At the moment I will follow these steps https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5226 to clean the complete environment. At the end, before allowing new tasts, I'll also reset all the projects. I'll keep three directories under slots and can make them available to anyone who wishes to debug or analyse the situation more closely. My guess would be that there is something between Windows 10, Ryzen 7 and VBox that causes this strange behaviour of ATLAS jobs. User greg_be has similar computer configuration as me and also has similar problems. For now thank you for your help. I'll get in touch if I discover something more or if the steps above don't resolve the issue. Best regards and keep up the good work! |
15)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41462)
Posted 3 Feb 2020 by broz69 Post: Noticed this line in your OP: Hi, Thank you for this info. I'll keep that in mind. WU 130921208 has already been running for some days without using CPU at the time when I decided to upgrade VirtualBox. At the moment I'm testing another ATLAS job with VirtualBox 6.1.2 r135662 (Qt5.6.2). In the meantime I discovered this in vbox_trace.txt: 2020-02-03 15:19:14 (10108): Command: VBoxManage -q modifyvm "boinc_d8f3620062e00255" --clipboard disabled Exit Code: -108 Output: Oracle VM VirtualBox Command Line Management Interface Version 6.1.2 (C) 2005-2020 Oracle Corporation All rights reserved. VBoxManage.exe: error: Unknown option: --clipboard |
16)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41457)
Posted 3 Feb 2020 by broz69 Post: 1. Done 2. Done 3. OK, sorry. About the ports - I don't have any ports explicitly closed to the outside world. Except TCP/UDP 135-139 and TCP/UDP 445 which are not required for any LHC applications. VirtualBox has only one network. Virtual machines (VMs) are connected to a NAT (I didn't change this so I guess that is the default setting for all LHC VMs). Network setting inside VirtualBox shows: Network Adapter 1: Intel PRO/1000 MT Desktop (NAT) Also - the last contact with ATLAS was 1 Feb 2020, 22:28:14 UTC or 29 Jan 2020, 16:24:37 UTC and since then I haven't changed any port settings... |
17)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41455)
Posted 3 Feb 2020 by broz69 Post: BOINC event log: 01/02/2020 20:48:11 | | Starting BOINC client version 7.14.2 for windows_x86_64 01/02/2020 20:48:11 | | log flags: file_xfer, sched_ops, task 01/02/2020 20:48:11 | | Libraries: libcurl/7.47.1 OpenSSL/1.0.2g zlib/1.2.8 01/02/2020 20:48:11 | | Data directory: F:\var\BOINC 01/02/2020 20:48:11 | | OpenCL: AMD/ATI GPU 0: AMD Radeon (TM) R9 390 Series (driver version 2841.19, device version OpenCL 2.0 AMD-APP (2841.19), 8192MB, 8192MB available, 5970 GFLOPS peak) 01/02/2020 20:48:11 | | Processor: 16 AuthenticAMD AMD Ryzen 7 2700X Eight-Core Processor [Family 23 Model 8 Stepping 2] 01/02/2020 20:48:11 | | Processor features: fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush mmx fxsr sse sse2 htt pni ssse3 fma cx16 sse4_1 sse4_2 movebe popcnt aes f16c rdrandsyscall nx lm avx avx2 svm sse4a osvw skinit wdt tce topx page1gb rdtscp fsgsbase bmi1 smep 01/02/2020 20:48:11 | | OS: Microsoft Windows 10: Professional x64 Edition, (10.00.18362.00) 01/02/2020 20:48:11 | | Memory: 63.95 GB physical, 72.93 GB virtual 01/02/2020 20:48:11 | | Disk: 698.63 GB total, 228.35 GB free 01/02/2020 20:48:11 | | Local time is UTC +1 hours 01/02/2020 20:48:11 | | No WSL found. 01/02/2020 20:48:11 | | VirtualBox version: 6.1.2 01/02/2020 20:48:11 | LHC@home | Found app_config.xml 01/02/2020 20:48:11 | | Config: GUI RPCs allowed from: 01/02/2020 20:48:11 | | Config: don't use GPUs while Origin.exe is running 01/02/2020 20:48:11 | | Config: don't use GPUs while PerformanceTest64.exe is running 01/02/2020 20:48:11 | | Config: don't use GPUs while Steam.exe is running 01/02/2020 20:48:11 | | Config: don't use GPUs while upc.exe is running 01/02/2020 20:48:11 | LHC@home | URL https://lhcathome.cern.ch/lhcathome/; Computer ID 10570926; resource share 400 01/02/2020 20:48:11 | Milkyway@Home | URL http://milkyway.cs.rpi.edu/milkyway/; Computer ID 788453; resource share 100 01/02/2020 20:48:11 | SETI@home | URL http://setiathome.berkeley.edu/; Computer ID 8610505; resource share 300 01/02/2020 20:48:11 | SETI@home | General prefs: from SETI@home (last modified 24-May-2019 10:53:38) 01/02/2020 20:48:11 | SETI@home | Host location: none 01/02/2020 20:48:11 | SETI@home | General prefs: using your defaults 01/02/2020 20:48:11 | | Reading preferences override file 01/02/2020 20:48:11 | | Preferences: 01/02/2020 20:48:11 | | max memory usage when active: 32741.81 MB 01/02/2020 20:48:11 | | max memory usage when idle: 49112.71 MB 01/02/2020 20:48:11 | | max disk usage: 253.60 GB 01/02/2020 20:48:11 | | max CPUs used: 8 01/02/2020 20:48:11 | | suspend work if non-BOINC CPU load exceeds 49% 01/02/2020 20:48:11 | | (to change preferences, visit a project web site or select Preferences in the Manager) 01/02/2020 20:48:11 | | Setting up project and slot directories 01/02/2020 20:48:11 | | Checking active tasks 01/02/2020 20:48:11 | LHC@home | Task Theory_2363-877514-16_0 is 2.21 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | LHC@home | Task Theory_2363-929450-16_0 is 2.21 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | LHC@home | Task Theory_2363-877881-16_0 is 2.20 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | LHC@home | Task Theory_2363-912279-16_0 is 2.18 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | LHC@home | Task Theory_2363-888863-16_0 is 2.18 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | LHC@home | Task aCbLDm850Dwn9Rq4apoT9bVoABFKDmABFKDmLD8WDmABFKDmC74yGn_2 is 4.14 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | LHC@home | Task 4N8LDmi5JFwnsSi4apGgGQJmABFKDmABFKDmhOqTDmABFKDm5ix9Un_0 is 0.89 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | LHC@home | Task MmhNDm9CKFwnsSi4apGgGQJmABFKDmABFKDmR1zTDmABFKDm9fdQpm_0 is 0.89 days overdue; you may not get credit for it. Consider aborting it. 01/02/2020 20:48:11 | | Setting up GUI RPC socket 01/02/2020 20:48:11 | | Checking presence of 259 project files 01/02/2020 20:48:42 | SETI@home | task 23ap08ae.27865.15201.8.35.245_1 suspended by user 01/02/2020 20:48:42 | SETI@home | task 23ap08ae.13647.13156.9.36.67_1 suspended by user 01/02/2020 20:48:42 | SETI@home | task 23jl08aa.19969.2526.11.38.234_0 suspended by user 01/02/2020 20:48:42 | SETI@home | task blc35_2bit_guppi_58691_85456_HIP79991_0109.18867.409.21.44.39.vlar_2 suspended by user 01/02/2020 20:48:42 | SETI@home | task 23jl08aa.19317.25021.8.35.0_1 suspended by user 01/02/2020 20:49:14 | LHC@home | task aCbLDm850Dwn9Rq4apoT9bVoABFKDmABFKDmLD8WDmABFKDmC74yGn_2 resumed by user 01/02/2020 20:51:23 | LHC@home | Sending scheduler request: Requested by project. 01/02/2020 20:51:23 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 20:51:25 | LHC@home | Scheduler request completed 01/02/2020 20:53:27 | LHC@home | Computation for task Theory_2363-929450-16_0 finished 01/02/2020 20:53:29 | LHC@home | Started upload of Theory_2363-929450-16_0_r691766450_result 01/02/2020 20:53:32 | LHC@home | Finished upload of Theory_2363-929450-16_0_r691766450_result 01/02/2020 20:53:35 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 20:53:35 | LHC@home | Reporting 1 completed tasks 01/02/2020 20:53:35 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 20:53:37 | LHC@home | Scheduler request completed 01/02/2020 20:55:55 | SETI@home | General prefs: from SETI@home (last modified 24-May-2019 10:53:38) 01/02/2020 20:55:55 | SETI@home | Host location: none 01/02/2020 20:55:55 | SETI@home | General prefs: using your defaults 01/02/2020 20:55:55 | | Reading preferences override file 01/02/2020 20:55:55 | | Preferences: 01/02/2020 20:55:55 | | max memory usage when active: 32741.81 MB 01/02/2020 20:55:55 | | max memory usage when idle: 49112.71 MB 01/02/2020 20:55:55 | | max disk usage: 254.40 GB 01/02/2020 20:55:55 | | Number of usable CPUs has changed from 8 to 10. 01/02/2020 20:55:55 | | max CPUs used: 10 01/02/2020 20:55:55 | | suspend work if non-BOINC CPU load exceeds 49% 01/02/2020 20:55:55 | | (to change preferences, visit a project web site or select Preferences in the Manager) 01/02/2020 20:58:17 | SETI@home | General prefs: from SETI@home (last modified 24-May-2019 10:53:38) 01/02/2020 20:58:17 | SETI@home | Host location: none 01/02/2020 20:58:17 | SETI@home | General prefs: using your defaults 01/02/2020 20:58:17 | | Reading preferences override file 01/02/2020 20:58:17 | | Preferences: 01/02/2020 20:58:17 | | max memory usage when active: 32741.81 MB 01/02/2020 20:58:17 | | max memory usage when idle: 49112.71 MB 01/02/2020 20:58:17 | | max disk usage: 253.87 GB 01/02/2020 20:58:17 | | Number of usable CPUs has changed from 10 to 16. 01/02/2020 20:58:17 | | suspend work if non-BOINC CPU load exceeds 49% 01/02/2020 20:58:17 | | (to change preferences, visit a project web site or select Preferences in the Manager) 01/02/2020 21:23:11 | LHC@home | Computation for task Theory_2363-888863-16_0 finished 01/02/2020 21:23:13 | LHC@home | Started upload of Theory_2363-888863-16_0_r1270884496_result 01/02/2020 21:23:16 | LHC@home | Finished upload of Theory_2363-888863-16_0_r1270884496_result 01/02/2020 21:23:19 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 21:23:19 | LHC@home | Reporting 1 completed tasks 01/02/2020 21:23:19 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 21:23:21 | LHC@home | Scheduler request completed 01/02/2020 21:35:50 | LHC@home | Computation for task Theory_2363-912279-16_0 finished 01/02/2020 21:35:52 | LHC@home | Started upload of Theory_2363-912279-16_0_r955799384_result 01/02/2020 21:35:55 | LHC@home | Finished upload of Theory_2363-912279-16_0_r955799384_result 01/02/2020 21:35:58 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 21:35:58 | LHC@home | Reporting 1 completed tasks 01/02/2020 21:35:58 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 21:36:00 | LHC@home | Scheduler request completed 01/02/2020 21:36:47 | SETI@home | Computation for task blc61_2bit_guppi_58692_58812_HIP21705_0023.29308.818.21.44.145.vlar_1 finished 01/02/2020 21:36:49 | SETI@home | Started upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29308.818.21.44.145.vlar_1_r32682124_0 01/02/2020 21:36:53 | SETI@home | Finished upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29308.818.21.44.145.vlar_1_r32682124_0 01/02/2020 21:36:55 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 21:36:55 | SETI@home | Reporting 1 completed tasks 01/02/2020 21:36:55 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 21:36:57 | SETI@home | Scheduler request completed 01/02/2020 21:40:55 | SETI@home | Computation for task blc61_2bit_guppi_58692_58812_HIP21705_0023.29308.818.21.44.140.vlar_1 finished 01/02/2020 21:40:57 | SETI@home | Started upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29308.818.21.44.140.vlar_1_r1057949798_0 01/02/2020 21:40:59 | SETI@home | Finished upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29308.818.21.44.140.vlar_1_r1057949798_0 01/02/2020 21:42:03 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 21:42:03 | SETI@home | Reporting 1 completed tasks 01/02/2020 21:42:03 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 21:42:04 | SETI@home | Scheduler request completed 01/02/2020 21:42:26 | SETI@home | Computation for task blc61_2bit_guppi_58692_58812_HIP21705_0023.29312.818.22.45.151.vlar_1 finished 01/02/2020 21:42:28 | SETI@home | Started upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29312.818.22.45.151.vlar_1_r2090817839_0 01/02/2020 21:42:32 | SETI@home | Finished upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29312.818.22.45.151.vlar_1_r2090817839_0 01/02/2020 21:47:10 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 21:47:10 | SETI@home | Reporting 1 completed tasks 01/02/2020 21:47:10 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 21:47:12 | SETI@home | Scheduler request completed 01/02/2020 21:53:42 | LHC@home | Computation for task Theory_2363-877881-16_0 finished 01/02/2020 21:53:44 | LHC@home | Started upload of Theory_2363-877881-16_0_r179002926_result 01/02/2020 21:53:47 | LHC@home | Finished upload of Theory_2363-877881-16_0_r179002926_result 01/02/2020 21:53:48 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 21:53:48 | LHC@home | Reporting 1 completed tasks 01/02/2020 21:53:48 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 21:53:50 | LHC@home | Scheduler request completed 01/02/2020 22:03:56 | SETI@home | Computation for task blc61_2bit_guppi_58692_58812_HIP21705_0023.29312.818.22.45.148.vlar_1 finished 01/02/2020 22:03:58 | SETI@home | Started upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29312.818.22.45.148.vlar_1_r276114749_0 01/02/2020 22:04:01 | SETI@home | Finished upload of blc61_2bit_guppi_58692_58812_HIP21705_0023.29312.818.22.45.148.vlar_1_r276114749_0 01/02/2020 22:04:01 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 22:04:01 | SETI@home | Reporting 1 completed tasks 01/02/2020 22:04:01 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 22:04:03 | SETI@home | Scheduler request completed 01/02/2020 22:22:56 | LHC@home | Computation for task Theory_2363-877514-16_0 finished 01/02/2020 22:22:58 | LHC@home | Started upload of Theory_2363-877514-16_0_r1511274365_result 01/02/2020 22:23:02 | LHC@home | Finished upload of Theory_2363-877514-16_0_r1511274365_result 01/02/2020 22:23:04 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 22:23:04 | LHC@home | Reporting 1 completed tasks 01/02/2020 22:23:04 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 22:23:06 | LHC@home | Scheduler request completed 01/02/2020 22:23:46 | SETI@home | Computation for task 23ap08ae.27370.13156.7.34.160_1 finished 01/02/2020 22:23:48 | SETI@home | Started upload of 23ap08ae.27370.13156.7.34.160_1_r1156124_0 01/02/2020 22:23:52 | SETI@home | Finished upload of 23ap08ae.27370.13156.7.34.160_1_r1156124_0 01/02/2020 22:23:52 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 22:23:52 | SETI@home | Reporting 1 completed tasks 01/02/2020 22:23:52 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 22:23:54 | SETI@home | Scheduler request completed 01/02/2020 22:34:03 | Milkyway@Home | task de_modfit_83_bundle4_4s_south4s_bgset_2_1580162702_2471544_1 resumed by user 01/02/2020 22:34:03 | Milkyway@Home | task de_modfit_14_bundle4_testing_3s4f_3_1580162702_2478729_0 resumed by user 01/02/2020 22:34:03 | Milkyway@Home | task de_modfit_14_bundle5_testing_4s3f_1_1580162702_2471635_1 resumed by user 01/02/2020 22:34:03 | SETI@home | task 23ap08ae.27865.15201.8.35.245_1 resumed by user 01/02/2020 22:34:03 | SETI@home | task 23ap08ae.13647.13156.9.36.67_1 resumed by user 01/02/2020 22:34:03 | SETI@home | task 23jl08aa.19969.2526.11.38.234_0 resumed by user 01/02/2020 22:34:03 | SETI@home | task blc35_2bit_guppi_58691_85456_HIP79991_0109.18867.409.21.44.39.vlar_2 resumed by user 01/02/2020 22:34:03 | SETI@home | task 23jl08aa.19317.25021.8.35.0_1 resumed by user 01/02/2020 22:34:03 | SETI@home | Starting task 23ap08ae.27865.15201.8.35.245_1 01/02/2020 22:34:03 | SETI@home | Starting task 23ap08ae.13647.13156.9.36.67_1 01/02/2020 22:34:04 | SETI@home | Starting task 23jl08aa.19969.2526.11.38.234_0 01/02/2020 22:34:04 | SETI@home | Starting task blc35_2bit_guppi_58691_85456_HIP79991_0109.18867.409.21.44.39.vlar_2 01/02/2020 22:34:04 | SETI@home | Starting task 23jl08aa.19317.25021.8.35.0_1 01/02/2020 22:34:04 | Milkyway@Home | Starting task de_modfit_83_bundle4_4s_south4s_bgset_2_1580162702_2471544_1 01/02/2020 22:34:04 | Milkyway@Home | Starting task de_modfit_14_bundle4_testing_3s4f_3_1580162702_2478729_0 01/02/2020 22:34:04 | Milkyway@Home | Starting task de_modfit_14_bundle5_testing_4s3f_1_1580162702_2471635_1 01/02/2020 22:34:23 | SETI@home | Computation for task 23jl08aa.19317.25021.8.35.0_1 finished 01/02/2020 22:34:25 | SETI@home | Started upload of 23jl08aa.19317.25021.8.35.0_1_r1977650626_0 01/02/2020 22:34:27 | SETI@home | Finished upload of 23jl08aa.19317.25021.8.35.0_1_r1977650626_0 01/02/2020 22:34:30 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 22:34:30 | SETI@home | Reporting 1 completed tasks 01/02/2020 22:34:30 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 22:34:32 | SETI@home | Scheduler request completed 01/02/2020 22:38:01 | LHC@home | task Theory_2363-928580-20_0 resumed by user 01/02/2020 22:38:02 | LHC@home | Starting task Theory_2363-928580-20_0 01/02/2020 23:12:03 | SETI@home | Computation for task blc35_2bit_guppi_58691_85456_HIP79991_0109.18867.409.21.44.39.vlar_2 finished 01/02/2020 23:12:05 | SETI@home | Started upload of blc35_2bit_guppi_58691_85456_HIP79991_0109.18867.409.21.44.39.vlar_2_r2031750402_0 01/02/2020 23:12:08 | SETI@home | Finished upload of blc35_2bit_guppi_58691_85456_HIP79991_0109.18867.409.21.44.39.vlar_2_r2031750402_0 01/02/2020 23:12:12 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 23:12:12 | SETI@home | Reporting 1 completed tasks 01/02/2020 23:12:12 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 23:12:14 | SETI@home | Scheduler request completed 01/02/2020 23:12:17 | LHC@home | task Theory_2363-925569-20_0 resumed by user 01/02/2020 23:12:18 | LHC@home | Starting task Theory_2363-925569-20_0 01/02/2020 23:19:36 | Milkyway@Home | Computation for task de_modfit_14_bundle4_testing_3s4f_3_1580162702_2478729_0 finished 01/02/2020 23:19:38 | Milkyway@Home | Computation for task de_modfit_83_bundle4_4s_south4s_bgset_2_1580162702_2471544_1 finished 01/02/2020 23:19:41 | Milkyway@Home | Sending scheduler request: To report completed tasks. 01/02/2020 23:19:41 | Milkyway@Home | Reporting 2 completed tasks 01/02/2020 23:19:41 | Milkyway@Home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 23:19:43 | Milkyway@Home | Scheduler request completed 01/02/2020 23:20:52 | LHC@home | task Theory_2363-934468-16_1 resumed by user 01/02/2020 23:20:53 | LHC@home | Starting task Theory_2363-934468-16_1 01/02/2020 23:21:35 | LHC@home | task Theory_2363-938541-20_1 resumed by user 01/02/2020 23:21:36 | LHC@home | Starting task Theory_2363-938541-20_1 01/02/2020 23:22:26 | Milkyway@Home | Computation for task de_modfit_14_bundle5_testing_4s3f_1_1580162702_2471635_1 finished 01/02/2020 23:22:28 | Milkyway@Home | Sending scheduler request: To report completed tasks. 01/02/2020 23:22:28 | Milkyway@Home | Reporting 1 completed tasks 01/02/2020 23:22:28 | Milkyway@Home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 23:22:30 | Milkyway@Home | Scheduler request completed 01/02/2020 23:24:39 | LHC@home | task Theory_2363-898535-20_1 resumed by user 01/02/2020 23:24:40 | LHC@home | Starting task Theory_2363-898535-20_1 01/02/2020 23:25:36 | LHC@home | task MmhNDm9CKFwnsSi4apGgGQJmABFKDmABFKDmR1zTDmABFKDm9fdQpm_0 aborted by user 01/02/2020 23:25:36 | LHC@home | Computation for task MmhNDm9CKFwnsSi4apGgGQJmABFKDmABFKDmR1zTDmABFKDm9fdQpm_0 finished 01/02/2020 23:26:57 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 23:26:57 | LHC@home | Reporting 1 completed tasks 01/02/2020 23:26:57 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 23:26:59 | LHC@home | Scheduler request completed 01/02/2020 23:27:14 | LHC@home | task Theory_2363-933848-20_0 resumed by user 01/02/2020 23:28:18 | LHC@home | task Theory_2363-873955-18_2 resumed by user 01/02/2020 23:28:21 | LHC@home | task Theory_2363-935645-20_0 resumed by user 01/02/2020 23:28:24 | LHC@home | task Theory_2363-923874-20_1 resumed by user 01/02/2020 23:28:28 | LHC@home | task Theory_2363-924854-20_0 resumed by user 01/02/2020 23:28:31 | LHC@home | task Theory_2363-903403-20_0 resumed by user 01/02/2020 23:29:21 | LHC@home | Computation for task Theory_2363-928580-20_0 finished 01/02/2020 23:29:21 | LHC@home | Starting task Theory_2363-933848-20_0 01/02/2020 23:29:23 | LHC@home | Started upload of Theory_2363-928580-20_0_r1040240675_result 01/02/2020 23:29:26 | LHC@home | Finished upload of Theory_2363-928580-20_0_r1040240675_result 01/02/2020 23:29:30 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 23:29:30 | LHC@home | Reporting 1 completed tasks 01/02/2020 23:29:30 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 23:29:32 | LHC@home | Scheduler request completed 01/02/2020 23:30:35 | LHC@home | Computation for task Theory_2363-925569-20_0 finished 01/02/2020 23:30:35 | LHC@home | Starting task Theory_2363-873955-18_2 01/02/2020 23:30:37 | LHC@home | Started upload of Theory_2363-925569-20_0_r1051028521_result 01/02/2020 23:30:40 | LHC@home | Finished upload of Theory_2363-925569-20_0_r1051028521_result 01/02/2020 23:30:44 | LHC@home | Sending scheduler request: To report completed tasks. 01/02/2020 23:30:44 | LHC@home | Reporting 1 completed tasks 01/02/2020 23:30:44 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 23:30:48 | LHC@home | Scheduler request completed 01/02/2020 23:56:20 | SETI@home | Computation for task 23ap08ae.13647.13156.9.36.67_1 finished 01/02/2020 23:56:20 | LHC@home | Starting task Theory_2363-935645-20_0 01/02/2020 23:56:22 | SETI@home | Started upload of 23ap08ae.13647.13156.9.36.67_1_r302429995_0 01/02/2020 23:56:26 | SETI@home | Finished upload of 23ap08ae.13647.13156.9.36.67_1_r302429995_0 01/02/2020 23:56:31 | SETI@home | Sending scheduler request: To report completed tasks. 01/02/2020 23:56:31 | SETI@home | Reporting 1 completed tasks 01/02/2020 23:56:31 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 01/02/2020 23:56:33 | SETI@home | Scheduler request completed 02/02/2020 00:02:21 | SETI@home | Computation for task 23ap08ae.27865.15201.8.35.245_1 finished 02/02/2020 00:02:21 | LHC@home | Starting task Theory_2363-923874-20_1 02/02/2020 00:02:23 | SETI@home | Started upload of 23ap08ae.27865.15201.8.35.245_1_r817039278_0 02/02/2020 00:02:26 | SETI@home | Finished upload of 23ap08ae.27865.15201.8.35.245_1_r817039278_0 02/02/2020 00:02:29 | SETI@home | Sending scheduler request: To report completed tasks. 02/02/2020 00:02:29 | SETI@home | Reporting 1 completed tasks 02/02/2020 00:02:29 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 00:02:32 | SETI@home | Scheduler request completed 02/02/2020 00:04:01 | LHC@home | Computation for task Theory_2363-935645-20_0 finished 02/02/2020 00:04:01 | LHC@home | Starting task Theory_2363-924854-20_0 02/02/2020 00:04:03 | LHC@home | Started upload of Theory_2363-935645-20_0_r1502588198_result 02/02/2020 00:04:06 | LHC@home | Finished upload of Theory_2363-935645-20_0_r1502588198_result 02/02/2020 00:04:07 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 00:04:07 | LHC@home | Reporting 1 completed tasks 02/02/2020 00:04:07 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 00:04:10 | LHC@home | Scheduler request completed 02/02/2020 00:04:17 | SETI@home | Computation for task 23jl08aa.19969.2526.11.38.234_0 finished 02/02/2020 00:04:17 | LHC@home | Starting task Theory_2363-903403-20_0 02/02/2020 00:04:20 | SETI@home | Started upload of 23jl08aa.19969.2526.11.38.234_0_r1491268335_0 02/02/2020 00:04:24 | SETI@home | Finished upload of 23jl08aa.19969.2526.11.38.234_0_r1491268335_0 02/02/2020 00:07:36 | SETI@home | Sending scheduler request: To report completed tasks. 02/02/2020 00:07:36 | SETI@home | Reporting 1 completed tasks 02/02/2020 00:07:36 | SETI@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 00:07:38 | SETI@home | Scheduler request completed 02/02/2020 00:18:18 | LHC@home | Computation for task Theory_2363-924854-20_0 finished 02/02/2020 00:18:20 | LHC@home | Started upload of Theory_2363-924854-20_0_r1816741428_result 02/02/2020 00:18:23 | LHC@home | Finished upload of Theory_2363-924854-20_0_r1816741428_result 02/02/2020 00:18:24 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 00:18:24 | LHC@home | Reporting 1 completed tasks 02/02/2020 00:18:24 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 00:18:26 | LHC@home | Scheduler request completed 02/02/2020 00:27:54 | LHC@home | Computation for task Theory_2363-923874-20_1 finished 02/02/2020 00:27:57 | LHC@home | Started upload of Theory_2363-923874-20_1_r1749176074_result 02/02/2020 00:28:02 | LHC@home | Finished upload of Theory_2363-923874-20_1_r1749176074_result 02/02/2020 00:28:02 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 00:28:02 | LHC@home | Reporting 1 completed tasks 02/02/2020 00:28:02 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 00:28:04 | LHC@home | Scheduler request completed 02/02/2020 00:34:30 | LHC@home | Computation for task Theory_2363-933848-20_0 finished 02/02/2020 00:34:32 | LHC@home | Started upload of Theory_2363-933848-20_0_r1180716501_result 02/02/2020 00:34:35 | LHC@home | Finished upload of Theory_2363-933848-20_0_r1180716501_result 02/02/2020 00:34:39 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 00:34:39 | LHC@home | Reporting 1 completed tasks 02/02/2020 00:34:39 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 00:34:41 | LHC@home | Scheduler request completed 02/02/2020 00:38:18 | LHC@home | Computation for task Theory_2363-898535-20_1 finished 02/02/2020 00:38:20 | LHC@home | Started upload of Theory_2363-898535-20_1_r1088673743_result 02/02/2020 00:38:23 | LHC@home | Finished upload of Theory_2363-898535-20_1_r1088673743_result 02/02/2020 00:38:27 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 00:38:27 | LHC@home | Reporting 1 completed tasks 02/02/2020 00:38:27 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 00:38:29 | LHC@home | Scheduler request completed 02/02/2020 01:22:50 | LHC@home | Computation for task Theory_2363-903403-20_0 finished 02/02/2020 01:22:52 | LHC@home | Started upload of Theory_2363-903403-20_0_r1081851329_result 02/02/2020 01:22:55 | LHC@home | Finished upload of Theory_2363-903403-20_0_r1081851329_result 02/02/2020 01:22:56 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 01:22:56 | LHC@home | Reporting 1 completed tasks 02/02/2020 01:22:56 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 01:22:58 | LHC@home | Scheduler request completed 02/02/2020 02:11:45 | LHC@home | Computation for task Theory_2363-938541-20_1 finished 02/02/2020 02:11:47 | LHC@home | Started upload of Theory_2363-938541-20_1_r1093400431_result 02/02/2020 02:11:50 | LHC@home | Finished upload of Theory_2363-938541-20_1_r1093400431_result 02/02/2020 02:11:50 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 02:11:50 | LHC@home | Reporting 1 completed tasks 02/02/2020 02:11:50 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 02:11:52 | LHC@home | Scheduler request completed 02/02/2020 02:58:52 | LHC@home | Computation for task Theory_2363-934468-16_1 finished 02/02/2020 02:58:54 | LHC@home | Started upload of Theory_2363-934468-16_1_r314453649_result 02/02/2020 02:58:57 | LHC@home | Finished upload of Theory_2363-934468-16_1_r314453649_result 02/02/2020 02:58:59 | LHC@home | Sending scheduler request: To report completed tasks. 02/02/2020 02:58:59 | LHC@home | Reporting 1 completed tasks 02/02/2020 02:58:59 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 02:59:01 | LHC@home | Scheduler request completed 02/02/2020 07:59:05 | LHC@home | Sending scheduler request: Requested by project. 02/02/2020 07:59:05 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 07:59:08 | LHC@home | Scheduler request completed 02/02/2020 12:59:08 | LHC@home | Sending scheduler request: Requested by project. 02/02/2020 12:59:08 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 12:59:10 | LHC@home | Scheduler request completed 02/02/2020 17:59:14 | LHC@home | Sending scheduler request: Requested by project. 02/02/2020 17:59:14 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 17:59:16 | LHC@home | Scheduler request completed 02/02/2020 22:59:21 | LHC@home | Sending scheduler request: Requested by project. 02/02/2020 22:59:21 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 02/02/2020 22:59:23 | LHC@home | Scheduler request completed 03/02/2020 03:59:27 | LHC@home | Sending scheduler request: Requested by project. 03/02/2020 03:59:27 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 03/02/2020 03:59:29 | LHC@home | Scheduler request completed 03/02/2020 08:59:33 | LHC@home | Sending scheduler request: Requested by project. 03/02/2020 08:59:33 | LHC@home | Not requesting tasks: "no new tasks" requested via Manager 03/02/2020 08:59:35 | LHC@home | Scheduler request completed |
18)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41454)
Posted 3 Feb 2020 by broz69 Post: WU ID: 131084784 1-2-2020 22:39 Application ATLAS Simulation 2.00 (vbox64_mt_mcore_atlas) Name 4N8LDmi5JFwnsSi4apGgGQJmABFKDmABFKDmhOqTDmABFKDm5ix9Un State Running Received 24/01/2020 23:28:14 Report deadline 31/01/2020 23:28:14 Resources 4 CPUs Estimated computation size 43,200 GFLOPs CPU time 00:02:25 CPU time since checkpoint 00:00:00 Elapsed time 16:10:08 Estimated time remaining 00:07:55 Fraction done 99.189% Virtual memory size 78.23 MB Working set size 9.96 GB Directory slots/14 Process ID 8436 Progress rate 6.120% per hour Executable vboxwrapper_26198ab7_windows_x86_64.exe 3-2-2020 09:16 Application ATLAS Simulation 2.00 (vbox64_mt_mcore_atlas) Name 4N8LDmi5JFwnsSi4apGgGQJmABFKDmABFKDmhOqTDmABFKDm5ix9Un State Running Received 24/01/2020 23:28:14 Report deadline 31/01/2020 23:28:14 Resources 4 CPUs Estimated computation size 43,200 GFLOPs CPU time 00:06:50 CPU time since checkpoint 00:00:00 Elapsed time 2d 02:50:54 Estimated time remaining 00:00:00 Fraction done 100.000% Virtual memory size 79.19 MB Working set size 9.96 GB Directory slots/14 Process ID 8436 Progress rate 1.800% per hour Executable vboxwrapper_26198ab7_windows_x86_64.exe stderr.txt from slots directory: 2020-01-31 23:17:56 (3532): Detected: vboxwrapper 26197 2020-01-31 23:17:56 (3532): Detected: BOINC client v7.7 2020-01-31 23:17:57 (3532): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-31 23:17:57 (3532): Successfully copied 'init_data.xml' to the shared directory. 2020-01-31 23:17:58 (3532): Create VM. (boinc_241d70e82b605c8a, slot#14) 2020-01-31 23:17:59 (3532): Setting Memory Size for VM. (10200MB) 2020-01-31 23:17:59 (3532): Setting CPU Count for VM. (8) 2020-01-31 23:17:59 (3532): Setting Chipset Options for VM. 2020-01-31 23:18:00 (3532): Setting Boot Options for VM. 2020-01-31 23:18:00 (3532): Setting Network Configuration for NAT. 2020-01-31 23:18:00 (3532): Enabling VM Network Access. 2020-01-31 23:18:00 (3532): Disabling USB Support for VM. 2020-01-31 23:18:01 (3532): Disabling COM Port Support for VM. 2020-01-31 23:18:01 (3532): Disabling LPT Port Support for VM. 2020-01-31 23:18:01 (3532): Disabling Audio Support for VM. 2020-01-31 23:18:02 (3532): Disabling Clipboard Support for VM. 2020-01-31 23:18:02 (3532): Disabling Drag and Drop Support for VM. 2020-01-31 23:18:02 (3532): Adding storage controller(s) to VM. 2020-01-31 23:18:03 (3532): Adding virtual disk drive to VM. (vm_image.vdi) 2020-01-31 23:18:03 (3532): Adding VirtualBox Guest Additions to VM. 2020-01-31 23:18:03 (3532): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2020-01-31 23:18:04 (3532): forwarding host port 51008 to guest port 80 2020-01-31 23:18:04 (3532): Enabling remote desktop for VM. 2020-01-31 23:18:04 (3532): Enabling shared directory for VM. 2020-01-31 23:18:05 (3532): Starting VM using VBoxManage interface. (boinc_241d70e82b605c8a, slot#14) 2020-01-31 23:18:08 (3532): Successfully started VM. (PID = '4676') 2020-01-31 23:18:08 (3532): Reporting VM Process ID to BOINC. 2020-01-31 23:18:08 (3532): Guest Log: BIOS: VirtualBox 6.0.8 2020-01-31 23:18:08 (3532): Guest Log: CPUID EDX: 0x178bfbff 2020-01-31 23:18:08 (3532): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-01-31 23:18:08 (3532): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-31 23:18:08 (3532): Detected: Web Application Enabled (http://localhost:51008) 2020-01-31 23:18:08 (3532): Detected: Remote Desktop Enabled (localhost:51009) 2020-01-31 23:18:08 (3532): Preference change detected 2020-01-31 23:18:08 (3532): Setting CPU throttle for VM. (100%) 2020-01-31 23:18:08 (3532): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-31 23:18:10 (3532): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-01-31 23:18:10 (3532): Guest Log: BIOS: Booting from Hard Disk... 2020-01-31 23:18:13 (3532): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-01-31 23:18:13 (3532): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2020-01-31 23:18:13 (3532): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2020-01-31 23:18:51 (3532): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-01-31 23:18:51 (3532): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-01-31 23:18:56 (3532): Guest Log: Checking CVMFS... 2020-01-31 23:18:57 (3532): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2020-01-31 23:18:57 (3532): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2020-01-31 23:18:57 (3532): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2020-01-31 23:18:57 (3532): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2020-01-31 23:19:04 (3532): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000103 main Log opened 2020-01-31T23:19:03.177454000Z 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000170 main OS Product: Linux 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000195 main OS Release: 3.10.0-957.27.2.el7.x86_64 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000215 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000234 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000234 main Process ID: 1884 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000235 main Package type: LINUX_64BITS_GENERIC 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.000706 main 5.2.32 r132073 started. Verbose level = 0 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.001103 main Error: Service 'control' failed to initialize: VERR_INVALID_FUNCTION 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.001177 main Session 0 is about to close ... 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.001199 main Stopping all guest processes ... 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.001219 main Closing all guest files ... 2020-01-31 23:19:04 (3532): Guest Log: 00:00:00.001293 main Ended. 2020-02-01 00:58:12 (3532): Status Report: Elapsed Time: '6000.000000' 2020-02-01 00:58:12 (3532): Status Report: CPU Time: '30.484375' 2020-02-01 02:38:16 (3532): Status Report: Elapsed Time: '12000.000000' 2020-02-01 02:38:16 (3532): Status Report: CPU Time: '41.515625' 2020-02-01 04:18:20 (3532): Status Report: Elapsed Time: '18000.000000' 2020-02-01 04:18:20 (3532): Status Report: CPU Time: '53.140625' 2020-02-01 05:58:25 (3532): Status Report: Elapsed Time: '24000.000000' 2020-02-01 05:58:25 (3532): Status Report: CPU Time: '65.156250' 2020-02-01 07:38:29 (3532): Status Report: Elapsed Time: '30000.000000' 2020-02-01 07:38:29 (3532): Status Report: CPU Time: '77.156250' 2020-02-01 08:53:00 (3532): Stopping VM. 2020-02-01 15:50:37 (2252): Detected: vboxwrapper 26197 2020-02-01 15:50:37 (2252): Detected: BOINC client v7.7 2020-02-01 15:50:37 (2252): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-02-01 15:50:38 (2252): Starting VM using VBoxManage interface. (boinc_241d70e82b605c8a, slot#14) 2020-02-01 15:50:43 (2252): Successfully started VM. (PID = '4472') 2020-02-01 15:50:43 (2252): Reporting VM Process ID to BOINC. 2020-02-01 15:50:43 (2252): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-02-01 15:50:43 (2252): Detected: Web Application Enabled (http://localhost:51008) 2020-02-01 15:50:43 (2252): Detected: Remote Desktop Enabled (localhost:51009) 2020-02-01 15:50:43 (2252): Status Report: Elapsed Time: '34468.000000' 2020-02-01 15:50:43 (2252): Status Report: CPU Time: '86.218750' 2020-02-01 15:50:43 (2252): Preference change detected 2020-02-01 15:50:43 (2252): Setting CPU throttle for VM. (100%) 2020-02-01 15:50:43 (2252): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 16:58:30 (2252): Preference change detected 2020-02-01 16:58:30 (2252): Setting CPU throttle for VM. (100%) 2020-02-01 16:58:31 (2252): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 17:30:47 (2252): Status Report: Elapsed Time: '40468.000000' 2020-02-01 17:30:47 (2252): Status Report: CPU Time: '101.078125' 2020-02-01 19:10:52 (2252): Status Report: Elapsed Time: '46468.000000' 2020-02-01 19:10:52 (2252): Status Report: CPU Time: '112.531250' 2020-02-01 20:35:23 (2252): Stopping VM. 2020-02-01 20:38:00 (6072): Detected: vboxwrapper 26197 2020-02-01 20:38:00 (6072): Detected: BOINC client v7.7 2020-02-01 20:38:01 (6072): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-02-01 20:38:02 (6072): Register VM. (boinc_241d70e82b605c8a, slot#14) 2020-02-01 20:38:02 (6072): Starting VM using VBoxManage interface. (boinc_241d70e82b605c8a, slot#14) 2020-02-01 20:38:08 (6072): Successfully started VM. (PID = '8844') 2020-02-01 20:38:08 (6072): Reporting VM Process ID to BOINC. 2020-02-01 20:38:08 (6072): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-02-01 20:38:08 (6072): Detected: Web Application Enabled (http://localhost:51008) 2020-02-01 20:38:08 (6072): Detected: Remote Desktop Enabled (localhost:51009) 2020-02-01 20:38:08 (6072): Status Report: Elapsed Time: '51536.000000' 2020-02-01 20:38:08 (6072): Status Report: CPU Time: '121.937500' 2020-02-01 20:38:08 (6072): Preference change detected 2020-02-01 20:38:08 (6072): Setting CPU throttle for VM. (100%) 2020-02-01 20:38:08 (6072): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 20:41:37 (6072): Stopping VM. 2020-02-01 20:48:12 (8436): Detected: vboxwrapper 26197 2020-02-01 20:48:12 (8436): Detected: BOINC client v7.7 2020-02-01 20:48:13 (8436): Detected: VirtualBox VboxManage Interface (Version: 6.1.2) 2020-02-01 20:48:14 (8436): Starting VM using VBoxManage interface. (boinc_241d70e82b605c8a, slot#14) 2020-02-01 20:49:06 (8436): Successfully started VM. (PID = '3356') 2020-02-01 20:49:06 (8436): Reporting VM Process ID to BOINC. 2020-02-01 20:49:06 (8436): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-02-01 20:49:06 (8436): Detected: Web Application Enabled (http://localhost:51008) 2020-02-01 20:49:06 (8436): Detected: Remote Desktop Enabled (localhost:51009) 2020-02-01 20:49:06 (8436): Status Report: Elapsed Time: '51745.000000' 2020-02-01 20:49:06 (8436): Status Report: CPU Time: '126.406250' 2020-02-01 20:49:06 (8436): Preference change detected 2020-02-01 20:49:06 (8436): Setting CPU throttle for VM. (100%) 2020-02-01 20:49:06 (8436): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 20:55:55 (8436): Preference change detected 2020-02-01 20:55:55 (8436): Setting CPU throttle for VM. (100%) 2020-02-01 20:55:56 (8436): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 20:58:17 (8436): Preference change detected 2020-02-01 20:58:17 (8436): Setting CPU throttle for VM. (100%) 2020-02-01 20:58:18 (8436): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 22:29:12 (8436): Status Report: Elapsed Time: '57745.386425' 2020-02-01 22:29:12 (8436): Status Report: CPU Time: '143.906250' 2020-02-01 22:32:35 (8436): Preference change detected 2020-02-01 22:32:35 (8436): Setting CPU throttle for VM. (100%) 2020-02-01 22:32:35 (8436): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-02 00:09:17 (8436): Status Report: Elapsed Time: '63745.386425' 2020-02-02 00:09:17 (8436): Status Report: CPU Time: '159.593750' 2020-02-02 01:49:23 (8436): Status Report: Elapsed Time: '69745.386425' 2020-02-02 01:49:23 (8436): Status Report: CPU Time: '172.765625' 2020-02-02 03:29:29 (8436): Status Report: Elapsed Time: '75745.386425' 2020-02-02 03:29:29 (8436): Status Report: CPU Time: '184.875000' 2020-02-02 05:09:35 (8436): Status Report: Elapsed Time: '81745.386425' 2020-02-02 05:09:35 (8436): Status Report: CPU Time: '197.093750' 2020-02-02 06:49:41 (8436): Status Report: Elapsed Time: '87745.386425' 2020-02-02 06:49:41 (8436): Status Report: CPU Time: '210.328125' 2020-02-02 08:29:47 (8436): Status Report: Elapsed Time: '93745.386425' 2020-02-02 08:29:47 (8436): Status Report: CPU Time: '223.359375' 2020-02-02 10:09:53 (8436): Status Report: Elapsed Time: '99745.386425' 2020-02-02 10:09:53 (8436): Status Report: CPU Time: '236.531250' 2020-02-02 11:49:59 (8436): Status Report: Elapsed Time: '105745.386425' 2020-02-02 11:49:59 (8436): Status Report: CPU Time: '248.781250' 2020-02-02 13:30:04 (8436): Status Report: Elapsed Time: '111745.386425' 2020-02-02 13:30:04 (8436): Status Report: CPU Time: '261.937500' 2020-02-02 15:10:10 (8436): Status Report: Elapsed Time: '117745.386425' 2020-02-02 15:10:10 (8436): Status Report: CPU Time: '274.078125' 2020-02-02 16:50:15 (8436): Status Report: Elapsed Time: '123745.386425' 2020-02-02 16:50:15 (8436): Status Report: CPU Time: '286.578125' 2020-02-02 18:30:21 (8436): Status Report: Elapsed Time: '129745.386425' 2020-02-02 18:30:21 (8436): Status Report: CPU Time: '299.484375' 2020-02-02 20:10:27 (8436): Status Report: Elapsed Time: '135745.386425' 2020-02-02 20:10:27 (8436): Status Report: CPU Time: '311.578125' 2020-02-02 21:50:33 (8436): Status Report: Elapsed Time: '141745.386425' 2020-02-02 21:50:33 (8436): Status Report: CPU Time: '323.671875' 2020-02-02 23:30:39 (8436): Status Report: Elapsed Time: '147745.386425' 2020-02-02 23:30:39 (8436): Status Report: CPU Time: '336.062500' 2020-02-03 01:10:45 (8436): Status Report: Elapsed Time: '153745.386425' 2020-02-03 01:10:45 (8436): Status Report: CPU Time: '348.906250' 2020-02-03 02:50:51 (8436): Status Report: Elapsed Time: '159745.386425' 2020-02-03 02:50:51 (8436): Status Report: CPU Time: '361.421875' 2020-02-03 04:30:57 (8436): Status Report: Elapsed Time: '165745.386425' 2020-02-03 04:30:57 (8436): Status Report: CPU Time: '374.718750' 2020-02-03 06:11:03 (8436): Status Report: Elapsed Time: '171745.386425' 2020-02-03 06:11:03 (8436): Status Report: CPU Time: '387.343750' 2020-02-03 07:51:08 (8436): Status Report: Elapsed Time: '177745.386425' 2020-02-03 07:51:08 (8436): Status Report: CPU Time: '399.937500' 2020-02-03 09:31:14 (8436): Status Report: Elapsed Time: '183745.386425' 2020-02-03 09:31:14 (8436): Status Report: CPU Time: '412.750000' 2020-02-03 09:56:04 (8436): Stopping VM. 2020-02-03 09:57:56 (1188): Detected: vboxwrapper 26197 2020-02-03 09:57:56 (1188): Detected: BOINC client v7.7 2020-02-03 09:57:57 (1188): Detected: VirtualBox VboxManage Interface (Version: 6.1.2) 2020-02-03 09:57:57 (1188): Starting VM using VBoxManage interface. (boinc_241d70e82b605c8a, slot#14) 2020-02-03 09:58:03 (1188): Successfully started VM. (PID = '10104') 2020-02-03 09:58:03 (1188): Reporting VM Process ID to BOINC. 2020-02-03 09:58:03 (1188): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-02-03 09:58:03 (1188): Detected: Web Application Enabled (http://localhost:51008) 2020-02-03 09:58:03 (1188): Detected: Remote Desktop Enabled (localhost:51009) 2020-02-03 09:58:03 (1188): Status Report: Elapsed Time: '185233.386425' 2020-02-03 09:58:03 (1188): Status Report: CPU Time: '415.796875' 2020-02-03 09:58:03 (1188): Preference change detected 2020-02-03 09:58:03 (1188): Setting CPU throttle for VM. (100%) 2020-02-03 09:58:03 (1188): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) |
19)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41453)
Posted 3 Feb 2020 by broz69 Post: WU ID: 130921208 1-2-2020 22:39 Application ATLAS Simulation 2.00 (vbox64_mt_mcore_atlas) Name aCbLDm850Dwn9Rq4apoT9bVoABFKDmABFKDmLD8WDmABFKDmC74yGn State Running Received 21/01/2020 17:24:37 Report deadline 28/01/2020 17:24:37 Resources 4 CPUs Estimated computation size 43,200 GFLOPs CPU time 00:15:42 CPU time since checkpoint 00:00:00 Elapsed time 4d 17:14:53 Estimated time remaining --- Fraction done 100.000% Virtual memory size 83.26 MB Working set size 9.96 GB Directory slots/15 Process ID 9664 Progress rate 0.720% per hour Executable vboxwrapper_26198ab7_windows_x86_64.exe 3-2-2020 09:16 Application ATLAS Simulation 2.00 (vbox64_mt_mcore_atlas) Name aCbLDm850Dwn9Rq4apoT9bVoABFKDmABFKDmLD8WDmABFKDmC74yGn State Running Received 21/01/2020 17:24:37 Report deadline 28/01/2020 17:24:37 Resources 4 CPUs Estimated computation size 43,200 GFLOPs CPU time 00:20:11 CPU time since checkpoint --- Elapsed time 6d 04:26:16 Estimated time remaining --- Fraction done 100.000% Virtual memory size 83.50 MB Working set size 9.96 GB Directory slots/15 Process ID 9664 Progress rate 0.720% per hour Executable vboxwrapper_26198ab7_windows_x86_64.exe stderr.txt from slots directory: 2020-01-25 10:20:56 (2352): Detected: vboxwrapper 26197 2020-01-25 10:20:56 (2352): Detected: BOINC client v7.7 2020-01-25 10:20:57 (2352): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-25 10:20:57 (2352): Successfully copied 'init_data.xml' to the shared directory. 2020-01-25 10:20:58 (2352): Create VM. (boinc_959537d37d2ec3c6, slot#15) 2020-01-25 10:20:59 (2352): Setting Memory Size for VM. (10200MB) 2020-01-25 10:20:59 (2352): Setting CPU Count for VM. (8) 2020-01-25 10:20:59 (2352): Setting Chipset Options for VM. 2020-01-25 10:21:00 (2352): Setting Boot Options for VM. 2020-01-25 10:21:00 (2352): Setting Network Configuration for NAT. 2020-01-25 10:21:00 (2352): Enabling VM Network Access. 2020-01-25 10:21:01 (2352): Disabling USB Support for VM. 2020-01-25 10:21:01 (2352): Disabling COM Port Support for VM. 2020-01-25 10:21:01 (2352): Disabling LPT Port Support for VM. 2020-01-25 10:21:01 (2352): Disabling Audio Support for VM. 2020-01-25 10:21:02 (2352): Disabling Clipboard Support for VM. 2020-01-25 10:21:02 (2352): Disabling Drag and Drop Support for VM. 2020-01-25 10:21:02 (2352): Adding storage controller(s) to VM. 2020-01-25 10:21:02 (2352): Adding virtual disk drive to VM. (vm_image.vdi) 2020-01-25 10:21:03 (2352): Adding VirtualBox Guest Additions to VM. 2020-01-25 10:21:03 (2352): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2020-01-25 10:21:03 (2352): forwarding host port 50549 to guest port 80 2020-01-25 10:21:04 (2352): Enabling remote desktop for VM. 2020-01-25 10:21:04 (2352): Enabling shared directory for VM. 2020-01-25 10:21:04 (2352): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-25 10:21:07 (2352): Successfully started VM. (PID = '2168') 2020-01-25 10:21:07 (2352): Reporting VM Process ID to BOINC. 2020-01-25 10:21:07 (2352): Guest Log: BIOS: VirtualBox 6.0.8 2020-01-25 10:21:07 (2352): Guest Log: CPUID EDX: 0x178bfbff 2020-01-25 10:21:07 (2352): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-01-25 10:21:07 (2352): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-25 10:21:07 (2352): Detected: Web Application Enabled (http://localhost:50549) 2020-01-25 10:21:07 (2352): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-25 10:21:07 (2352): Preference change detected 2020-01-25 10:21:07 (2352): Setting CPU throttle for VM. (100%) 2020-01-25 10:21:08 (2352): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-25 10:21:09 (2352): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-01-25 10:21:09 (2352): Guest Log: BIOS: Booting from Hard Disk... 2020-01-25 10:21:12 (2352): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-01-25 10:21:12 (2352): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2020-01-25 10:21:12 (2352): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2020-01-25 10:21:21 (2352): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-01-25 10:21:21 (2352): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-01-25 10:21:31 (2352): Guest Log: Checking CVMFS... 2020-01-25 10:21:32 (2352): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2020-01-25 10:21:32 (2352): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2020-01-25 10:21:32 (2352): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2020-01-25 10:21:32 (2352): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2020-01-25 10:21:45 (2352): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000123 main Log opened 2020-01-25T10:21:44.015521000Z 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000186 main OS Product: Linux 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000209 main OS Release: 3.10.0-957.27.2.el7.x86_64 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000227 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000245 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000245 main Process ID: 1862 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000246 main Package type: LINUX_64BITS_GENERIC 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.000703 main 5.2.32 r132073 started. Verbose level = 0 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.001539 main Error: Service 'control' failed to initialize: VERR_INVALID_FUNCTION 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.001714 main Session 0 is about to close ... 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.001738 main Stopping all guest processes ... 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.001758 main Closing all guest files ... 2020-01-25 10:21:45 (2352): Guest Log: 00:00:00.001848 main Ended. 2020-01-25 12:01:12 (2352): Status Report: Elapsed Time: '6000.000000' 2020-01-25 12:01:12 (2352): Status Report: CPU Time: '31.578125' 2020-01-25 13:41:16 (2352): Status Report: Elapsed Time: '12000.000000' 2020-01-25 13:41:16 (2352): Status Report: CPU Time: '42.328125' 2020-01-25 15:21:20 (2352): Status Report: Elapsed Time: '18000.000000' 2020-01-25 15:21:20 (2352): Status Report: CPU Time: '54.390625' 2020-01-25 17:01:23 (2352): Status Report: Elapsed Time: '24000.000000' 2020-01-25 17:01:23 (2352): Status Report: CPU Time: '65.859375' 2020-01-25 18:41:27 (2352): Status Report: Elapsed Time: '30000.000000' 2020-01-25 18:41:27 (2352): Status Report: CPU Time: '76.921875' 2020-01-25 20:21:31 (2352): Status Report: Elapsed Time: '36000.000000' 2020-01-25 20:21:31 (2352): Status Report: CPU Time: '88.421875' 2020-01-25 22:01:36 (2352): Status Report: Elapsed Time: '42000.000000' 2020-01-25 22:01:36 (2352): Status Report: CPU Time: '100.296875' 2020-01-25 23:41:40 (2352): Status Report: Elapsed Time: '48000.000000' 2020-01-25 23:41:40 (2352): Status Report: CPU Time: '111.625000' 2020-01-26 00:02:44 (2352): Stopping VM. 2020-01-26 00:02:44 (2352): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_959537d37d2ec3c6" savestate Output: 2020-01-26 00:02:44 (2352): VM did not stop when requested. 2020-01-26 00:02:44 (2352): VM was successfully terminated. 2020-01-26 08:10:05 (7360): Detected: vboxwrapper 26197 2020-01-26 08:10:05 (7360): Detected: BOINC client v7.7 2020-01-26 08:10:07 (7360): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-26 08:10:07 (7360): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-26 08:10:11 (7360): Successfully started VM. (PID = '7512') 2020-01-26 08:10:11 (7360): Reporting VM Process ID to BOINC. 2020-01-26 08:10:11 (7360): Guest Log: BIOS: VirtualBox 6.0.8 2020-01-26 08:10:11 (7360): Guest Log: CPUID EDX: 0x178bfbff 2020-01-26 08:10:11 (7360): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-01-26 08:10:11 (7360): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-26 08:10:11 (7360): Detected: Web Application Enabled (http://localhost:50549) 2020-01-26 08:10:11 (7360): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-26 08:10:11 (7360): Status Report: Elapsed Time: '49263.000000' 2020-01-26 08:10:11 (7360): Status Report: CPU Time: '114.046875' 2020-01-26 08:10:11 (7360): Preference change detected 2020-01-26 08:10:11 (7360): Setting CPU throttle for VM. (100%) 2020-01-26 08:10:12 (7360): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-26 08:10:13 (7360): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-01-26 08:10:13 (7360): Guest Log: BIOS: Booting from Hard Disk... 2020-01-26 08:10:16 (7360): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-01-26 08:10:16 (7360): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2020-01-26 08:10:16 (7360): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2020-01-26 08:10:26 (7360): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-01-26 08:10:26 (7360): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-01-26 08:10:35 (7360): Guest Log: Checking CVMFS... 2020-01-26 08:10:37 (7360): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2020-01-26 08:10:37 (7360): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2020-01-26 08:10:37 (7360): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2020-01-26 08:10:37 (7360): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2020-01-26 08:10:49 (7360): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000128 main Log opened 2020-01-26T08:10:47.898874000Z 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000194 main OS Product: Linux 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000217 main OS Release: 3.10.0-957.27.2.el7.x86_64 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000236 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000255 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000255 main Process ID: 1860 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000256 main Package type: LINUX_64BITS_GENERIC 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.000725 main 5.2.32 r132073 started. Verbose level = 0 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.001876 main Error: Service 'control' failed to initialize: VERR_INVALID_FUNCTION 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.002071 main Session 0 is about to close ... 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.002118 main Stopping all guest processes ... 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.002140 main Closing all guest files ... 2020-01-26 08:10:49 (7360): Guest Log: 00:00:00.002232 main Ended. 2020-01-26 09:50:16 (7360): Status Report: Elapsed Time: '55263.000000' 2020-01-26 09:50:16 (7360): Status Report: CPU Time: '142.718750' 2020-01-26 11:30:20 (7360): Status Report: Elapsed Time: '61263.000000' 2020-01-26 11:30:20 (7360): Status Report: CPU Time: '154.687500' 2020-01-26 13:10:25 (7360): Status Report: Elapsed Time: '67263.000000' 2020-01-26 13:10:25 (7360): Status Report: CPU Time: '167.531250' 2020-01-26 14:50:29 (7360): Status Report: Elapsed Time: '73263.000000' 2020-01-26 14:50:29 (7360): Status Report: CPU Time: '179.703125' 2020-01-26 16:30:33 (7360): Status Report: Elapsed Time: '79263.000000' 2020-01-26 16:30:33 (7360): Status Report: CPU Time: '191.328125' 2020-01-26 18:10:37 (7360): Status Report: Elapsed Time: '85263.000000' 2020-01-26 18:10:37 (7360): Status Report: CPU Time: '202.859375' 2020-01-26 19:50:42 (7360): Status Report: Elapsed Time: '91263.000000' 2020-01-26 19:50:42 (7360): Status Report: CPU Time: '215.468750' 2020-01-26 21:30:46 (7360): Status Report: Elapsed Time: '97263.000000' 2020-01-26 21:30:46 (7360): Status Report: CPU Time: '227.296875' 2020-01-26 23:10:51 (7360): Status Report: Elapsed Time: '103263.000000' 2020-01-26 23:10:51 (7360): Status Report: CPU Time: '239.203125' 2020-01-26 23:35:05 (7360): VM state change detected. (old = 'Running', new = 'Paused') 2020-01-26 23:35:05 (7360): Stopping VM. 2020-01-27 07:10:38 (7360): VM did not stop when requested. 2020-01-27 07:10:38 (7360): VM was successfully terminated. 2020-01-27 07:10:50 (9076): Detected: vboxwrapper 26197 2020-01-27 07:10:50 (9076): Detected: BOINC client v7.7 2020-01-27 07:10:51 (9076): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-27 07:10:51 (9076): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-27 07:10:58 (9076): Successfully started VM. (PID = '1252') 2020-01-27 07:10:58 (9076): Reporting VM Process ID to BOINC. 2020-01-27 07:10:58 (9076): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-27 07:10:58 (9076): Detected: Web Application Enabled (http://localhost:50549) 2020-01-27 07:10:58 (9076): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-27 07:10:58 (9076): Status Report: Elapsed Time: '104716.000000' 2020-01-27 07:10:58 (9076): Status Report: CPU Time: '242.156250' 2020-01-27 07:10:58 (9076): Preference change detected 2020-01-27 07:10:58 (9076): Setting CPU throttle for VM. (100%) 2020-01-27 07:10:59 (9076): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-27 08:51:03 (9076): Status Report: Elapsed Time: '110716.000000' 2020-01-27 08:51:03 (9076): Status Report: CPU Time: '257.609375' 2020-01-27 10:31:07 (9076): Status Report: Elapsed Time: '116716.000000' 2020-01-27 10:31:07 (9076): Status Report: CPU Time: '268.625000' 2020-01-27 12:11:12 (9076): Status Report: Elapsed Time: '122716.000000' 2020-01-27 12:11:12 (9076): Status Report: CPU Time: '281.906250' 2020-01-27 13:51:16 (9076): Status Report: Elapsed Time: '128716.000000' 2020-01-27 13:51:16 (9076): Status Report: CPU Time: '294.859375' 2020-01-27 15:31:21 (9076): Status Report: Elapsed Time: '134716.000000' 2020-01-27 15:31:21 (9076): Status Report: CPU Time: '308.390625' 2020-01-27 17:11:25 (9076): Status Report: Elapsed Time: '140716.000000' 2020-01-27 17:11:25 (9076): Status Report: CPU Time: '321.296875' 2020-01-27 18:51:29 (9076): Status Report: Elapsed Time: '146716.000000' 2020-01-27 18:51:29 (9076): Status Report: CPU Time: '334.421875' 2020-01-27 20:31:32 (9076): Status Report: Elapsed Time: '152716.000000' 2020-01-27 20:31:32 (9076): Status Report: CPU Time: '346.640625' 2020-01-27 22:11:36 (9076): Status Report: Elapsed Time: '158716.000000' 2020-01-27 22:11:36 (9076): Status Report: CPU Time: '358.890625' 2020-01-27 23:30:55 (9076): VM state change detected. (old = 'Running', new = 'Paused') 2020-01-27 23:30:55 (9076): Stopping VM. 2020-01-28 07:10:39 (9076): VM did not stop when requested. 2020-01-28 07:10:39 (9076): VM was successfully terminated. 2020-01-28 07:10:49 (3896): Detected: vboxwrapper 26197 2020-01-28 07:10:49 (3896): Detected: BOINC client v7.7 2020-01-28 07:10:50 (3896): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-28 07:10:50 (3896): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-28 07:10:58 (3896): Successfully started VM. (PID = '8640') 2020-01-28 07:10:58 (3896): Reporting VM Process ID to BOINC. 2020-01-28 07:10:58 (3896): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-28 07:10:58 (3896): Detected: Web Application Enabled (http://localhost:50549) 2020-01-28 07:10:58 (3896): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-28 07:10:58 (3896): Status Report: Elapsed Time: '163472.000000' 2020-01-28 07:10:58 (3896): Status Report: CPU Time: '368.187500' 2020-01-28 07:10:58 (3896): Preference change detected 2020-01-28 07:10:58 (3896): Setting CPU throttle for VM. (100%) 2020-01-28 07:10:58 (3896): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-28 07:35:48 (3896): VM state change detected. (old = 'Running', new = 'Paused') 2020-01-28 07:35:59 (3896): VM state change detected. (old = 'Paused', new = 'Running') 2020-01-28 08:51:15 (3896): Status Report: Elapsed Time: '169472.000000' 2020-01-28 08:51:15 (3896): Status Report: CPU Time: '384.468750' 2020-01-28 09:16:10 (3896): Stopping VM. 2020-01-28 09:16:10 (3896): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_959537d37d2ec3c6" savestate Output: 2020-01-28 09:16:10 (3896): VM did not stop when requested. 2020-01-28 09:16:10 (3896): VM was successfully terminated. 2020-01-28 09:17:33 (4796): Detected: vboxwrapper 26197 2020-01-28 09:17:33 (4796): Detected: BOINC client v7.7 2020-01-28 09:17:35 (4796): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-28 09:17:35 (4796): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-28 09:17:39 (4796): Successfully started VM. (PID = '10136') 2020-01-28 09:17:39 (4796): Reporting VM Process ID to BOINC. 2020-01-28 09:17:39 (4796): Guest Log: BIOS: VirtualBox 6.0.8 2020-01-28 09:17:39 (4796): Guest Log: CPUID EDX: 0x178bfbff 2020-01-28 09:17:39 (4796): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-01-28 09:17:39 (4796): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-28 09:17:39 (4796): Detected: Web Application Enabled (http://localhost:50549) 2020-01-28 09:17:39 (4796): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-28 09:17:39 (4796): Status Report: Elapsed Time: '170966.000000' 2020-01-28 09:17:39 (4796): Status Report: CPU Time: '387.250000' 2020-01-28 09:17:39 (4796): Preference change detected 2020-01-28 09:17:39 (4796): Setting CPU throttle for VM. (100%) 2020-01-28 09:17:40 (4796): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-28 09:17:41 (4796): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-01-28 09:17:41 (4796): Guest Log: BIOS: Booting from Hard Disk... 2020-01-28 09:17:44 (4796): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-01-28 09:17:44 (4796): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2020-01-28 09:17:44 (4796): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2020-01-28 09:17:53 (4796): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-01-28 09:17:53 (4796): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-01-28 09:18:01 (4796): Guest Log: Checking CVMFS... 2020-01-28 09:18:03 (4796): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2020-01-28 09:18:03 (4796): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2020-01-28 09:18:03 (4796): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2020-01-28 09:18:03 (4796): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2020-01-28 09:18:15 (4796): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000128 main Log opened 2020-01-28T09:18:14.000148000Z 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000196 main OS Product: Linux 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000220 main OS Release: 3.10.0-957.27.2.el7.x86_64 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000238 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000257 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000257 main Process ID: 1886 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000258 main Package type: LINUX_64BITS_GENERIC 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.000741 main 5.2.32 r132073 started. Verbose level = 0 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.001166 main Error: Service 'control' failed to initialize: VERR_INVALID_FUNCTION 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.001242 main Session 0 is about to close ... 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.001265 main Stopping all guest processes ... 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.001283 main Closing all guest files ... 2020-01-28 09:18:15 (4796): Guest Log: 00:00:00.001349 main Ended. 2020-01-28 09:40:33 (4796): Preference change detected 2020-01-28 09:40:33 (4796): Setting CPU throttle for VM. (100%) 2020-01-28 09:40:34 (4796): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-28 09:41:46 (4796): Preference change detected 2020-01-28 09:41:46 (4796): Setting CPU throttle for VM. (100%) 2020-01-28 09:41:47 (4796): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-28 09:42:02 (4796): Stopping VM. 2020-01-28 09:43:14 (8512): Detected: vboxwrapper 26197 2020-01-28 09:43:14 (8512): Detected: BOINC client v7.7 2020-01-28 09:43:15 (8512): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-28 09:43:16 (8512): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-28 09:43:21 (8512): Successfully started VM. (PID = '2436') 2020-01-28 09:43:21 (8512): Reporting VM Process ID to BOINC. 2020-01-28 09:43:21 (8512): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-28 09:43:21 (8512): Detected: Web Application Enabled (http://localhost:50549) 2020-01-28 09:43:21 (8512): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-28 09:43:21 (8512): Status Report: Elapsed Time: '172428.000000' 2020-01-28 09:43:21 (8512): Status Report: CPU Time: '407.312500' 2020-01-28 09:43:21 (8512): Preference change detected 2020-01-28 09:43:21 (8512): Setting CPU throttle for VM. (100%) 2020-01-28 09:43:21 (8512): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-28 11:23:25 (8512): Status Report: Elapsed Time: '178428.000000' 2020-01-28 11:23:25 (8512): Status Report: CPU Time: '422.281250' 2020-01-28 13:03:30 (8512): Status Report: Elapsed Time: '184428.000000' 2020-01-28 13:03:30 (8512): Status Report: CPU Time: '434.296875' 2020-01-28 14:43:34 (8512): Status Report: Elapsed Time: '190428.000000' 2020-01-28 14:43:34 (8512): Status Report: CPU Time: '446.171875' 2020-01-28 16:23:39 (8512): Status Report: Elapsed Time: '196428.000000' 2020-01-28 16:23:39 (8512): Status Report: CPU Time: '458.562500' 2020-01-28 18:03:43 (8512): Status Report: Elapsed Time: '202428.000000' 2020-01-28 18:03:43 (8512): Status Report: CPU Time: '470.562500' 2020-01-28 19:43:48 (8512): Status Report: Elapsed Time: '208428.000000' 2020-01-28 19:43:48 (8512): Status Report: CPU Time: '483.000000' 2020-01-28 21:23:52 (8512): Status Report: Elapsed Time: '214428.000000' 2020-01-28 21:23:52 (8512): Status Report: CPU Time: '495.234375' 2020-01-28 23:03:57 (8512): Status Report: Elapsed Time: '220428.000000' 2020-01-28 23:03:57 (8512): Status Report: CPU Time: '507.906250' 2020-01-28 23:36:34 (8512): Stopping VM. 2020-01-28 23:36:34 (8512): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_959537d37d2ec3c6" savestate Output: 2020-01-28 23:36:34 (8512): VM did not stop when requested. 2020-01-28 23:36:34 (8512): VM was successfully terminated. 2020-01-29 08:33:28 (7712): Detected: vboxwrapper 26197 2020-01-29 08:33:28 (7712): Detected: BOINC client v7.7 2020-01-29 08:33:29 (7712): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-29 08:33:30 (7712): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-29 08:33:34 (7712): Successfully started VM. (PID = '7864') 2020-01-29 08:33:34 (7712): Reporting VM Process ID to BOINC. 2020-01-29 08:33:34 (7712): Guest Log: BIOS: VirtualBox 6.0.8 2020-01-29 08:33:34 (7712): Guest Log: CPUID EDX: 0x178bfbff 2020-01-29 08:33:34 (7712): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-01-29 08:33:34 (7712): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-29 08:33:34 (7712): Detected: Web Application Enabled (http://localhost:50549) 2020-01-29 08:33:34 (7712): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-29 08:33:34 (7712): Status Report: Elapsed Time: '222383.000000' 2020-01-29 08:33:34 (7712): Status Report: CPU Time: '512.390625' 2020-01-29 08:33:34 (7712): Preference change detected 2020-01-29 08:33:34 (7712): Setting CPU throttle for VM. (100%) 2020-01-29 08:33:34 (7712): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-29 08:33:36 (7712): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-01-29 08:33:36 (7712): Guest Log: BIOS: Booting from Hard Disk... 2020-01-29 08:33:39 (7712): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-01-29 08:33:39 (7712): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2020-01-29 08:33:39 (7712): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2020-01-29 08:33:52 (7712): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-01-29 08:33:52 (7712): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-01-29 08:34:24 (7712): Guest Log: Checking CVMFS... 2020-01-29 08:34:26 (7712): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2020-01-29 08:34:26 (7712): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2020-01-29 08:34:26 (7712): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2020-01-29 08:34:26 (7712): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2020-01-29 08:34:38 (7712): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000130 main Log opened 2020-01-29T08:34:36.487864000Z 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000201 main OS Product: Linux 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000224 main OS Release: 3.10.0-957.27.2.el7.x86_64 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000242 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000261 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000261 main Process ID: 1864 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000262 main Package type: LINUX_64BITS_GENERIC 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.000729 main 5.2.32 r132073 started. Verbose level = 0 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.001148 main Error: Service 'control' failed to initialize: VERR_INVALID_FUNCTION 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.001218 main Session 0 is about to close ... 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.001239 main Stopping all guest processes ... 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.001257 main Closing all guest files ... 2020-01-29 08:34:38 (7712): Guest Log: 00:00:00.001329 main Ended. 2020-01-29 10:13:39 (7712): Status Report: Elapsed Time: '228383.000000' 2020-01-29 10:13:39 (7712): Status Report: CPU Time: '539.562500' 2020-01-29 11:53:43 (7712): Status Report: Elapsed Time: '234383.000000' 2020-01-29 11:53:43 (7712): Status Report: CPU Time: '552.468750' 2020-01-29 13:33:48 (7712): Status Report: Elapsed Time: '240383.000000' 2020-01-29 13:33:48 (7712): Status Report: CPU Time: '565.062500' 2020-01-29 15:13:52 (7712): Status Report: Elapsed Time: '246383.000000' 2020-01-29 15:13:52 (7712): Status Report: CPU Time: '578.203125' 2020-01-29 16:53:56 (7712): Status Report: Elapsed Time: '252383.000000' 2020-01-29 16:53:56 (7712): Status Report: CPU Time: '590.843750' 2020-01-29 18:34:01 (7712): Status Report: Elapsed Time: '258383.000000' 2020-01-29 18:34:01 (7712): Status Report: CPU Time: '603.296875' 2020-01-29 20:14:05 (7712): Status Report: Elapsed Time: '264383.000000' 2020-01-29 20:14:05 (7712): Status Report: CPU Time: '615.250000' 2020-01-29 21:54:10 (7712): Status Report: Elapsed Time: '270383.000000' 2020-01-29 21:54:10 (7712): Status Report: CPU Time: '626.781250' 2020-01-29 22:27:39 (7712): Stopping VM. 2020-01-29 22:27:39 (7712): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_959537d37d2ec3c6" savestate Output: 2020-01-29 22:27:39 (7712): VM did not stop when requested. 2020-01-29 22:27:39 (7712): VM was successfully terminated. 2020-01-30 07:46:15 (7308): Detected: vboxwrapper 26197 2020-01-30 07:46:15 (7308): Detected: BOINC client v7.7 2020-01-30 07:46:16 (7308): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-30 07:46:17 (7308): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-30 07:46:21 (7308): Successfully started VM. (PID = '7532') 2020-01-30 07:46:21 (7308): Reporting VM Process ID to BOINC. 2020-01-30 07:46:21 (7308): Guest Log: BIOS: VirtualBox 6.0.8 2020-01-30 07:46:21 (7308): Guest Log: CPUID EDX: 0x178bfbff 2020-01-30 07:46:21 (7308): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-01-30 07:46:21 (7308): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-30 07:46:21 (7308): Detected: Web Application Enabled (http://localhost:50549) 2020-01-30 07:46:21 (7308): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-30 07:46:21 (7308): Status Report: Elapsed Time: '272391.000000' 2020-01-30 07:46:21 (7308): Status Report: CPU Time: '630.968750' 2020-01-30 07:46:21 (7308): Preference change detected 2020-01-30 07:46:21 (7308): Setting CPU throttle for VM. (100%) 2020-01-30 07:46:21 (7308): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-30 07:46:23 (7308): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-01-30 07:46:23 (7308): Guest Log: BIOS: Booting from Hard Disk... 2020-01-30 07:46:26 (7308): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-01-30 07:46:26 (7308): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2020-01-30 07:46:26 (7308): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2020-01-30 07:46:36 (7308): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-01-30 07:46:36 (7308): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-01-30 07:47:00 (7308): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000195 main Log opened 2020-01-30T07:46:59.309790000Z 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000263 main OS Product: Linux 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000285 main OS Release: 3.10.0-957.27.2.el7.x86_64 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000304 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000322 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000323 main Process ID: 1095 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000323 main Package type: LINUX_64BITS_GENERIC 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.000825 main 5.2.32 r132073 started. Verbose level = 0 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.001245 main Error: Service 'control' failed to initialize: VERR_INVALID_FUNCTION 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.001318 main Session 0 is about to close ... 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.001341 main Stopping all guest processes ... 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.001360 main Closing all guest files ... 2020-01-30 07:47:00 (7308): Guest Log: 00:00:00.001429 main Ended. 2020-01-30 07:47:05 (7308): Guest Log: Checking CVMFS... 2020-01-30 07:47:06 (7308): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2020-01-30 07:47:06 (7308): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2020-01-30 07:47:06 (7308): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2020-01-30 07:47:06 (7308): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2020-01-30 09:26:25 (7308): Status Report: Elapsed Time: '278391.000000' 2020-01-30 09:26:25 (7308): Status Report: CPU Time: '658.312500' 2020-01-30 11:06:30 (7308): Status Report: Elapsed Time: '284391.000000' 2020-01-30 11:06:30 (7308): Status Report: CPU Time: '670.203125' 2020-01-30 12:46:34 (7308): Status Report: Elapsed Time: '290391.000000' 2020-01-30 12:46:34 (7308): Status Report: CPU Time: '681.796875' 2020-01-30 14:26:39 (7308): Status Report: Elapsed Time: '296391.000000' 2020-01-30 14:26:39 (7308): Status Report: CPU Time: '694.187500' 2020-01-30 16:06:43 (7308): Status Report: Elapsed Time: '302391.000000' 2020-01-30 16:06:43 (7308): Status Report: CPU Time: '706.296875' 2020-01-30 17:46:48 (7308): Status Report: Elapsed Time: '308391.000000' 2020-01-30 17:46:48 (7308): Status Report: CPU Time: '718.312500' 2020-01-30 19:26:52 (7308): Status Report: Elapsed Time: '314391.000000' 2020-01-30 19:26:52 (7308): Status Report: CPU Time: '730.281250' 2020-01-30 21:06:57 (7308): Status Report: Elapsed Time: '320391.000000' 2020-01-30 21:06:57 (7308): Status Report: CPU Time: '742.031250' 2020-01-30 22:47:01 (7308): Status Report: Elapsed Time: '326391.000000' 2020-01-30 22:47:01 (7308): Status Report: CPU Time: '753.390625' 2020-01-30 23:14:16 (7308): Stopping VM. 2020-01-30 23:14:17 (7308): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_959537d37d2ec3c6" savestate Output: 2020-01-30 23:14:17 (7308): VM did not stop when requested. 2020-01-30 23:14:17 (7308): VM was successfully terminated. 2020-01-31 09:11:55 (8088): Detected: vboxwrapper 26197 2020-01-31 09:11:55 (8088): Detected: BOINC client v7.7 2020-01-31 09:11:56 (8088): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-31 09:11:57 (8088): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-31 09:12:01 (8088): Successfully started VM. (PID = '8176') 2020-01-31 09:12:01 (8088): Reporting VM Process ID to BOINC. 2020-01-31 09:12:01 (8088): Guest Log: BIOS: VirtualBox 6.0.8 2020-01-31 09:12:01 (8088): Guest Log: CPUID EDX: 0x178bfbff 2020-01-31 09:12:01 (8088): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-01-31 09:12:01 (8088): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-31 09:12:01 (8088): Detected: Web Application Enabled (http://localhost:50549) 2020-01-31 09:12:01 (8088): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-31 09:12:01 (8088): Status Report: Elapsed Time: '328025.000000' 2020-01-31 09:12:01 (8088): Status Report: CPU Time: '756.531250' 2020-01-31 09:12:01 (8088): Preference change detected 2020-01-31 09:12:01 (8088): Setting CPU throttle for VM. (100%) 2020-01-31 09:12:01 (8088): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-31 09:12:03 (8088): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-01-31 09:12:03 (8088): Guest Log: BIOS: Booting from Hard Disk... 2020-01-31 09:12:06 (8088): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-01-31 09:12:06 (8088): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2020-01-31 09:12:06 (8088): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2020-01-31 09:12:16 (8088): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-01-31 09:12:16 (8088): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-01-31 09:12:26 (8088): Guest Log: Checking CVMFS... 2020-01-31 09:12:28 (8088): Guest Log: Failed to check CVMFS, check output from cvmfs_config probe: 2020-01-31 09:12:28 (8088): Guest Log: Probing /cvmfs/atlas.cern.ch... Failed! 2020-01-31 09:12:28 (8088): Guest Log: Probing /cvmfs/atlas-condb.cern.ch... Failed! 2020-01-31 09:12:28 (8088): Guest Log: Probing /cvmfs/grid.cern.ch... Failed! 2020-01-31 09:12:38 (8088): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000124 main Log opened 2020-01-31T09:12:36.563997000Z 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000190 main OS Product: Linux 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000213 main OS Release: 3.10.0-957.27.2.el7.x86_64 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000232 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000250 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000250 main Process ID: 1862 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000251 main Package type: LINUX_64BITS_GENERIC 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.000725 main 5.2.32 r132073 started. Verbose level = 0 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.001197 main Error: Service 'control' failed to initialize: VERR_INVALID_FUNCTION 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.001293 main Session 0 is about to close ... 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.001316 main Stopping all guest processes ... 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.001336 main Closing all guest files ... 2020-01-31 09:12:38 (8088): Guest Log: 00:00:00.001424 main Ended. 2020-01-31 10:52:05 (8088): Status Report: Elapsed Time: '334025.000000' 2020-01-31 10:52:05 (8088): Status Report: CPU Time: '782.546875' 2020-01-31 12:32:10 (8088): Status Report: Elapsed Time: '340025.000000' 2020-01-31 12:32:10 (8088): Status Report: CPU Time: '795.671875' 2020-01-31 14:12:14 (8088): Status Report: Elapsed Time: '346025.000000' 2020-01-31 14:12:14 (8088): Status Report: CPU Time: '808.093750' 2020-01-31 15:52:19 (8088): Status Report: Elapsed Time: '352025.000000' 2020-01-31 15:52:19 (8088): Status Report: CPU Time: '820.828125' 2020-01-31 17:32:23 (8088): Status Report: Elapsed Time: '358025.000000' 2020-01-31 17:32:23 (8088): Status Report: CPU Time: '833.109375' 2020-01-31 19:12:28 (8088): Status Report: Elapsed Time: '364025.000000' 2020-01-31 19:12:28 (8088): Status Report: CPU Time: '844.343750' 2020-01-31 20:52:32 (8088): Status Report: Elapsed Time: '370025.000000' 2020-01-31 20:52:32 (8088): Status Report: CPU Time: '856.218750' 2020-01-31 22:32:36 (8088): Status Report: Elapsed Time: '376025.000000' 2020-01-31 22:32:36 (8088): Status Report: CPU Time: '868.546875' 2020-01-31 23:00:40 (8088): Stopping VM. 2020-01-31 23:05:54 (4236): Detected: vboxwrapper 26197 2020-01-31 23:05:54 (4236): Detected: BOINC client v7.7 2020-01-31 23:05:55 (4236): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-01-31 23:05:55 (4236): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-01-31 23:06:02 (4236): Successfully started VM. (PID = '8604') 2020-01-31 23:06:02 (4236): Reporting VM Process ID to BOINC. 2020-01-31 23:06:02 (4236): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-01-31 23:06:02 (4236): Detected: Web Application Enabled (http://localhost:50549) 2020-01-31 23:06:02 (4236): Detected: Remote Desktop Enabled (localhost:50550) 2020-01-31 23:06:02 (4236): Status Report: Elapsed Time: '377707.000000' 2020-01-31 23:06:02 (4236): Status Report: CPU Time: '871.531250' 2020-01-31 23:06:02 (4236): Preference change detected 2020-01-31 23:06:02 (4236): Setting CPU throttle for VM. (100%) 2020-01-31 23:06:03 (4236): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-01-31 23:17:46 (4236): Stopping VM. 2020-02-01 08:52:59 (7760): Detected: vboxwrapper 26197 2020-02-01 08:52:59 (7760): Detected: BOINC client v7.7 2020-02-01 08:53:00 (7760): Detected: VirtualBox VboxManage Interface (Version: 6.0.8) 2020-02-01 08:53:00 (7760): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-02-01 08:53:06 (7760): Successfully started VM. (PID = '7180') 2020-02-01 08:53:06 (7760): Reporting VM Process ID to BOINC. 2020-02-01 08:53:06 (7760): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-02-01 08:53:06 (7760): Detected: Web Application Enabled (http://localhost:50549) 2020-02-01 08:53:06 (7760): Detected: Remote Desktop Enabled (localhost:50550) 2020-02-01 08:53:06 (7760): Status Report: Elapsed Time: '378410.524935' 2020-02-01 08:53:06 (7760): Status Report: CPU Time: '876.187500' 2020-02-01 08:53:06 (7760): Preference change detected 2020-02-01 08:53:06 (7760): Setting CPU throttle for VM. (100%) 2020-02-01 08:53:06 (7760): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 10:33:10 (7760): Status Report: Elapsed Time: '384410.524935' 2020-02-01 10:33:10 (7760): Status Report: CPU Time: '890.531250' 2020-02-01 12:13:13 (7760): Status Report: Elapsed Time: '390410.524935' 2020-02-01 12:13:13 (7760): Status Report: CPU Time: '901.890625' 2020-02-01 13:53:17 (7760): Status Report: Elapsed Time: '396410.524935' 2020-02-01 13:53:17 (7760): Status Report: CPU Time: '913.281250' 2020-02-01 15:33:22 (7760): Status Report: Elapsed Time: '402410.524935' 2020-02-01 15:33:22 (7760): Status Report: CPU Time: '925.578125' 2020-02-01 15:50:37 (7760): Stopping VM. 2020-02-01 20:53:27 (9664): Detected: vboxwrapper 26197 2020-02-01 20:53:27 (9664): Detected: BOINC client v7.7 2020-02-01 20:53:28 (9664): Detected: VirtualBox VboxManage Interface (Version: 6.1.2) 2020-02-01 20:53:29 (9664): Starting VM using VBoxManage interface. (boinc_959537d37d2ec3c6, slot#15) 2020-02-01 20:53:37 (9664): Successfully started VM. (PID = '9880') 2020-02-01 20:53:37 (9664): Reporting VM Process ID to BOINC. 2020-02-01 20:53:37 (9664): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-02-01 20:53:37 (9664): Detected: Web Application Enabled (http://localhost:50549) 2020-02-01 20:53:37 (9664): Detected: Remote Desktop Enabled (localhost:50550) 2020-02-01 20:53:37 (9664): Status Report: Elapsed Time: '403445.524935' 2020-02-01 20:53:37 (9664): Status Report: CPU Time: '927.718750' 2020-02-01 20:53:37 (9664): Preference change detected 2020-02-01 20:53:37 (9664): Setting CPU throttle for VM. (100%) 2020-02-01 20:53:37 (9664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 20:55:56 (9664): Preference change detected 2020-02-01 20:55:56 (9664): Setting CPU throttle for VM. (100%) 2020-02-01 20:55:56 (9664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 20:58:18 (9664): Preference change detected 2020-02-01 20:58:18 (9664): Setting CPU throttle for VM. (100%) 2020-02-01 20:58:18 (9664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 22:32:35 (9664): Preference change detected 2020-02-01 22:32:35 (9664): Setting CPU throttle for VM. (100%) 2020-02-01 22:32:35 (9664): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2020-02-01 22:33:42 (9664): Status Report: Elapsed Time: '409445.524935' 2020-02-01 22:33:42 (9664): Status Report: CPU Time: '946.812500' 2020-02-02 00:13:48 (9664): Status Report: Elapsed Time: '415445.524935' 2020-02-02 00:13:48 (9664): Status Report: CPU Time: '962.718750' 2020-02-02 01:53:54 (9664): Status Report: Elapsed Time: '421445.524935' 2020-02-02 01:53:54 (9664): Status Report: CPU Time: '975.937500' 2020-02-02 03:34:00 (9664): Status Report: Elapsed Time: '427445.524935' 2020-02-02 03:34:00 (9664): Status Report: CPU Time: '988.953125' 2020-02-02 05:14:05 (9664): Status Report: Elapsed Time: '433445.524935' 2020-02-02 05:14:05 (9664): Status Report: CPU Time: '1002.250000' 2020-02-02 06:54:11 (9664): Status Report: Elapsed Time: '439445.524935' 2020-02-02 06:54:11 (9664): Status Report: CPU Time: '1015.078125' 2020-02-02 08:34:17 (9664): Status Report: Elapsed Time: '445445.524935' 2020-02-02 08:34:17 (9664): Status Report: CPU Time: '1027.875000' 2020-02-02 10:14:23 (9664): Status Report: Elapsed Time: '451445.524935' 2020-02-02 10:14:23 (9664): Status Report: CPU Time: '1040.125000' 2020-02-02 11:54:29 (9664): Status Report: Elapsed Time: '45744 |
20)
Message boards :
ATLAS application :
ATLAS problem - long running but not using any CPU
(Message 41452)
Posted 3 Feb 2020 by broz69 Post: Hi, I have a problem with ATLAS tasks. I've read around couple of threads here but I still can't resolve the issue. https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5261#41133 https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5226 https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5256#41063 https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5255#41051 https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5162#40094 https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5195#40391 https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5135#39821 I've seen a similar thing a month or two back when I was testing another computer. ATLAS tasks seem to be running but not using any CPU (CPU usage is around 1%). This means that while they are running they are "using" all available CPUs so other BOINC tasks can't run. Another thing is that the task somehow doesn't know that it should be terminated/cancelled. Computer ID: 10570926 Windows 10 Pro 1903 (OS Build 18362.592) BOINC 7.14.2 WU ID: 131084784 WU ID: 130921208 WU 130921208 started under VirtualBox 6.0.8 r130520 (Qt5.6.2), 1-Feb-2020 upgraded to 6.1.2 r135662 (Qt5.6.2). I changed setting a bit in these days. My CPU has 8C/16T with 64GB RAM. Normally (and when the jobs were downloaded) BOINC is allowed to use 50% of CPUs and 50% of RAM. At the moment BOINC can use 100% of CPUs and 50% of RAM. Normally I also don't use app_config.xml on my computer. But at the moment I have one: <app_config> <app> <name>ATLAS</name> <max_concurrent>2</max_concurrent> </app> <app_version> <app_name>ATLAS</app_name> <plan_class>vbox64_mt_mcore_atlas</plan_class> <avg_ncpus>8.0</avg_ncpus> <cmdline>--nthreads 8</cmdline> </app_version> </app_config> I'll post logs and any attachments in another message.[url][/url] |
©2023 CERN