Name | CMS_2949884_1675527892.300633_0 |
Workunit | 2277471 |
Created | 4 Feb 2023, 16:24:56 UTC |
Sent | 8 Feb 2023, 16:31:03 UTC |
Report deadline | 15 Feb 2023, 16:31:03 UTC |
Received | 13 Feb 2023, 2:30:15 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 4318 |
Run time | 17 hours 47 min 55 sec |
CPU time | 21 hours 0 min 13 sec |
Validate state | Valid |
Credit | 1,754.36 |
Device peak FLOPS | 33.00 GFLOPS |
Application version | CMS Simulation v60.70 (vbox64_mt_mcore_cms) x86_64-pc-linux-gnu |
Peak working set size | 5.02 GB |
Peak swap size | 8.51 GB |
Peak disk usage | 3.33 GB |
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> int interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-10 20:47:19 (3700789): Guest Log: 00:59:51.448971 timesync vgsvcTimeSyncWorker: Radical host time change: 8 248 042 000 000ns (HostNow=1 676 058 438 980 000 000 ns HostLast=1 676 050 190 938 000 000 ns) 2023-02-10 20:47:29 (3700789): Guest Log: 01:00:01.449692 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 244 183 297 000ns (GuestNow=1 676 058 448 984 065 000 ns GuestLast=1 676 050 204 800 768 000 ns fSetTimeLastLoop=true ) 2023-02-10 21:25:37 (3700789): Status Report: Job Duration: '64800.000000' 2023-02-10 21:25:37 (3700789): Status Report: Elapsed Time: '6000.000000' 2023-02-10 21:25:37 (3700789): Status Report: CPU Time: '7475.240000' 2023-02-10 21:47:25 (3700789): Stopping VM. 2023-02-10 21:47:52 (3700789): Successfully stopped VM. 2023-02-11 00:03:44 (3784923): Detected: vboxwrapper 26206 2023-02-11 00:03:44 (3784923): Detected: BOINC client v7.16.11 2023-02-11 00:03:44 (3784923): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-11 00:03:45 (3784923): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-11 00:03:45 (3784923): Guest Log: 00:59:51.448971 timesync vgsvcTimeSyncWorker: Radical host time change: 8 248 042 000 000ns (HostNow=1 676 058 438 980 000 000 ns HostLast=1 676 050 190 938 000 000 ns) 2023-02-11 00:03:45 (3784923): Guest Log: 01:00:01.449692 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 244 183 297 000ns (GuestNow=1 676 058 448 984 065 000 ns GuestLast=1 676 050 204 800 768 000 ns fSetTimeLastLoop=true ) 2023-02-11 00:03:45 (3784923): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-11 00:03:58 (3784923): Successfully started VM. (PID = '3785030') 2023-02-11 00:03:58 (3784923): Reporting VM Process ID to BOINC. 2023-02-11 00:03:58 (3784923): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-11 00:03:58 (3784923): Detected: Web Application Enabled (http://localhost:52911) 2023-02-11 00:03:58 (3784923): Status Report: Job Duration: '64800.000000' 2023-02-11 00:03:58 (3784923): Status Report: Elapsed Time: '7321.000000' 2023-02-11 00:03:58 (3784923): Status Report: CPU Time: '8986.820000' 2023-02-11 00:03:58 (3784923): Preference change detected 2023-02-11 00:03:58 (3784923): Setting CPU throttle for VM. (100%) 2023-02-11 00:03:58 (3784923): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-11 00:03:59 (3784923): Guest Log: 02:00:02.945189 timesync vgsvcTimeSyncWorker: Radical host time change: 8 201 776 000 000ns (HostNow=1 676 070 238 387 000 000 ns HostLast=1 676 062 036 611 000 000 ns) 2023-02-11 00:04:09 (3784923): Guest Log: 02:00:12.952956 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 197 928 253 000ns (GuestNow=1 676 070 248 401 282 000 ns GuestLast=1 676 062 050 473 029 000 ns fSetTimeLastLoop=true ) 2023-02-11 01:03:55 (3784923): Stopping VM. 2023-02-11 01:04:36 (3784923): Successfully stopped VM. 2023-02-11 04:44:42 (3901641): Detected: vboxwrapper 26206 2023-02-11 04:44:42 (3901641): Detected: BOINC client v7.16.11 2023-02-11 04:44:42 (3901641): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-11 04:44:42 (3901641): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-11 04:44:43 (3901641): Guest Log: 02:00:02.945189 timesync vgsvcTimeSyncWorker: Radical host time change: 8 201 776 000 000ns (HostNow=1 676 070 238 387 000 000 ns HostLast=1 676 062 036 611 000 000 ns) 2023-02-11 04:44:43 (3901641): Guest Log: 02:00:12.952956 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 197 928 253 000ns (GuestNow=1 676 070 248 401 282 000 ns GuestLast=1 676 062 050 473 029 000 ns fSetTimeLastLoop=true ) 2023-02-11 04:44:43 (3901641): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-11 04:44:56 (3901641): Successfully started VM. (PID = '3901758') 2023-02-11 04:44:56 (3901641): Reporting VM Process ID to BOINC. 2023-02-11 04:44:56 (3901641): VM state change detected. (old = 'poweredoff', new = 'gurumeditation') 2023-02-11 04:50:02 (3901641): NOTE: VM failed to enter an online state within the timeout period. This might be a temporary problem and so this job will be rescheduled for another time. Hypervisor System Log: VM Execution Log: 00:00:12.573819 12: 00 3F 00 00:00:12.573820 13: 00 3F 2A 00:00:12.573821 14: 2A 15 00 00:00:12.573823 15: 2A 15 2A 00:00:12.573824 16: 2A 3F 00 00:00:12.573825 17: 2A 3F 2A 00:00:12.573827 18: 00 15 15 00:00:12.573828 19: 00 15 3F 00:00:12.573830 1A: 00 3F 15 00:00:12.573831 1B: 00 3F 3F 00:00:12.573832 1C: 2A 15 15 00:00:12.573834 1D: 2A 15 3F 00:00:12.573835 1E: 2A 3F 15 00:00:12.573836 1F: 2A 3F 3F 00:00:12.573837 20: 15 00 00 00:00:12.573838 21: 15 00 2A 00:00:12.573840 22: 15 2A 00 00:00:12.573841 23: 15 2A 2A 00:00:12.573842 24: 3F 00 00 00:00:12.573844 25: 3F 00 2A 00:00:12.573846 26: 3F 2A 00 00:00:12.573847 27: 3F 2A 2A 00:00:12.573848 28: 15 00 15 00:00:12.573849 29: 15 00 3F 00:00:12.573851 2A: 15 2A 15 00:00:12.573853 2B: 15 2A 3F 00:00:12.573854 2C: 3F 00 15 00:00:12.573855 2D: 3F 00 3F 00:00:12.573857 2E: 3F 2A 15 00:00:12.573858 2F: 3F 2A 3F 00:00:12.573860 30: 15 15 00 00:00:12.573861 31: 15 15 2A 00:00:12.573862 32: 15 3F 00 00:00:12.573864 33: 15 3F 2A 00:00:12.573865 34: 3F 15 00 00:00:12.573867 35: 3F 15 2A 00:00:12.573868 36: 3F 3F 00 00:00:12.573869 37: 3F 3F 2A 00:00:12.573871 38: 15 15 15 00:00:12.573872 39: 15 15 3F 00:00:12.573873 3A: 15 3F 15 00:00:12.573874 3B: 15 3F 3F 00:00:12.573876 3C: 3F 15 15 00:00:12.573877 3D: 3F 15 3F 00:00:12.573878 3E: 3F 3F 15 00:00:12.573880 3F: 3F 3F 3F 00:00:12.573881 40: 00 00 00 00:00:12.573883 41: 00 00 00 00:00:12.573884 42: 00 00 00 00:00:12.573885 43: 00 00 00 00:00:12.573886 44: 00 00 00 00:00:12.573888 45: 00 00 00 00:00:12.573889 46: 00 00 00 00:00:12.573890 47: 00 00 00 00:00:12.573892 48: 00 00 00 00:00:12.573893 49: 00 00 00 00:00:12.573895 4A: 00 00 00 00:00:12.573896 4B: 00 00 00 00:00:12.573897 4C: 00 00 00 00:00:12.573899 4D: 00 00 00 00:00:12.573900 4E: 00 00 00 00:00:12.573901 4F: 00 00 00 00:00:12.573902 50: 00 00 00 00:00:12.573903 51: 00 00 00 00:00:12.573905 52: 00 00 00 00:00:12.573906 53: 00 00 00 00:00:12.573907 54: 00 00 00 00:00:12.573909 55: 00 00 00 00:00:12.573910 56: 00 00 00 00:00:12.573912 57: 00 00 00 00:00:12.573913 58: 00 00 00 00:00:12.573914 59: 00 00 00 00:00:12.573916 5A: 00 00 00 00:00:12.573917 5B: 00 00 00 00:00:12.573919 5C: 00 00 00 00:00:12.573920 5D: 00 00 00 00:00:12.573921 5E: 00 00 00 00:00:12.573922 5F: 00 00 00 00:00:12.573923 60: 00 00 00 00:00:12.573925 61: 00 00 00 00:00:12.573926 62: 00 00 00 00:00:12.573928 63: 00 00 00 00:00:12.573929 64: 00 00 00 00:00:12.573930 65: 00 00 00 00:00:12.573931 66: 00 00 00 00:00:12.573933 67: 00 00 00 00:00:12.573935 68: 00 00 00 00:00:12.573936 69: 00 00 00 00:00:12.573938 6A: 00 00 00 00:00:12.573939 6B: 00 00 00 00:00:12.573940 6C: 00 00 00 00:00:12.573941 6D: 00 00 00 00:00:12.573942 6E: 00 00 00 00:00:12.573943 6F: 00 00 00 00:00:12.573945 70: 00 00 00 00:00:12.573946 71: 00 00 00 00:00:12.573947 72: 00 00 00 00:00:12.573949 73: 00 00 00 00:00:12.573950 74: 00 00 00 00:00:12.573951 75: 00 00 00 00:00:12.573952 76: 00 00 00 00:00:12.573953 77: 00 00 00 00:00:12.573955 78: 00 00 00 00:00:12.573956 79: 00 00 00 00:00:12.573958 7A: 00 00 00 00:00:12.573959 7B: 00 00 00 00:00:12.573961 7C: 00 00 00 00:00:12.573963 7D: 00 00 00 00:00:12.573965 7E: 00 00 00 00:00:12.573966 7F: 00 00 00 00:00:12.573968 80: 00 00 00 00:00:12.573969 81: 00 00 00 00:00:12.573970 82: 00 00 00 00:00:12.573972 83: 00 00 00 00:00:12.573973 84: 00 00 00 00:00:12.573974 85: 00 00 00 00:00:12.573975 86: 00 00 00 00:00:12.573976 87: 00 00 00 00:00:12.573978 88: 00 00 00 00:00:12.573979 89: 00 00 00 00:00:12.573980 8A: 00 00 00 00:00:12.573981 8B: 00 00 00 00:00:12.573982 8C: 00 00 00 00:00:12.573984 8D: 00 00 00 00:00:12.573985 8E: 00 00 00 00:00:12.573987 8F: 00 00 00 00:00:12.573988 90: 00 00 00 00:00:12.573990 91: 00 00 00 00:00:12.573991 92: 00 00 00 00:00:12.573992 93: 00 00 00 00:00:12.573994 94: 00 00 00 00:00:12.573995 95: 00 00 00 00:00:12.573997 96: 00 00 00 00:00:12.573998 97: 00 00 00 00:00:12.573999 98: 00 00 00 00:00:12.574000 99: 00 00 00 00:00:12.574002 9A: 00 00 00 00:00:12.574003 9B: 00 00 00 00:00:12.574005 9C: 00 00 00 00:00:12.574007 9D: 00 00 00 00:00:12.574008 9E: 00 00 00 00:00:12.574009 9F: 00 00 00 00:00:12.574011 A0: 00 00 00 00:00:12.574012 A1: 00 00 00 00:00:12.574013 A2: 00 00 00 00:00:12.574015 A3: 00 00 00 00:00:12.574016 A4: 00 00 00 00:00:12.574017 A5: 00 00 00 00:00:12.574018 A6: 00 00 00 00:00:12.574019 A7: 00 00 00 00:00:12.574021 A8: 00 00 00 00:00:12.574022 A9: 00 00 00 00:00:12.574023 AA: 00 00 00 00:00:12.574024 AB: 00 00 00 00:00:12.574025 AC: 00 00 00 00:00:12.574026 AD: 00 00 00 00:00:12.574030 AE: 00 00 00 00:00:12.574032 AF: 00 00 00 00:00:12.574033 B0: 00 00 00 00:00:12.574034 B1: 00 00 00 00:00:12.574035 B2: 00 00 00 00:00:12.574036 B3: 00 00 00 00:00:12.574037 B4: 00 00 00 00:00:12.574039 B5: 00 00 00 00:00:12.574040 B6: 00 00 00 00:00:12.574041 B7: 00 00 00 00:00:12.574042 B8: 00 00 00 00:00:12.574043 B9: 00 00 00 00:00:12.574044 BA: 00 00 00 00:00:12.574046 BB: 00 00 00 00:00:12.574047 BC: 00 00 00 00:00:12.574048 BD: 00 00 00 00:00:12.574050 BE: 00 00 00 00:00:12.574051 BF: 00 00 00 00:00:12.574052 C0: 00 00 00 00:00:12.574053 C1: 00 00 00 00:00:12.574054 C2: 00 00 00 00:00:12.574055 C3: 00 00 00 00:00:12.574056 C4: 00 00 00 00:00:12.574058 C5: 00 00 00 00:00:12.574059 C6: 00 00 00 00:00:12.574060 C7: 00 00 00 00:00:12.574062 C8: 00 00 00 00:00:12.574063 C9: 00 00 00 00:00:12.574064 CA: 00 00 00 00:00:12.574065 CB: 00 00 00 00:00:12.574067 CC: 00 00 00 00:00:12.574068 CD: 00 00 00 00:00:12.574070 CE: 00 00 00 00:00:12.574071 CF: 00 00 00 00:00:12.574072 D0: 00 00 00 00:00:12.574073 D1: 00 00 00 00:00:12.574074 D2: 00 00 00 00:00:12.574075 D3: 00 00 00 00:00:12.574077 D4: 00 00 00 00:00:12.574078 D5: 00 00 00 00:00:12.574079 D6: 00 00 00 00:00:12.574081 D7: 00 00 00 00:00:12.574082 D8: 00 00 00 00:00:12.574084 D9: 00 00 00 00:00:12.574085 DA: 00 00 00 00:00:12.574086 DB: 00 00 00 00:00:12.574087 DC: 00 00 00 00:00:12.574088 DD: 00 00 00 00:00:12.574090 DE: 00 00 00 00:00:12.574091 DF: 00 00 00 00:00:12.574093 E0: 00 00 00 00:00:12.574094 E1: 00 00 00 00:00:12.574095 E2: 00 00 00 00:00:12.574096 E3: 00 00 00 00:00:12.574097 E4: 00 00 00 00:00:12.574098 E5: 00 00 00 00:00:12.574099 E6: 00 00 00 00:00:12.574101 E7: 00 00 00 00:00:12.574102 E8: 00 00 00 00:00:12.574103 E9: 00 00 00 00:00:12.574105 EA: 00 00 00 00:00:12.574106 EB: 00 00 00 00:00:12.574108 EC: 00 00 00 00:00:12.574109 ED: 00 00 00 00:00:12.574110 EE: 00 00 00 00:00:12.574111 EF: 00 00 00 00:00:12.574113 F0: 00 00 00 00:00:12.574114 F1: 00 00 00 00:00:12.574115 F2: 00 00 00 00:00:12.574116 F3: 00 00 00 00:00:12.574118 F4: 00 00 00 00:00:12.574119 F5: 00 00 00 00:00:12.574120 F6: 00 00 00 00:00:12.574121 F7: 00 00 00 00:00:12.574123 F8: 00 00 00 00:00:12.574124 F9: 00 00 00 00:00:12.574125 FA: 00 00 00 00:00:12.574127 FB: 00 00 00 00:00:12.574129 FC: 00 00 00 00:00:12.574131 FD: 00 00 00 00:00:12.574132 FE: 00 00 00 00:00:12.574133 FF: 00 00 00 00:00:12.574135 !! 00:00:12.574136 !! {vgagr} 00:00:12.574136 !! 00:00:12.574137 VGA Graphics Controller (3CF): GR index 3CE:05 00:00:12.574138 GR00:00 GR01:00 GR02:00 GR03:00 GR04:00 GR05:50 GR06:07 GR07:0F GR08:FF 00:00:12.574144 !! 00:00:12.574145 !! {vgapl} 00:00:12.574146 !! 00:00:12.574147 read mode : 0 write mode: 0 00:00:12.574148 set/reset data: 00 S/R enable: 00 00:00:12.574149 color compare : 00 read map : 0 00:00:12.574150 rotate : 0 function : 0 00:00:12.574151 don't care : 0F bit mask : FF 00:00:12.574153 seq plane mask: 0F chain-4 : on 00:00:12.574154 !! 00:00:12.574154 !! {vgasr} 00:00:12.574155 !! 00:00:12.574156 VGA Sequencer (3C5): SR index 3C4:03 00:00:12.574157 SR00:03 SR01:00 SR02:0F SR03:00 SR04:0A SR05:00 SR06:00 SR07:01 00:00:12.574162 !! 00:00:12.574162 !! {vgatext} 00:00:12.574163 !! 00:00:12.574164 Not in text mode! 00:00:12.574165 !!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!!! 00:00:12.574216 emR3Debug: rc=VERR_PGM_PHYS_NOT_MMIO2 VM Startup Log: VM Trace Log: 2023-02-11 00:03:58 (3784923): Command: VBoxManage -q controlvm "boinc_983fd6eb6f46f97e" cpuexecutioncap 100 Exit Code: 0 Output: 2023-02-11 01:04:36 (3784923): Command: VBoxManage -q controlvm "boinc_983fd6eb6f46f97e" savestate Exit Code: 0 Output: 0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100% 2023-02-11 04:44:42 (3901641): Command: VBoxManage -q --version Exit Code: 0 Output: 6.1.26_Ubuntur145957 2023-02-11 04:44:42 (3901641): Command: VBoxManage -q list systemproperties Exit Code: 0 Output: API version: 6_1 Minimum guest RAM size: 4 Megabytes Maximum guest RAM size: 2097152 Megabytes Minimum video RAM size: 0 Megabytes Maximum video RAM size: 256 Megabytes Maximum guest monitor count: 64 Minimum guest CPU count: 1 Maximum guest CPU count: 32 Virtual disk limit (info): 2199022206976 Bytes Maximum Serial Port count: 4 Maximum Parallel Port count: 2 Maximum Boot Position: 4 Maximum PIIX3 Network Adapter count: 8 Maximum ICH9 Network Adapter count: 36 Maximum PIIX3 IDE Controllers: 1 Maximum ICH9 IDE Controllers: 1 Maximum IDE Port count: 2 Maximum Devices per IDE Port: 2 Maximum PIIX3 SATA Controllers: 1 Maximum ICH9 SATA Controllers: 8 Maximum SATA Port count: 30 Maximum Devices per SATA Port: 1 Maximum PIIX3 SCSI Controllers: 1 Maximum ICH9 SCSI Controllers: 8 Maximum SCSI Port count: 16 Maximum Devices per SCSI Port: 1 Maximum SAS PIIX3 Controllers: 1 Maximum SAS ICH9 Controllers: 8 Maximum SAS Port count: 255 Maximum Devices per SAS Port: 1 Maximum NVMe PIIX3 Controllers: 1 Maximum NVMe ICH9 Controllers: 8 Maximum NVMe Port count: 255 Maximum Devices per NVMe Port: 1 Maximum virtio-scsi PIIX3 Controllers: 1 Maximum virtio-scsi ICH9 Controllers: 8 Maximum virtio-scsi Port count: 256 Maximum Devices per virtio-scsi Port: 1 Maximum PIIX3 Floppy Controllers:1 Maximum ICH9 Floppy Controllers: 1 Maximum Floppy Port count: 1 Maximum Devices per Floppy Port: 2 Default machine folder: /var/lib/boinc-client/VirtualBox VMs Raw-mode Supported: no Exclusive HW virtualization use: on Default hard disk format: VDI VRDE auth library: VBoxAuth Webservice auth. library: VBoxAuth Remote desktop ExtPack: VNC Log history count: 3 Default frontend: Default audio driver: ALSA Autostart database path: Default Guest Additions ISO: Logging Level: all Proxy Mode: System Proxy URL: 2023-02-11 04:44:42 (3901641): Command: VBoxManage -q list hostinfo Exit Code: 0 Output: Host Information: Host time: 2023-02-11T03:44:42.941000000Z Processor online count: 16 Processor count: 16 Processor online core count: 8 Processor core count: 8 Processor supports HW virtualization: yes Processor supports PAE: yes Processor supports long mode: yes Processor supports nested paging: yes Processor supports unrestricted guest: yes Processor supports nested HW virtualization: no Processor#0 speed: 3400 MHz Processor#0 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#1 speed: 3400 MHz Processor#1 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#2 speed: 3400 MHz Processor#2 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#3 speed: 3400 MHz Processor#3 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#4 speed: 3400 MHz Processor#4 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#5 speed: 3400 MHz Processor#5 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#6 speed: 3400 MHz Processor#6 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#7 speed: 3400 MHz Processor#7 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#8 speed: 3400 MHz Processor#8 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#9 speed: 3400 MHz Processor#9 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#10 speed: 3400 MHz Processor#10 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#11 speed: 3400 MHz Processor#11 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#12 speed: 3400 MHz Processor#12 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#13 speed: 3400 MHz Processor#13 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#14 speed: 3400 MHz Processor#14 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Processor#15 speed: 3400 MHz Processor#15 description: Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz Memory size: 64278 MByte Memory available: 43851 MByte Operating system: Linux Operating system version: 5.13.0-52-generic 2023-02-11 04:44:43 (3901641): Command: VBoxManage -q showvminfo "boinc_983fd6eb6f46f97e" --machinereadable Exit Code: 0 Output: name="boinc_983fd6eb6f46f97e" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="56b183c4-07a9-4011-8ef8-ffce14bd5661" CfgFile="/var/lib/boinc-client/slots/18/boinc_983fd6eb6f46f97e/boinc_983fd6eb6f46f97e.vbox" SnapFldr="/var/lib/boinc-client/slots/18/boinc_983fd6eb6f46f97e/Snapshots" LogFldr="/var/lib/boinc-client/slots/18/boinc_983fd6eb6f46f97e/Logs" hardwareuuid="56b183c4-07a9-4011-8ef8-ffce14bd5661" memory=15336 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" cpu-profile="host" chipset="piix3" firmware="BIOS" cpus=16 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" nested-hw-virt="off" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 rtcuseutc="on" hwvirtex="on" nestedpaging="on" largepages="off" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="saved" VMStateChangeTime="2023-02-11T00:04:35.665000000" VMStateFile="/var/lib/boinc-client/slots/18/boinc_983fd6eb6f46f97e/Snapshots/2023-02-11T00-03-55-339275000Z.sav" graphicscontroller="vboxvga" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" vmprocpriority="default" storagecontrollername0="Hard Disk Controller" storagecontrollertype0="IntelAhci" storagecontrollerinstance0="0" storagecontrollermaxportcount0="30" storagecontrollerportcount0="3" storagecontrollerbootable0="on" "Hard Disk Controller-0-0"="/var/lib/boinc-client/slots/18/boinc_983fd6eb6f46f97e/Snapshots/{574ba55c-3629-4a3b-a3fd-f27069199d0d}.vdi" "Hard Disk Controller-ImageUUID-0-0"="574ba55c-3629-4a3b-a3fd-f27069199d0d" "Hard Disk Controller-1-0"="none" "Hard Disk Controller-2-0"="none" natnet1="nat" macaddress1="08002744619F" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp_52911_80,tcp,127.0.0.1,52911,,80" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="none" audio_out="off" audio_in="off" clipboard="disabled" draganddrop="disabled" vrde="off" usb="off" ehci="off" xhci="off" BandwidthGroup0=boinc_983fd6eb6f46f97e_net,Network,1099511627776 SharedFolderNameMachineMapping1="shared" SharedFolderPathMachineMapping1="/var/lib/boinc-client/slots/18/shared" videocap="off" videocapaudio="off" capturescreens="" capturefilename="/var/lib/boinc-client/slots/18/boinc_983fd6eb6f46f97e/boinc_983fd6eb6f46f97e.webm" captureres="1024x768" capturevideorate=512 capturevideofps=25 captureopts="" description="CMS_2949884_1675527892.300633_0" GuestMemoryBalloon=0 2023-02-11 04:44:55 (3901641): Command: VBoxManage -q startvm "boinc_983fd6eb6f46f97e" --type headless Exit Code: 0 Output: Waiting for VM "boinc_983fd6eb6f46f97e" to power on... VM "boinc_983fd6eb6f46f97e" has been successfully started. 2023-02-12 04:50:26 (308095): Detected: vboxwrapper 26206 2023-02-12 04:50:26 (308095): Detected: BOINC client v7.16.11 2023-02-12 04:50:26 (308095): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-12 04:50:26 (308095): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-12 04:50:26 (308095): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-12 04:50:28 (308095): Successfully started VM. (PID = '308229') 2023-02-12 04:50:28 (308095): Reporting VM Process ID to BOINC. 2023-02-12 04:50:28 (308095): Guest Log: BIOS: VirtualBox 6.1.25 2023-02-12 04:50:28 (308095): Guest Log: CPUID EDX: 0x178bfbff 2023-02-12 04:50:28 (308095): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-02-12 04:50:28 (308095): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-02-12 04:50:28 (308095): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-12 04:50:28 (308095): Detected: Web Application Enabled (http://localhost:52911) 2023-02-12 04:50:28 (308095): Status Report: Job Duration: '64800.000000' 2023-02-12 04:50:28 (308095): Status Report: Elapsed Time: '10954.000000' 2023-02-12 04:50:28 (308095): Status Report: CPU Time: '12585.480000' 2023-02-12 04:50:28 (308095): Preference change detected 2023-02-12 04:50:28 (308095): Setting CPU throttle for VM. (100%) 2023-02-12 04:50:28 (308095): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-12 04:50:30 (308095): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-02-12 04:50:30 (308095): Guest Log: BIOS: Booting from Hard Disk... 2023-02-12 04:50:33 (308095): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-02-12 04:50:33 (308095): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-02-12 04:51:16 (308095): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-02-12 04:51:16 (308095): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-02-12 04:51:20 (308095): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.000367 main Log opened 2023-02-12T03:51:20.624348000Z 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.000499 main OS Product: Linux 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.000542 main OS Release: 4.14.232-19.cernvm.x86_64 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.000577 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.000609 main Executable: /usr/sbin/VBoxService 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.000610 main Process ID: 2726 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.000611 main Package type: LINUX_64BITS_GENERIC 2023-02-12 04:51:20 (308095): Guest Log: 00:00:00.001729 main 5.2.6 r120293 started. Verbose level = 0 2023-02-12 04:51:46 (308095): Guest Log: [INFO] Mounting the shared directory 2023-02-12 04:51:47 (308095): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-02-12 04:51:47 (308095): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-02-12 04:51:47 (308095): Guest Log: [INFO] Testing connection to cern.ch 2023-02-12 04:51:48 (308095): Guest Log: [INFO] Testing connection to VCCS 2023-02-12 04:51:48 (308095): Guest Log: [INFO] Testing connection to HTCondor 2023-02-12 04:51:49 (308095): Guest Log: [INFO] Testing connection to WMAgent 2023-02-12 04:51:49 (308095): Guest Log: [INFO] Testing connection to EOSCMS 2023-02-12 04:51:50 (308095): Guest Log: [INFO] Testing connection to CMS-Factory 2023-02-12 04:51:50 (308095): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-02-12 04:51:51 (308095): Guest Log: [INFO] Testing connection to Frontier 2023-02-12 04:51:52 (308095): Guest Log: [INFO] Could not find a local HTTP proxy 2023-02-12 04:51:52 (308095): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-02-12 04:51:53 (308095): Guest Log: [INFO] This makes the application less efficient 2023-02-12 04:51:53 (308095): Guest Log: [INFO] It also puts higher load on the project servers 2023-02-12 04:51:53 (308095): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-02-12 04:51:54 (308095): Guest Log: [INFO] Advice can be found in the project forum 2023-02-12 04:51:54 (308095): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-02-12 04:52:06 (308095): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-02-12 04:52:10 (308095): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-02-12 04:52:10 (308095): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-02-12 04:52:11 (308095): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-02-12 04:52:13 (308095): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-02-12 04:52:15 (308095): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-02-12 04:52:15 (308095): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2023-02-12 04:52:16 (308095): Guest Log: [INFO] Environment HTTP proxy: not set 2023-02-12 04:52:16 (308095): Guest Log: [INFO] Reading volunteer information 2023-02-12 04:52:21 (308095): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-02-12 04:52:23 (308095): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-02-12 04:52:25 (308095): Guest Log: [INFO] CMS application starting. Check log files. 2023-02-12 04:52:26 (308095): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-02-12 04:52:27 (308095): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-02-12 06:29:28 (308095): Status Report: Job Duration: '64800.000000' 2023-02-12 06:29:28 (308095): Status Report: Elapsed Time: '16954.042748' 2023-02-12 06:29:28 (308095): Status Report: CPU Time: '19941.100000' 2023-02-12 08:08:29 (308095): Status Report: Job Duration: '64800.000000' 2023-02-12 08:08:29 (308095): Status Report: Elapsed Time: '22954.042748' 2023-02-12 08:08:29 (308095): Status Report: CPU Time: '26891.650000' 2023-02-12 09:47:29 (308095): Status Report: Job Duration: '64800.000000' 2023-02-12 09:47:29 (308095): Status Report: Elapsed Time: '28954.042748' 2023-02-12 09:47:29 (308095): Status Report: CPU Time: '33800.220000' 2023-02-12 11:26:30 (308095): Status Report: Job Duration: '64800.000000' 2023-02-12 11:26:30 (308095): Status Report: Elapsed Time: '34954.042748' 2023-02-12 11:26:30 (308095): Status Report: CPU Time: '40798.710000' 2023-02-12 13:05:30 (308095): Status Report: Job Duration: '64800.000000' 2023-02-12 13:05:30 (308095): Status Report: Elapsed Time: '40954.042748' 2023-02-12 13:05:30 (308095): Status Report: CPU Time: '47688.300000' 2023-02-12 13:10:20 (308095): Stopping VM. 2023-02-12 13:25:52 (530924): Detected: vboxwrapper 26206 2023-02-12 13:25:52 (530924): Detected: BOINC client v7.16.11 2023-02-12 13:25:52 (530924): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-12 13:25:52 (530924): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-12 13:25:52 (530924): Guest Log: BIOS: VirtualBox 6.1.25 2023-02-12 13:25:52 (530924): Guest Log: CPUID EDX: 0x178bfbff 2023-02-12 13:25:52 (530924): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-02-12 13:25:52 (530924): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-02-12 13:25:52 (530924): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-02-12 13:25:52 (530924): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-02-12 13:25:52 (530924): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-02-12 13:25:52 (530924): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-02-12 13:25:52 (530924): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-02-12 13:25:52 (530924): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.000367 main Log opened 2023-02-12T03:51:20.624348000Z 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.000499 main OS Product: Linux 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.000542 main OS Release: 4.14.232-19.cernvm.x86_64 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.000577 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.000609 main Executable: /usr/sbin/VBoxService 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.000610 main Process ID: 2726 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.000611 main Package type: LINUX_64BITS_GENERIC 2023-02-12 13:25:52 (530924): Guest Log: 00:00:00.001729 main 5.2.6 r120293 started. Verbose level = 0 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Mounting the shared directory 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to cern.ch 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to VCCS 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to HTCondor 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to WMAgent 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to EOSCMS 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to CMS-Factory 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Testing connection to Frontier 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Could not find a local HTTP proxy 2023-02-12 13:25:52 (530924): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-02-12 13:25:52 (530924): Guest Log: [INFO] This makes the application less efficient 2023-02-12 13:25:52 (530924): Guest Log: [INFO] It also puts higher load on the project servers 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Advice can be found in the project forum 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-02-12 13:25:52 (530924): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Environment HTTP proxy: not set 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Reading volunteer information 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-02-12 13:25:52 (530924): Guest Log: [INFO] CMS application starting. Check log files. 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-02-12 13:25:52 (530924): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-02-12 13:25:52 (530924): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-12 13:25:55 (530924): Successfully started VM. (PID = '531004') 2023-02-12 13:25:55 (530924): Reporting VM Process ID to BOINC. 2023-02-12 13:25:55 (530924): Guest Log: BIOS: VirtualBox 6.1.25 2023-02-12 13:25:55 (530924): Guest Log: CPUID EDX: 0x178bfbff 2023-02-12 13:25:55 (530924): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-02-12 13:25:55 (530924): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-02-12 13:25:55 (530924): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-12 13:25:55 (530924): Detected: Web Application Enabled (http://localhost:52911) 2023-02-12 13:25:55 (530924): Status Report: Job Duration: '64800.000000' 2023-02-12 13:25:55 (530924): Status Report: Elapsed Time: '41247.042748' 2023-02-12 13:25:55 (530924): Status Report: CPU Time: '48024.980000' 2023-02-12 13:25:55 (530924): Preference change detected 2023-02-12 13:25:55 (530924): Setting CPU throttle for VM. (100%) 2023-02-12 13:25:55 (530924): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-12 13:25:57 (530924): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-02-12 13:25:57 (530924): Guest Log: BIOS: Booting from Hard Disk... 2023-02-12 13:26:12 (530924): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-02-12 13:26:12 (530924): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-02-12 13:27:03 (530924): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-02-12 13:27:03 (530924): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-02-12 13:27:19 (530924): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.000136 main Log opened 2023-02-12T12:27:19.474211000Z 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.000344 main OS Product: Linux 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.000392 main OS Release: 4.14.232-19.cernvm.x86_64 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.000428 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.000465 main Executable: /usr/sbin/VBoxService 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.000466 main Process ID: 2723 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.000467 main Package type: LINUX_64BITS_GENERIC 2023-02-12 13:27:19 (530924): Guest Log: 00:00:00.003475 main 5.2.6 r120293 started. Verbose level = 0 2023-02-12 13:27:44 (530924): Guest Log: [INFO] Mounting the shared directory 2023-02-12 13:27:45 (530924): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-02-12 13:27:45 (530924): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-02-12 13:27:45 (530924): Guest Log: [INFO] Testing connection to cern.ch 2023-02-12 13:27:45 (530924): Guest Log: [INFO] Testing connection to VCCS 2023-02-12 13:27:46 (530924): Guest Log: [INFO] Testing connection to HTCondor 2023-02-12 13:27:46 (530924): Guest Log: [INFO] Testing connection to WMAgent 2023-02-12 13:27:47 (530924): Guest Log: [INFO] Testing connection to EOSCMS 2023-02-12 13:27:47 (530924): Guest Log: [INFO] Testing connection to CMS-Factory 2023-02-12 13:27:48 (530924): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-02-12 13:27:48 (530924): Guest Log: [INFO] Testing connection to Frontier 2023-02-12 13:27:49 (530924): Guest Log: [INFO] Could not find a local HTTP proxy 2023-02-12 13:27:49 (530924): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-02-12 13:27:50 (530924): Guest Log: [INFO] This makes the application less efficient 2023-02-12 13:27:50 (530924): Guest Log: [INFO] It also puts higher load on the project servers 2023-02-12 13:27:50 (530924): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-02-12 13:27:50 (530924): Guest Log: [INFO] Advice can be found in the project forum 2023-02-12 13:27:51 (530924): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-02-12 13:28:03 (530924): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-02-12 13:28:06 (530924): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-02-12 13:28:06 (530924): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-02-12 13:28:07 (530924): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-02-12 13:28:08 (530924): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-02-12 13:28:10 (530924): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-02-12 13:28:11 (530924): Guest Log: [INFO] 2.7.2.0 http://s1bnl-cvmfs.openhtc.io DIRECT 2023-02-12 13:28:11 (530924): Guest Log: [INFO] Environment HTTP proxy: not set 2023-02-12 13:28:11 (530924): Guest Log: [INFO] Reading volunteer information 2023-02-12 13:28:18 (530924): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-02-12 13:28:19 (530924): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-02-12 13:28:21 (530924): Guest Log: [INFO] CMS application starting. Check log files. 2023-02-12 13:28:21 (530924): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-02-12 13:28:22 (530924): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-02-12 14:26:24 (530924): Stopping VM. 2023-02-12 14:27:16 (530924): Successfully stopped VM. 2023-02-12 15:15:31 (576913): Detected: vboxwrapper 26206 2023-02-12 15:15:31 (576913): Detected: BOINC client v7.16.11 2023-02-12 15:15:31 (576913): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-12 15:15:31 (576913): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-12 15:15:32 (576913): Guest Log: BIOS: VirtualBox 6.1.25 2023-02-12 15:15:32 (576913): Guest Log: CPUID EDX: 0x178bfbff 2023-02-12 15:15:32 (576913): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-02-12 15:15:32 (576913): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-02-12 15:15:32 (576913): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-02-12 15:15:32 (576913): Guest Log: BIOS: Booting from Hard Disk... 2023-02-12 15:15:32 (576913): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-02-12 15:15:32 (576913): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-02-12 15:15:32 (576913): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-02-12 15:15:32 (576913): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-02-12 15:15:32 (576913): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.000136 main Log opened 2023-02-12T12:27:19.474211000Z 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.000344 main OS Product: Linux 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.000392 main OS Release: 4.14.232-19.cernvm.x86_64 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.000428 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.000465 main Executable: /usr/sbin/VBoxService 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.000466 main Process ID: 2723 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.000467 main Package type: LINUX_64BITS_GENERIC 2023-02-12 15:15:32 (576913): Guest Log: 00:00:00.003475 main 5.2.6 r120293 started. Verbose level = 0 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Mounting the shared directory 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to cern.ch 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to VCCS 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to HTCondor 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to WMAgent 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to EOSCMS 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to CMS-Factory 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Testing connection to Frontier 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Could not find a local HTTP proxy 2023-02-12 15:15:32 (576913): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-02-12 15:15:32 (576913): Guest Log: [INFO] This makes the application less efficient 2023-02-12 15:15:32 (576913): Guest Log: [INFO] It also puts higher load on the project servers 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Advice can be found in the project forum 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-02-12 15:15:32 (576913): Guest Log: [INFO] 2.7.2.0 http://s1bnl-cvmfs.openhtc.io DIRECT 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Environment HTTP proxy: not set 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Reading volunteer information 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-02-12 15:15:32 (576913): Guest Log: [INFO] CMS application starting. Check log files. 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-02-12 15:15:32 (576913): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-02-12 15:15:32 (576913): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-12 15:15:46 (576913): Successfully started VM. (PID = '576989') 2023-02-12 15:15:46 (576913): Reporting VM Process ID to BOINC. 2023-02-12 15:15:46 (576913): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-12 15:15:46 (576913): Detected: Web Application Enabled (http://localhost:52911) 2023-02-12 15:15:46 (576913): Status Report: Job Duration: '64800.000000' 2023-02-12 15:15:46 (576913): Status Report: Elapsed Time: '44912.042748' 2023-02-12 15:15:46 (576913): Status Report: CPU Time: '52738.890000' 2023-02-12 15:15:46 (576913): Preference change detected 2023-02-12 15:15:46 (576913): Setting CPU throttle for VM. (100%) 2023-02-12 15:15:47 (576913): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-12 15:15:48 (576913): Guest Log: 00:59:11.446004 timesync vgsvcTimeSyncWorker: Radical host time change: 2 971 530 000 000ns (HostNow=1 676 211 348 592 000 000 ns HostLast=1 676 208 377 062 000 000 ns) 2023-02-12 15:15:58 (576913): Guest Log: 00:59:21.452416 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 967 736 305 000ns (GuestNow=1 676 211 358 627 350 000 ns GuestLast=1 676 208 390 891 045 000 ns fSetTimeLastLoop=true ) 2023-02-12 16:15:36 (576913): Stopping VM. 2023-02-12 16:16:19 (576913): Successfully stopped VM. 2023-02-12 16:48:23 (616849): Detected: vboxwrapper 26206 2023-02-12 16:48:23 (616849): Detected: BOINC client v7.16.11 2023-02-12 16:48:24 (616849): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-12 16:48:24 (616849): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-12 16:48:24 (616849): Guest Log: 00:59:11.446004 timesync vgsvcTimeSyncWorker: Radical host time change: 2 971 530 000 000ns (HostNow=1 676 211 348 592 000 000 ns HostLast=1 676 208 377 062 000 000 ns) 2023-02-12 16:48:24 (616849): Guest Log: 00:59:21.452416 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 967 736 305 000ns (GuestNow=1 676 211 358 627 350 000 ns GuestLast=1 676 208 390 891 045 000 ns fSetTimeLastLoop=true ) 2023-02-12 16:48:24 (616849): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-12 16:48:42 (616849): Successfully started VM. (PID = '616947') 2023-02-12 16:48:42 (616849): Reporting VM Process ID to BOINC. 2023-02-12 16:48:42 (616849): Guest Log: 01:59:04.072545 timesync vgsvcTimeSyncWorker: Radical host time change: 1 994 669 000 000ns (HostNow=1 676 216 921 952 000 000 ns HostLast=1 676 214 927 283 000 000 ns) 2023-02-12 16:48:42 (616849): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-12 16:48:42 (616849): Detected: Web Application Enabled (http://localhost:52911) 2023-02-12 16:48:42 (616849): Status Report: Job Duration: '64800.000000' 2023-02-12 16:48:42 (616849): Status Report: Elapsed Time: '48538.042748' 2023-02-12 16:48:42 (616849): Status Report: CPU Time: '56942.070000' 2023-02-12 16:48:42 (616849): Preference change detected 2023-02-12 16:48:42 (616849): Setting CPU throttle for VM. (100%) 2023-02-12 16:48:43 (616849): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-12 16:48:52 (616849): Guest Log: 01:59:14.085559 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 990 933 296 000ns (GuestNow=1 676 216 932 072 868 000 ns GuestLast=1 676 214 941 139 572 000 ns fSetTimeLastLoop=true ) 2023-02-12 17:48:49 (616849): Stopping VM. 2023-02-12 17:49:17 (616849): Successfully stopped VM. 2023-02-12 19:27:30 (680201): Detected: vboxwrapper 26206 2023-02-12 19:27:30 (680201): Detected: BOINC client v7.16.11 2023-02-12 19:27:31 (680201): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-12 19:27:31 (680201): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-12 19:27:31 (680201): Guest Log: 01:59:04.072545 timesync vgsvcTimeSyncWorker: Radical host time change: 1 994 669 000 000ns (HostNow=1 676 216 921 952 000 000 ns HostLast=1 676 214 927 283 000 000 ns) 2023-02-12 19:27:31 (680201): Guest Log: 01:59:14.085559 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 990 933 296 000ns (GuestNow=1 676 216 932 072 868 000 ns GuestLast=1 676 214 941 139 572 000 ns fSetTimeLastLoop=true ) 2023-02-12 19:27:31 (680201): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-12 19:27:44 (680201): Successfully started VM. (PID = '680301') 2023-02-12 19:27:44 (680201): Reporting VM Process ID to BOINC. 2023-02-12 19:27:44 (680201): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-12 19:27:44 (680201): Detected: Web Application Enabled (http://localhost:52911) 2023-02-12 19:27:44 (680201): Status Report: Job Duration: '64800.000000' 2023-02-12 19:27:44 (680201): Status Report: Elapsed Time: '52180.042748' 2023-02-12 19:27:44 (680201): Status Report: CPU Time: '61092.350000' 2023-02-12 19:27:44 (680201): Preference change detected 2023-02-12 19:27:44 (680201): Setting CPU throttle for VM. (100%) 2023-02-12 19:27:44 (680201): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-12 19:27:46 (680201): Guest Log: 02:59:17.398283 timesync vgsvcTimeSyncWorker: Radical host time change: 5 944 156 000 000ns (HostNow=1 676 226 465 669 000 000 ns HostLast=1 676 220 521 513 000 000 ns) 2023-02-12 19:27:56 (680201): Guest Log: 02:59:27.404922 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 940 291 670 000ns (GuestNow=1 676 226 475 676 447 000 ns GuestLast=1 676 220 535 384 777 000 ns fSetTimeLastLoop=true ) 2023-02-12 20:27:51 (680201): Stopping VM. 2023-02-12 20:28:46 (680201): Successfully stopped VM. 2023-02-12 22:21:21 (754009): Detected: vboxwrapper 26206 2023-02-12 22:21:21 (754009): Detected: BOINC client v7.16.11 2023-02-12 22:21:22 (754009): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-12 22:21:22 (754009): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-12 22:21:22 (754009): Guest Log: 02:59:17.398283 timesync vgsvcTimeSyncWorker: Radical host time change: 5 944 156 000 000ns (HostNow=1 676 226 465 669 000 000 ns HostLast=1 676 220 521 513 000 000 ns) 2023-02-12 22:21:22 (754009): Guest Log: 02:59:27.404922 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 940 291 670 000ns (GuestNow=1 676 226 475 676 447 000 ns GuestLast=1 676 220 535 384 777 000 ns fSetTimeLastLoop=true ) 2023-02-12 22:21:22 (754009): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-12 22:21:35 (754009): Successfully started VM. (PID = '754107') 2023-02-12 22:21:35 (754009): Reporting VM Process ID to BOINC. 2023-02-12 22:21:35 (754009): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-12 22:21:35 (754009): Detected: Web Application Enabled (http://localhost:52911) 2023-02-12 22:21:35 (754009): Status Report: Job Duration: '64800.000000' 2023-02-12 22:21:35 (754009): Status Report: Elapsed Time: '55823.042748' 2023-02-12 22:21:35 (754009): Status Report: CPU Time: '64689.150000' 2023-02-12 22:21:35 (754009): Preference change detected 2023-02-12 22:21:35 (754009): Setting CPU throttle for VM. (100%) 2023-02-12 22:21:35 (754009): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-12 22:21:37 (754009): Guest Log: 03:59:30.357432 timesync vgsvcTimeSyncWorker: Radical host time change: 6 832 905 000 000ns (HostNow=1 676 236 897 667 000 000 ns HostLast=1 676 230 064 762 000 000 ns) 2023-02-12 22:21:47 (754009): Guest Log: 03:59:40.365059 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 829 055 328 000ns (GuestNow=1 676 236 907 679 432 000 ns GuestLast=1 676 230 078 624 104 000 ns fSetTimeLastLoop=true ) 2023-02-12 23:22:10 (754009): Stopping VM. 2023-02-13 01:16:26 (827597): Detected: vboxwrapper 26206 2023-02-13 01:16:26 (827597): Detected: BOINC client v7.16.11 2023-02-13 01:16:26 (827597): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-13 01:16:26 (827597): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-13 01:16:27 (827597): Guest Log: 03:59:30.357432 timesync vgsvcTimeSyncWorker: Radical host time change: 6 832 905 000 000ns (HostNow=1 676 236 897 667 000 000 ns HostLast=1 676 230 064 762 000 000 ns) 2023-02-13 01:16:27 (827597): Guest Log: 03:59:40.365059 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 829 055 328 000ns (GuestNow=1 676 236 907 679 432 000 ns GuestLast=1 676 230 078 624 104 000 ns fSetTimeLastLoop=true ) 2023-02-13 01:16:27 (827597): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-13 01:16:28 (827597): Successfully started VM. (PID = '827695') 2023-02-13 01:16:28 (827597): Reporting VM Process ID to BOINC. 2023-02-13 01:16:28 (827597): Guest Log: BIOS: VirtualBox 6.1.25 2023-02-13 01:16:28 (827597): Guest Log: CPUID EDX: 0x178bfbff 2023-02-13 01:16:28 (827597): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-02-13 01:16:28 (827597): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-02-13 01:16:28 (827597): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-13 01:16:28 (827597): Detected: Web Application Enabled (http://localhost:52911) 2023-02-13 01:16:28 (827597): Status Report: Job Duration: '64800.000000' 2023-02-13 01:16:28 (827597): Status Report: Elapsed Time: '59494.042748' 2023-02-13 01:16:28 (827597): Status Report: CPU Time: '68944.690000' 2023-02-13 01:16:28 (827597): Preference change detected 2023-02-13 01:16:28 (827597): Setting CPU throttle for VM. (100%) 2023-02-13 01:16:28 (827597): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-13 01:16:30 (827597): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-02-13 01:16:30 (827597): Guest Log: BIOS: Booting from Hard Disk... 2023-02-13 01:16:33 (827597): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-02-13 01:16:33 (827597): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-02-13 01:17:21 (827597): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-02-13 01:17:21 (827597): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-02-13 01:17:24 (827597): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.000159 main Log opened 2023-02-13T00:17:24.358048000Z 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.000361 main OS Product: Linux 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.000411 main OS Release: 4.14.232-19.cernvm.x86_64 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.000450 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.000530 main Executable: /usr/sbin/VBoxService 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.000532 main Process ID: 2707 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.000533 main Package type: LINUX_64BITS_GENERIC 2023-02-13 01:17:24 (827597): Guest Log: 00:00:00.003282 main 5.2.6 r120293 started. Verbose level = 0 2023-02-13 01:17:49 (827597): Guest Log: [INFO] Mounting the shared directory 2023-02-13 01:17:49 (827597): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-02-13 01:17:49 (827597): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-02-13 01:17:50 (827597): Guest Log: [INFO] Testing connection to cern.ch 2023-02-13 01:17:50 (827597): Guest Log: [INFO] Testing connection to VCCS 2023-02-13 01:17:50 (827597): Guest Log: [INFO] Testing connection to HTCondor 2023-02-13 01:17:51 (827597): Guest Log: [INFO] Testing connection to WMAgent 2023-02-13 01:17:52 (827597): Guest Log: [INFO] Testing connection to EOSCMS 2023-02-13 01:17:52 (827597): Guest Log: [INFO] Testing connection to CMS-Factory 2023-02-13 01:17:53 (827597): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-02-13 01:17:53 (827597): Guest Log: [INFO] Testing connection to Frontier 2023-02-13 01:17:54 (827597): Guest Log: [INFO] Could not find a local HTTP proxy 2023-02-13 01:17:55 (827597): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-02-13 01:17:55 (827597): Guest Log: [INFO] This makes the application less efficient 2023-02-13 01:17:55 (827597): Guest Log: [INFO] It also puts higher load on the project servers 2023-02-13 01:17:55 (827597): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-02-13 01:17:56 (827597): Guest Log: [INFO] Advice can be found in the project forum 2023-02-13 01:17:56 (827597): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-02-13 01:18:08 (827597): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-02-13 01:18:13 (827597): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-02-13 01:18:13 (827597): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-02-13 01:18:13 (827597): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-02-13 01:18:16 (827597): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-02-13 01:18:18 (827597): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-02-13 01:18:19 (827597): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2023-02-13 01:18:19 (827597): Guest Log: [INFO] Environment HTTP proxy: not set 2023-02-13 01:18:19 (827597): Guest Log: [INFO] Reading volunteer information 2023-02-13 01:18:25 (827597): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-02-13 01:18:26 (827597): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-02-13 01:18:27 (827597): Guest Log: [INFO] CMS application starting. Check log files. 2023-02-13 01:18:28 (827597): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-02-13 01:18:29 (827597): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-02-13 02:17:02 (827597): Stopping VM. 2023-02-13 02:17:44 (827597): Successfully stopped VM. 2023-02-13 03:02:44 (867190): Detected: vboxwrapper 26206 2023-02-13 03:02:44 (867190): Detected: BOINC client v7.16.11 2023-02-13 03:02:44 (867190): Detected: VirtualBox VboxManage Interface (Version: 6.1.26) 2023-02-13 03:02:44 (867190): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2023-02-13 03:02:44 (867190): Guest Log: BIOS: VirtualBox 6.1.25 2023-02-13 03:02:44 (867190): Guest Log: CPUID EDX: 0x178bfbff 2023-02-13 03:02:44 (867190): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2023-02-13 03:02:44 (867190): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2023-02-13 03:02:44 (867190): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2023-02-13 03:02:44 (867190): Guest Log: BIOS: Booting from Hard Disk... 2023-02-13 03:02:44 (867190): Guest Log: BIOS: KBD: unsupported int 16h function 03 2023-02-13 03:02:44 (867190): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2023-02-13 03:02:44 (867190): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2023-02-13 03:02:44 (867190): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2023-02-13 03:02:44 (867190): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.000159 main Log opened 2023-02-13T00:17:24.358048000Z 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.000361 main OS Product: Linux 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.000411 main OS Release: 4.14.232-19.cernvm.x86_64 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.000450 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.000530 main Executable: /usr/sbin/VBoxService 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.000532 main Process ID: 2707 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.000533 main Package type: LINUX_64BITS_GENERIC 2023-02-13 03:02:44 (867190): Guest Log: 00:00:00.003282 main 5.2.6 r120293 started. Verbose level = 0 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Mounting the shared directory 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to cern.ch 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to VCCS 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to HTCondor 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to WMAgent 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to EOSCMS 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to CMS-Factory 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to CMS-Frontier 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Testing connection to Frontier 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Could not find a local HTTP proxy 2023-02-13 03:02:44 (867190): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2023-02-13 03:02:44 (867190): Guest Log: [INFO] This makes the application less efficient 2023-02-13 03:02:44 (867190): Guest Log: [INFO] It also puts higher load on the project servers 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Advice can be found in the project forum 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2023-02-13 03:02:44 (867190): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Environment HTTP proxy: not set 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Reading volunteer information 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2023-02-13 03:02:44 (867190): Guest Log: [INFO] CMS application starting. Check log files. 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Requesting an idtoken from LHC@home 2023-02-13 03:02:44 (867190): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2023-02-13 03:02:44 (867190): Starting VM using VBoxManage interface. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-13 03:03:03 (867190): Successfully started VM. (PID = '867290') 2023-02-13 03:03:03 (867190): Reporting VM Process ID to BOINC. 2023-02-13 03:03:03 (867190): VM state change detected. (old = 'poweredoff', new = 'running') 2023-02-13 03:03:03 (867190): Detected: Web Application Enabled (http://localhost:52911) 2023-02-13 03:03:03 (867190): Status Report: Job Duration: '64800.000000' 2023-02-13 03:03:03 (867190): Status Report: Elapsed Time: '63164.042748' 2023-02-13 03:03:03 (867190): Status Report: CPU Time: '73733.280000' 2023-02-13 03:03:03 (867190): Preference change detected 2023-02-13 03:03:03 (867190): Setting CPU throttle for VM. (100%) 2023-02-13 03:03:05 (867190): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2023-02-13 03:03:12 (867190): Guest Log: 00:59:51.880817 timesync vgsvcTimeSyncWorker: Radical host time change: 2 768 968 000 000ns (HostNow=1 676 253 791 239 000 000 ns HostLast=1 676 251 022 271 000 000 ns) 2023-02-13 03:03:22 (867190): Guest Log: 01:00:01.887854 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 765 163 710 000ns (GuestNow=1 676 253 801 322 844 000 ns GuestLast=1 676 251 036 159 134 000 ns fSetTimeLastLoop=true ) 2023-02-13 03:30:04 (867190): Powering off VM. 2023-02-13 03:30:04 (867190): Successfully stopped VM. 2023-02-13 03:30:04 (867190): Deregistering VM. (boinc_983fd6eb6f46f97e, slot#18) 2023-02-13 03:30:04 (867190): Removing network bandwidth throttle group from VM. 2023-02-13 03:30:04 (867190): Removing VM from VirtualBox. 03:30:09 (867190): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN