SynoDLNAtrakt
SynoDLNAtrakt copied to clipboard
cytec
SynoDLNATrakt crashing
Hi there!
I've installed SynoDLNATrakt through the repo on a DS214play with DSM 5.0-4458. Every time I try to run it, it stops after a few secs, and I haven't even been able to access the WebUI. I can't seem to find any logs in order to help you.
Do you have any ideas on what might be causing this?
Thanks, Bill
Seems like there is something wrong during startup... you can try running the debug script and check if there is any output...
that would look something like this: ssh into your DS cd to synodlnatrakt (cd /usr/local/synodlnatrakt/share/SynoDLNAtrakt/) /usr/local/python/bin/python debug.py
this should give you some output in the console and most likeley provide some infos about why its crashing. maybe also have a look here: https://github.com/cytec/SynoDLNAtrakt/issues/27
Can you make anything of this?
Traceback (most recent call last):
File "debug.py", line 17, in <module>
from synodlnatrakt import web
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/web.py", line 4, in <module>
from synodlnatrakt.mediaelement import Episode, Movie
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/mediaelement.py", line 7, in <module>
from synodlnatrakt import pgsql, config, db, helper, images, trakt
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/pgsql.py", line 108, in <module>
Base.metadata.create_all(engine)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/schema.py", line 2848, in create_all
tables=tables)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py", line 1478, in _run_visitor
with self._optional_conn_ctx_manager(connection) as conn:
File "/usr/local/python/lib/python2.7/contextlib.py", line 17, in __enter__
return self.gen.next()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py", line 1471, in _optional_conn_ctx_manager
with self.contextual_connect() as conn:
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py", line 1661, in contextual_connect
self.pool.connect(),
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 272, in connect
return _ConnectionFairy(self).checkout()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 431, in __init__
rec = self._connection_record = pool._do_get()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 788, in _do_get
con = self._create_connection()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 225, in create_connection
return _ConnectionRecord(self)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 318, in __init__
self.connection = self.__connect()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 379, in __connect
connection = self.__pool._creator()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/strategies.py", line 80, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/default.py", line 283, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dbapi.py", line 581, in connect
password=password, socket_timeout=socket_timeout, ssl=ssl)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dbapi.py", line 480, in __init__
self.conn = interface.Connection(**kwargs)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/interface.py", line 433, in __init__
self.c.authenticate(user, password=password, database=database)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol.py", line 1018, in authenticate
reader.handle_messages()
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol.py", line 881, in handle_messages
retval = handler(msg, *args, **kwargs)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol.py", line 1031, in _func
reader.handle_messages()
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol.py", line 899, in handle_messages
raise exc
sqlalchemy.exc.ProgrammingError: (ProgrammingError) ('FATAL', '28000', 'role "admin" does not exist') None None
are you sure you have enabled the MediaServer/DLNA Server of your DS? seems like there is no admin user which is used by the MediaServer to maintain your MediaServer library...
EDIT: just saw you use 5.x... maybe they changed the user or MediaServer handling on DSM 5 have not yet tested it with later versions than 4.3
UPDATE: yeah like i thought... in DSM 5 they now use a special user (postgres) for database connections and admin has no more access to it...
i will push a fix for this asap (hopefully this week/weekend)
so i've just pushed an update to the spk repo... please uninstall SynoDLNAtrakt then refresh the Package Center and Install it again...
should work then ;)
Hi, I installed the latest spk from the repo for Synology 413j DSM 5 but it still stops after i run the application.
@musasm have you done this? https://github.com/cytec/SynoDLNAtrakt/issues/31#issuecomment-40327362 if not please do so and post the results here. thanks :)
Traceback (most recent call last):
File "debug.py", line 21, in
strange... which version of DSM 5 are you useing? seems like synology changed something on the mediaserver sql table...
Hi, it seems that the problem persists with DSM 5.0-4493 Update 2 and a new installation of the latest version (with a value postgres_user config (for DSM 5 and 4 compatibility): it still stops after i run the application
Traceback (most recent call last):
File "debug.py", line 21, in <module>
from synodlnatrakt import web
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/web.p y", line 4, in <module>
from synodlnatrakt.mediaelement import Episode, Movie
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/media element.py", line 7, in <module>
from synodlnatrakt import pgsql, config, db, helper, images, trakt
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/pgsql .py", line 108, in <module>
Base.metadata.create_all(engine)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/sql/schema.py", line 3023, in create_all
tables=tables)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py" , line 1462, in _run_visitor
with self._optional_conn_ctx_manager(connection) as conn:
File "/usr/local/python/lib/python2.7/contextlib.py", line 17, in __enter__
return self.gen.next()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py" , line 1455, in _optional_conn_ctx_manager
with self.contextual_connect() as conn:
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py" , line 1645, in contextual_connect
self.pool.connect(),
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 271, in connect
return _ConnectionFairy.checkout(self)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 466, in checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 329, in checkout
rec = pool._do_get()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 799, in _do_get
return self._create_connection()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 224, in _create_connection
return _ConnectionRecord(self)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 315, in __init__
self.connection = self.__connect()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 400, in __connect
connection = self.__pool._creator()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/strategi es.py", line 95, in connect
connection_invalidated=invalidated
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/util/compat.py" , line 185, in raise_from_cause
reraise(type(exception), exception, tb=exc_tb)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/strategi es.py", line 89, in connect
return dialect.connect(*cargs, **cparams)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/default. py", line 329, in connect
return self.dbapi.connect(*cargs, **cparams)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dbapi.py ", line 581, in connect
password=password, socket_timeout=socket_timeout, ssl=ssl)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dbapi.py ", line 480, in __init__
self.conn = interface.Connection(**kwargs)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/interfac e.py", line 433, in __init__
self.c.authenticate(user, password=password, database=database)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol .py", line 1018, in authenticate
reader.handle_messages()
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol .py", line 881, in handle_messages
retval = handler(msg, *args, **kwargs)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol .py", line 1031, in _func
reader.handle_messages()
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol .py", line 899, in handle_messages
raise exc
sqlalchemy.exc.ProgrammingError: (ProgrammingError) ('FATAL', '28000', 'role "ad min" does not exist') None None
@xav093 check your config.ini postgres_user='admin' is for DSM 4.x postgres_user='postgres' is for DSM 5.x
Thank you for your reply, My setup was not correct but now I have the same problem as musasm:
Traceback (most recent call last):
File "debug.py", line 21, in <module>
from synodlnatrakt import web
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/web.py", line 4, in <module>
from synodlnatrakt.mediaelement import Episode, Movie
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/mediaelement.py", line 7, in <module>
from synodlnatrakt import pgsql, config, db, helper, images, trakt
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/pgsql.py", line 108, in <module>
Base.metadata.create_all(engine)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/sql/schema.py", line 3023, in create_all
tables=tables)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py", line 1462, in _run_visitor
with self._optional_conn_ctx_manager(connection) as conn:
File "/usr/local/python/lib/python2.7/contextlib.py", line 17, in __enter__
return self.gen.next()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py", line 1455, in _optional_conn_ctx_manager
with self.contextual_connect() as conn:
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/base.py", line 1645, in contextual_connect
self.pool.connect(),
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 271, in connect
return _ConnectionFairy.checkout(self)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 466, in checkout
fairy = _ConnectionRecord.checkout(pool)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 329, in checkout
rec = pool._do_get()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 799, in _do_get
return self._create_connection()
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 224, in _create_connection
return _ConnectionRecord(self)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py", line 320, in __init__
exec_once(self.connection, self)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/event/attr.py", line 233, in exec_once
self(*args, **kw)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/event/attr.py", line 242, in __call__
fn(*args, **kw)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/util/langhelpers.py", line 1178, in go
return once_fn(*arg, **kw)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/strategies.py", line 166, in first_connect
dialect.initialize(c)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/dialects/postgresql/base.py", line 1450, in initialize
super(PGDialect, self).initialize(connection)
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/default.py", line 212, in initialize
self._check_unicode_description(connection):
File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/default.py", line 288, in _check_unicode_description
]).compile(dialect=self)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dbapi.py", line 243, in _fn
return fn(self, *args, **kwargs)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dbapi.py", line 314, in execute
self._execute(operation, args)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dbapi.py", line 319, in _execute
self.cursor.execute(new_query, *new_args)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/interface.py", line 304, in execute
self._stmt.execute(*args, **kwargs)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/interface.py", line 139, in execute
self._row_desc, cmd = self.c.bind(self._portal_name, self._statement_name, args, self._parse_row_desc, kwargs.get("stream"))
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol.py", line 913, in _fn
return fn(self, *args, **kwargs)
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/protocol.py", line 1082, in bind
output_fc = [types.py_type_info(f) for f in row_desc.fields]
File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/types.py", line 162, in py_type_info
raise NotSupportedError("type oid %r not mapped to py type" % type_oid)
pg8000.errors.NotSupportedError: type oid 705 not mapped to py type
yeah seems like pg8000 throws out some errors, try with the latest commit/update https://github.com/cytec/SynoDLNAtrakt/commit/6c3c6615278a54d7f55658f23ef62a9ffa18e26f
All seem to work, it already started successfully. I will look in detail if everything is ok and come back to tell you. :)
Hi, I come to new I did an update git pull, no error at launch, the films of the library are integrated quickly. The side of trakt everything is ok. The problem is that the movies watched are not in "lastseen" Maybe I have forgotten something ? Here are the logs that seem affected:
07.07.2014 15:41:10 ERROR : Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [07/Jul/2014:14:26:18 +0300] "GET /v/NDLNA/vtl_4657.srt HTTP/1.1" 200 21835 "-" "GStreamer souphttpsrc libsoup/2.44.0"
AA
07.07.2014 15:41:10 ERROR : Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [07/Jul/2014:03:34:57 +0300] "GET /v/NDLNA/vtl_5306.srt HTTP/1.1" 404 345 "-" "GStreamer souphttpsrc libsoup/2.44.0"
AA
07.07.2014 15:41:10 ERROR : Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [06/Jul/2014:23:37:16 +0300] "GET /v/NDLNA/vtl_5269.srt HTTP/1.1" 404 345 "-" "GStreamer souphttpsrc libsoup/2.44.0"
07.07.2014 15:41:10 INFO : IMPORT FROM MEDIASERVER STARTED
.srt is only a subtitle file format, the log is checked for several video formats ("avi", "mkv", "mov", "mp4", "m4v", "ts", "hdmov", "wmv", "mpg", "mpeg", "xvid") so that is not really an error.
also there is (sadly) no method to get an exact playtime or anything like that from the logs, it just checks how often a file is requested from the DLNA server and then tries to calculate the runtime out of those informations...
so maybe just try to watch a full movie (or at least 40-50% of it) and then try the log parsing action again...
I watched a full movie and nothing appears in the logs, just:
07/07/2014 5:49:43 p.m. ERROR: Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [07/Jul/2014: 2:26:18 p.m. +0300] "GET / HTTP v/NDLNA/vtl_4657.srt / 1.1 "200 21835" - "" GStreamer souphttpsrc libsoup/2.44.0 "
It was a film (with subtitle) looked at 100% but it does not appear in the lastseen and no trace of the file name or title in the logs, just this error on a subtitle file.
I renewed experience after your answer:
07/07/2014 6:04:43 p.m. ERROR: Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [07/Jul/2014: 5:07:54 p.m. +0300] "GET / HTTP vs/NDLNA/vtl_667.srt / 1.1 "404 345" - "" GStreamer souphttpsrc libsoup/2.44.0 "
Same thing, looked at> 50%, still nothing in lastseen
it seems like your DLNA client just requests the .srt files...
can you please upload the content of /usr/local/synodlnatrakt/var/accesslog-backups so i can take a look at the DLNA log files?
What client are you useing to play the videos?
I don't understand, I have this in /usr /local/synodlnatrakt/var :
There are 2 directories: cache and logs
and 3 files: config.ini SynoDLNAtrakt.db and synodlnatrakt.pid
I did a search accesslog-backups is not findable
I use multiple clients to play videos: Freebox (French internet box), Asus O'play mini and Chromcast (DLNA?).
I'm back :blush:
In SynoDLNAlog I see:
07.07.2014 12:36:59 ERROR : Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [05/Jul/2014:16:10:03 +0300] "GET /vs/NDLNA/vtl_417.srt HTTP/1.1" 404 345 "-" "GStreamer souphttpsrc libsoup/2.44.0"
07.07.2014 12:36:59 ERROR : Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [06/Jul/2014:23:37:16 +0300] "GET /v/NDLNA/vtl_5269.srt HTTP/1.1" 404 345 "-" "GStreamer souphttpsrc libsoup/2.44.0"
07.07.2014 12:36:59 ERROR : Unable to parse line: 192.168.1.85 192.168.1.60:50002 - [07/Jul/2014:03:34:57 +0300] "GET /v/NDLNA/vtl_5306.srt HTTP/1.1" 404 345 "-" "GStreamer souphttpsrc libsoup/2.44.0"
07.07.2014 12:36:59 INFO : Parsing: /var/log/lighttpd/access.log gave 3 entry(s)
But in /var/log/lighttpd/access.log there are more than 3 entries, for example:
192.168.1.85 192.168.1.60:50002 - [06/Jul/2014:23:38:39 +0300] "GET /v/NDLNA/5269.mkv HTTP/1.1" 206 114064 "-" "fbxmms/1.0 FreeboxPlayer/6.0"
192.168.1.85 192.168.1.60:50002 - [07/Jul/2014:01:21:04 +0300] "GET /v/NDLNA/5269.mkv HTTP/1.1" 206 1936166808 "-" "fbxmms/1.0 FreeboxPlayer/6.0"
192.168.1.85 192.168.1.60:50002 - [07/Jul/2014:03:35:02 +0300] "GET /v/NDLNA/5306.avi HTTP/1.1" 206 4495656 "-" "fbxmms/1.0 FreeboxPlayer/6.0"
192.168.1.85 192.168.1.60:50002 - [07/Jul/2014:17:07:54 +0300] "GET /vs/NDLNA/vtl_667.srt HTTP/1.1" 404 345 "-" "GStreamer souphttpsrc libsoup/2.44.0"
192.168.1.85 192.168.1.60:50002 - [07/Jul/2014:18:26:27 +0300] "GET /vs/NDLNA/667.mkv HTTP/1.1" 200 3851807162 "-" "fbxmms/1.0 FreeboxPlayer/6.0"
So it seems that the problem does not come from my DLNA client?
First: Sorry that folder does only exist if you have the development settings enabled, my fault... but /var/log/lighttpd/access.log is the same so thanks...
ok, i think i've got the problem here: your Client requests the file and the Server then sends the whole File in one request, SynoDLNAtrakt thinks files are transfered in junks over several requests and uses the time between the first and the last request to calculate the current view time...
for example:
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:09:01 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 337056 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5.1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:09:02 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 4533360 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5.1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:06 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 1831393 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:08 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 1717001 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5.1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:09 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 1105945 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:10 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 1032097 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:12 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 1621433 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:14 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 1060976 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:15 +0200] "GET /v/NDLNA/11425.mkv HTTP/1.1" 206 306895 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:27 +0200] "GET /v/NDLNA/11424.srt HTTP/1.1" 404 345 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5.1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:27 +0200] "GET /v/NDLNA/11424.mkv HTTP/1.1" 200 3028955 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:27 +0200] "GET /v/NDLNA/11424.mkv HTTP/1.1" 206 13360 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5.1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:28 +0200] "GET /v/NDLNA/11424.mkv HTTP/1.1" 206 4190188 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:29 +0200] "GET /v/NDLNA/11424.mkv HTTP/1.1" 200 17688507 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5 .1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:30 +0200] "GET /v/NDLNA/11424.mkv HTTP/1.1" 206 1428852 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
192.168.0.11 192.168.0.55:50002 - [06/Jul/2014:23:10:31 +0200] "GET /v/NDLNA/11424.mkv HTTP/1.1" 206 784492 "-" "Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5. 1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)"
which then calculates a runtime (in this example about 1 Minute 30 Seconds) and calculates the progress... if you get the whole file in one request there is no way to check/verify if you watched the whole video or just a few minutes of it.
as you see in my log compared to yours: i get a junk of ~17MB every second streamed to my DLNA Client (LG TV) while your Client gets the whole file (~3.6GB for 667.mkv) in one single request...
have you enabled the debug mode for the Mediaserver? i think it's called DMA-Communicationprotocol or something like that... you can find a screenshot how to activate it here: https://github.com/cytec/SynoDLNAtrakt/wiki
hopefully that should fix everything :)
PS: As you can see i have some .srt requests there also, thats not really importent, because they just get ignored when parsing, so even if there is an error for them (like you have because of the prefix vtl_) it has no effect on the parsing itself
Hi, I have the same issue
['Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows
NT 5.1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NE
T CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)']
-ash: [Mozilla/5.0 (compatible; LG-HttpClient-v1.0.3 UPnP/1.1; MSIE 8.0; Windows NT 5.1; LG_UA; AD_LOGON=LGE.NET; .NET CLR 2.0.50727; .NET CLR 3.0.04506.30; .NET CLR 3.0.04506.648; LG_UA; AD_LOGON=LGE.NET; LG NetCast.TV-2011)]: not found
NAS> Traceback (most recent call last):
-ash: syntax error: unexpected word (expecting ")")
NAS> File "debug.py", line 21, in <module>
-ash: syntax error: unexpected newline
NAS> from synodlnatrakt import web
-ash: from: not found
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/
web.py", line 4, in <module>
-ash: syntax error: unexpected newline
NAS> from synodlnatrakt.mediaelement import Episode, Movie
-ash: from: not found
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/
mediaelement.py", line 7, in <module>
-ash: syntax error: unexpected newline
NAS> from synodlnatrakt import pgsql, config, db, helper, images, trakt
-ash: from: not found
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/synodlnatrakt/
pgsql.py", line 108, in <module>
-ash: syntax error: unexpected newline
NAS> Base.metadata.create_all(engine)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/sql/schema
.py", line 3023, in create_all
-ash: File: not found
NAS> tables=tables)
-ash: syntax error: unexpected ")"
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/bas
e.py", line 1462, in _run_visitor
-ash: File: not found
NAS> with self._optional_conn_ctx_manager(connection) as conn:
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/contextlib.py", line 17, in __enter
__
-ash: File: not found
NAS> return self.gen.next()
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/bas
e.py", line 1455, in _optional_conn_ctx_manager
-ash: File: not found
NAS> with self.contextual_connect() as conn:
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/bas
e.py", line 1645, in contextual_connect
-ash: File: not found
NAS> self.pool.connect(),
-ash: syntax error: bad function name
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py",
line 271, in connect
-ash: File: not found
NAS> return _ConnectionFairy.checkout(self)
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py",
line 466, in checkout
-ash: File: not found
NAS> fairy = _ConnectionRecord.checkout(pool)
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py",
line 329, in checkout
-ash: File: not found
NAS> rec = pool._do_get()
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py",
line 799, in _do_get
-ash: File: not found
NAS> return self._create_connection()
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py",
line 224, in _create_connection
-ash: File: not found
NAS> return _ConnectionRecord(self)
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/pool.py",
line 320, in __init__
-ash: File: not found
NAS> exec_once(self.connection, self)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/event/attr
.py", line 233, in exec_once
-ash: File: not found
NAS> self(*args, **kw)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/event/attr
.py", line 242, in __call__
-ash: File: not found
NAS> fn(*args, **kw)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/util/langh
elpers.py", line 1178, in go
-ash: File: not found
NAS> return once_fn(*arg, **kw)
-ash: syntax error: unexpected "("
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/str
ategies.py", line 166, in first_connect
-ash: File: not found
NAS> dialect.initialize(c)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/dialects/p
ostgresql/base.py", line 1450, in initialize
-ash: File: not found
NAS> super(PGDialect, self).initialize(connection)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/def
ault.py", line 212, in initialize
-ash: File: not found
NAS> self._check_unicode_description(connection):
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/usr/local/python/lib/python2.7/site-packages/sqlalchemy/engine/def
ault.py", line 288, in _check_unicode_description
-ash: File: not found
NAS> ]).compile(dialect=self)
-ash: syntax error: unexpected ")"
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dba
pi.py", line 243, in _fn
-ash: File: not found
NAS> return fn(self, *args, **kwargs)
-ash: syntax error: unexpected "("
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dba
pi.py", line 314, in execute
-ash: File: not found
NAS> self._execute(operation, args)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/dba
pi.py", line 319, in _execute
-ash: File: not found
NAS> self.cursor.execute(new_query, *new_args)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/int
erface.py", line 304, in execute
-ash: File: not found
NAS> self._stmt.execute(*args, **kwargs)
-ash: syntax error: unexpected word (expecting ")")
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/int
erface.py", line 139, in execute
-ash: File: not found
NAS> self._row_desc, cmd = self.c.bind(self._portal_name, self._statement_na
me, args, self._parse_row_desc, kwargs.get("stream"))
-ash: syntax error: unexpected "("
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/pro
tocol.py", line 913, in _fn
-ash: File: not found
NAS> return fn(self, *args, **kwargs)
-ash: syntax error: unexpected "("
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/pro
tocol.py", line 1082, in bind
-ash: File: not found
NAS> output_fc = [types.py_type_info(f) for f in row_desc.fields]
-ash: syntax error: unexpected "("
NAS> File "/volume1/@appstore/synodlnatrakt/share/SynoDLNAtrakt/lib/pg8000/typ
es.py", line 162, in py_type_info
-ash: File: not found
NAS> raise NotSupportedError("type oid %r not mapped to py type" % type_oid)
-ash: syntax error: unexpected "("
NAS> pg8000.errors.NotSupportedError: type oid 705 not mapped to py type
-ash: pg8000.errors.NotSupportedError:: not found
Can you help me?
@xav093 setting the media server to debug mode should hopefully fix it ;) @bentux what are you doing?
-ash: File: not found seems like you try to run it with bash instead of python... also the error in the last line is fixed in the latest version... so just pull in the latest version and try again with /usr/local/python/bin/python debug.py
Ok it's seems good, but now I have some erreurs like that
10.07.2014 12:59:43 ERROR : Job "parse_logs (trigger: interval[0:30:00], next run at: 2014-07-10 13:28:45.709710)" raised an exception
10.07.2014 12:59:42 ERROR : Cant find/open/parse file: /volume1/video/Series/Battlestar Galactica/Battlestar Galactica S02E22.nfo
10.07.2014 12:59:42 ERROR : cant find/open file: /volume1/video/Series/Battlestar Galactica/tvshow.nfo
10.07.2014 12:59:41 ERROR : No entry found for ID 2922
10.07.2014 12:59:41 ERROR : No entry found for ID 2921
10.07.2014 12:59:41 ERROR : No entry found for ID 3617
10.07.2014 12:59:41 ERROR : No entry found for ID 3597
10.07.2014 12:59:41 ERROR : No entry found for ID 3590
10.07.2014 12:59:40 ERROR : No entry found for ID 2928
10.07.2014 12:59:40 ERROR : No entry found for ID 3095
10.07.2014 12:59:40 ERROR : No entry found for ID 3097
10.07.2014 12:59:39 ERROR : Cant find/open file: /volume1/video/Parents/Colorful.nfo
10.07.2014 12:59:39 ERROR : No entry found for ID 3468
10.07.2014 12:59:37 ERROR : Cant find/open file: /volume1/video/Parents/Colorful.nfo
10.07.2014 12:59:37 ERROR : No entry found for ID 3397
10.07.2014 12:59:35 ERROR : Cant find/open file: /volume1/video/Parents/300 Rise Of An Empire 2014 FRENCH BRRiP XViD-CARPEDIEM.nfo
I haven't any .nfo in my folder so wtf? Thank's for your help
It find some (31 of 198) movies but they all named "parents" maybe cause my folder is /volume1/video/Parents
10.07.2014 13:29:39 INFO : Found result for parents -> Fullname: Parents, year 1989, imdb_id: tt0098068
Funny
@bentux
make sure you activated try guessing in the Settings -> General -> Advanced view and check the Debug log for more Informations there should be more output on the "non nfo parsing" (see below)
A little background storry.... SynoDLNAtrakt uses a folder based naming i'll give you some examples:
Movies:
Set movie Folder to /volume1/video/Parents/ then for a movie like that /volume1/video/Parents/Iron Man (2008)/Iron.Man.2008.xyz.mkv first the folder will be parsed and checked, if it gets no result it tries the filename...
if you don't have any subfolders in your Movies folder (example: /volume1/video/Parents/Iron.Man.2008.xyz.mkv) it takes the Parents folder and looks that one up... so basically you need to organize your movies in Subfolders inside the Main Movie Folder...
TV-Shows:
Set Series folder to /volume1/video/Series/then for every TV-Show have a File with the Name in it like this /volume1/video/Series/Dexter/Season 1/Dexter.s01.e01.mkv... in TV-Show ordering thats not really that important because it always parses the Filename first... if there is no Show Name in the filename or no season name it tries to get those informations based on your folder structure (thats verry unstable feature atm)
NFO: SynoDLNAtrakt has built in support for XBMC like .nfo files (mainly to get the correct tvdb/imdb ids and stuff like that) thats what it looks up FIRST... so if you have Problems with some files, you can easy fix that by creating a nfo for that file... if however no such nfo file is found it falls back to the methods above (folder/filename guessing) and logs out that there was no .nfo file found... thats what you see in the logs ;)+
Try Guessing (settings) if you don't use nfo Files you have to activate this or SynoDLNAtrakt will not try to figure out any infos from the Filename itself...
Media server Debug mode is activated from the beginning so I continued my research and come back later to tell you (I'll try other DLNA client )