There appears to be some exceptions in the middlewared.log but to me its a foreign language.
Code:
[2018/05/24 17:15:20] (DEBUG) ServiceService._simplecmd():255 - Calling: restart(system)
Exception in thread Thread-175:
Traceback (most recent call last):
File "/usr/local/lib/python3.6/threading.py", line 916, in _bootstrap_inner
self.run()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 543, in run
self.register()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 540, in register
self._register(self.hostname, self.regtype, self.port)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 530, in _register
pybonjour.DNSServiceProcessResult(ref)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 895, in DNSServiceProcessResult
_DNSServiceProcessResult(sdRef)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 286, in _errcheck
raise cls(result)
pybonjour.BonjourError: (-65563, 'unknown')
Exception in thread Thread-177:
Traceback (most recent call last):
File "/usr/local/lib/python3.6/threading.py", line 916, in _bootstrap_inner
self.run()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 543, in run
self.register()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 540, in register
self._register(self.hostname, self.regtype, self.port)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 530, in _register
pybonjour.DNSServiceProcessResult(ref)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 895, in DNSServiceProcessResult
_DNSServiceProcessResult(sdRef)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 286, in _errcheck
raise cls(result)
pybonjour.BonjourError: (-65563, 'unknown')
Exception in thread Thread-179:
Traceback (most recent call last):
File "/usr/local/lib/python3.6/threading.py", line 916, in _bootstrap_inner
self.run()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 543, in run
self.register()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 540, in register
self._register(self.hostname, self.regtype, self.port)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 530, in _register
pybonjour.DNSServiceProcessResult(ref)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 895, in DNSServiceProcessResult
_DNSServiceProcessResult(sdRef)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 286, in _errcheck
raise cls(result)
pybonjour.BonjourError: (-65563, 'unknown')
Exception in thread Thread-176:
Traceback (most recent call last):
File "/usr/local/lib/python3.6/threading.py", line 916, in _bootstrap_inner
self.run()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 543, in run
self.register()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 540, in register
self._register(self.hostname, self.regtype, self.port)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 530, in _register
pybonjour.DNSServiceProcessResult(ref)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 895, in DNSServiceProcessResult
_DNSServiceProcessResult(sdRef)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 286, in _errcheck
raise cls(result)
pybonjour.BonjourError: (-65563, 'unknown')
[2018/05/24 17:16:19] (WARNING) middlewared.devd_loop():70 - devd pipe error, retrying...
Traceback (most recent call last):
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/device.py", line 68, in devd_loop
await devd_listen(middleware)
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 109, in __next__
return self.gen.send(None)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/device.py", line 76, in devd_listen
s.connect(DEVD_SOCKETFILE)
ConnectionRefusedError: [Errno 61] Connection refused
[2018/05/24 17:16:20] (WARNING) middlewared.devd_loop():70 - devd pipe error, retrying...
Traceback (most recent call last):
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/device.py", line 68, in devd_loop
await devd_listen(middleware)
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 109, in __next__
return self.gen.send(None)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/device.py", line 76, in devd_listen
s.connect(DEVD_SOCKETFILE)
ConnectionRefusedError: [Errno 61] Connection refused
[2018/05/24 17:16:21] (WARNING) middlewared.devd_loop():70 - devd pipe error, retrying...
Traceback (most recent call last):
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/device.py", line 68, in devd_loop
await devd_listen(middleware)
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 109, in __next__
return self.gen.send(None)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/device.py", line 76, in devd_listen
s.connect(DEVD_SOCKETFILE)
ConnectionRefusedError: [Errno 61] Connection refused
[2018/05/24 17:16:22] (INFO) middlewared.terminate():1047 - Terminating
[2018/05/24 17:16:22] (INFO) middlewared.terminate():1047 - Terminating
[2018/05/24 17:18:16] (DEBUG) raven.base.Client.set_dsn():243 - Configuring Raven for host: <raven.conf.remote.RemoteConfig object at 0x80ba1af60>
[2018/05/24 17:18:16] (DEBUG) middlewared.__plugins_load():671 - Loading plugins from /usr/local/lib/python3.6/site-packages/middlewared/plugins
[2018/05/24 17:18:20] (WARNING) middlewared._loop_monitor_thread():997 - Task seems blocked: File "/usr/local/www/freenasUI/system/alert.py", line 224, in __init__
self.snmp_trap_sender = SnmpTrapSender()
File "/usr/local/www/freenasUI/system/alert.py", line 159, in __init__
resolveWithMib(mib_view_controller)
File "/usr/local/lib/python3.6/site-packages/pysnmp/smi/rfc1902.py", line 357, in resolveWithMib
ifAvailable=True, ifNotAdded=True)
File "/usr/local/lib/python3.6/site-packages/pysnmp/smi/compiler.py", line 51, in addMibCompiler
compiler = MibCompiler(parserFactory(**smiV1Relaxed)(),
File "/usr/local/lib/python3.6/site-packages/pysmi/parser/smi.py", line 48, in __init__
errorlog=logger)
File "/usr/local/lib/python3.6/site-packages/ply/yacc.py", line 3432, in yacc
lr = LRGeneratedTable(grammar, method, debuglog)
File "/usr/local/lib/python3.6/site-packages/ply/yacc.py", line 2133, in __init__
self.lr_parse_table()
File "/usr/local/lib/python3.6/site-packages/ply/yacc.py", line 2550, in lr_parse_table
self.add_lalr_lookaheads(C)
File "/usr/local/lib/python3.6/site-packages/ply/yacc.py", line 2514, in add_lalr_lookaheads
trans = self.find_nonterminal_transitions(C)
File "/usr/local/lib/python3.6/site-packages/ply/yacc.py", line 2290, in find_nonterminal_transitions
if t not in trans:
[2018/05/24 17:18:22] (WARNING) middlewared._loop_monitor_thread():997 - Task seems blocked: File "/usr/local/bin/middlewared", line 10, in <module>
sys.exit(main())
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 1137, in main
debug_level=debug_level,
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 1012, in run
self.__loop.run_until_complete(self.__plugins_load())
File "/usr/local/lib/python3.6/asyncio/base_events.py", line 454, in run_until_complete
self.run_forever()
File "/usr/local/lib/python3.6/asyncio/base_events.py", line 421, in run_forever
self._run_once()
File "/usr/local/lib/python3.6/asyncio/base_events.py", line 1418, in _run_once
handle._run()
File "/usr/local/lib/python3.6/asyncio/events.py", line 127, in _run
self._callback(*self._args)
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 728, in __plugins_load
await call
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 109, in __next__
return self.gen.send(None)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/ipmi.py", line 138, in setup
kld.kldload('/boot/kernel/ipmi.ko')
[2018/05/24 17:18:23] (DEBUG) middlewared.__plugins_load():730 - All plugins loaded
[2018/05/24 17:18:23] (DEBUG) middlewared.__setup_periodic_tasks():742 - Setting up periodic task mail::send_mail_queue to run every 600 seconds
[2018/05/24 17:18:23] (DEBUG) middlewared.__setup_periodic_tasks():742 - Setting up periodic task zfs.quota::notify_quota_excess to run every 60 seconds
[2018/05/24 17:18:23] (DEBUG) middlewared.run():1038 - Accepting connections
======== Running on http://0.0.0.0:6000 ========
(Press CTRL+C to quit)
[2018/05/24 17:18:23] (DEBUG) common.freenasldap.__init__():2441 - FreeNAS_ActiveDirectory.__init__: enter
[2018/05/24 17:18:23] (DEBUG) common.freenasldap.__init__():1536 - FreeNAS_ActiveDirectory_Base.__init__: enter
[2018/05/24 17:18:23] (DEBUG) common.freenasldap.__set_defaults():1389 - FreeNAS_ActiveDirectory_Base.__set_defaults: enter
[2018/05/24 17:18:23] (DEBUG) common.freenasldap.__set_defaults():1425 - FreeNAS_ActiveDirectory_Base.__set_defaults: leave
[2018/05/24 17:18:23] (WARNING) application.call_method():174 - Exception while calling notifier.directoryservice(*['AD'])
Traceback (most recent call last):
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 150, in call_method
result = await self.middleware.call_method(self, message)
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 128, in throw
return self.gen.throw(type, value, traceback)
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 908, in call_method
return await self._call(message['method'], serviceobj, methodobj, params, app=app)
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 128, in throw
return self.gen.throw(type, value, traceback)
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 886, in _call
return await self.run_in_thread(methodobj, *args)
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 128, in throw
return self.gen.throw(type, value, traceback)
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 849, in run_in_thread
return await self.run_in_thread_pool(self.__threadpool, method, *args, **kwargs)
File "/usr/local/lib/python3.6/asyncio/coroutines.py", line 128, in throw
return self.gen.throw(type, value, traceback)
File "/usr/local/lib/python3.6/site-packages/middlewared/main.py", line 845, in run_in_thread_pool
await task
File "/usr/local/lib/python3.6/concurrent/futures/thread.py", line 56, in run
result = self.fn(*self.args, **self.kwargs)
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/notifier.py", line 141, in directoryservice
ds = FreeNAS_ActiveDirectory(flags=FLAGS_DBINIT)
File "/usr/local/www/freenasUI/common/freenasldap.py", line 2443, in __init__
super(FreeNAS_ActiveDirectory, self).__init__(**kwargs)
File "/usr/local/www/freenasUI/common/freenasldap.py", line 1555, in __init__
self.set_servers()
File "/usr/local/www/freenasUI/common/freenasldap.py", line 1699, in set_servers
self.set_domain_controller()
File "/usr/local/www/freenasUI/common/freenasldap.py", line 1656, in set_domain_controller
"Unable to find domain controllers for %s" % self.domainname)
freenasUI.common.freenasldap.FreeNAS_ActiveDirectory_Exception: Unable to find domain controllers for None
[2018/05/24 17:18:23] (DEBUG) middlewared.logger.CrashReporting.report():97 - Sending a crash report...
[2018/05/24 17:18:23] (DEBUG) raven.base.Client.send_remote():684 - Sending message of length 4345 to https://sentry.ixsystems.com/api/2/store/
[2018/05/24 17:18:23] (ERROR) sentry.errors.uncaught._log_failed_submission():670 - ['FreeNAS_ActiveDirectory_Exception: Unable to find domain controllers for None', ' File "middlewared/main.py", line 150, in call_method', ' File "asyncio/coroutines.py", line 128, in throw', ' File "middlewared/main.py", line 908, in call_method', ' File "asyncio/coroutines.py", line 128, in throw', ' File "middlewared/main.py", line 886, in _call', ' File "asyncio/coroutines.py", line 128, in throw', ' File "middlewared/main.py", line 849, in run_in_thread', ' File "asyncio/coroutines.py", line 128, in throw', ' File "middlewared/main.py", line 845, in run_in_thread_pool', ' File "concurrent/futures/thread.py", line 56, in run', ' File "plugins/notifier.py", line 141, in directoryservice', ' File "freenasUI/common/freenasldap.py", line 2443, in __init__', ' File "freenasUI/common/freenasldap.py", line 1555, in __init__', ' File "freenasUI/common/freenasldap.py", line 1699, in set_servers', ' File "freenasUI/common/freenasldap.py", line 1656, in set_domain_controller']
[2018/05/24 17:18:43] (DEBUG) EtcService.generate():129 - No new changes for /etc/nsswitch.conf
[2018/05/24 17:18:43] (DEBUG) EtcService.generate():129 - No new changes for /etc/local/nss_ldap.conf
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/system
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/su
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/cron
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/passwd
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/pop3
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/samba
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/rsh
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/README
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/sshd
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/login
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/telnetd
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/xdm
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/sudo
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/imap
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/other
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/atrun
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/netatalk
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/ftp
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/kde
[2018/05/24 17:18:44] (DEBUG) EtcService.generate():129 - No new changes for /etc/pam.d/ftpd
[2018/05/24 17:18:49] (DEBUG) middleware.notifier._pipeopen():185 - Popen()ing: /sbin/zfs list -H -o name -t volume,filesystem
[2018/05/24 17:18:53] (DEBUG) middleware.notifier._pipeopen():185 - Popen()ing: /usr/local/bin/net groupmap list
Exception in thread Thread-51:
Traceback (most recent call last):
File "/usr/local/lib/python3.6/threading.py", line 916, in _bootstrap_inner
self.run()
File "/usr/local/lib/python3.6/site-packages/middlewared/plugins/mdns.py", line 275, in run
callBack=self.on_discover
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 1418, in DNSServiceBrowse
None)
File "/usr/local/lib/python3.6/site-packages/pybonjour.py", line 286, in _errcheck
raise cls(result)
pybonjour.BonjourError: (-65540, 'bad param')
[2018/05/24 18:50:52] (DEBUG) ServiceService._simplecmd():255 - Calling: reload(ssh)
[2018/05/24 18:53:22] (DEBUG) ServiceService._simplecmd():255 - Calling: reload(ssh)
[2018/05/24 19:29:13] (DEBUG) ServiceService._simplecmd():255 - Calling: reload(ssh)
[2018/05/25 07:31:06] (DEBUG) freenasOS.Update.DownloadUpdate():977 - Going to try checking cached manifest /var/db/system/update/MANIFEST
[2018/05/25 07:31:06] (DEBUG) freenasOS.Update.DownloadUpdate():1001 - Got this exception: [Errno 2] No such file or directory: '/var/db/system/update/MANIFEST'
[2018/05/25 07:31:06] (DEBUG) freenasOS.Update.DownloadUpdate():1034 - DownloadUpdate: No update available
[2018/05/26 07:31:03] (DEBUG) freenasOS.Update.DownloadUpdate():977 - Going to try checking cached manifest /var/db/system/update/MANIFEST
[2018/05/26 07:31:03] (DEBUG) freenasOS.Update.DownloadUpdate():1001 - Got this exception: [Errno 2] No such file or directory: '/var/db/system/update/MANIFEST'
[2018/05/26 07:31:03] (DEBUG) freenasOS.Update.DownloadUpdate():1034 - DownloadUpdate: No update available