Jump to content

Trakt: Wrong time


Recommended Posts

Posted

When I manually mark a movie/episode as watched, I notice that trakt reports the wrong timing. My guess is the UTC timing is off, I stay in UTC+8.

 

Eg I manually mark an episode at 5-Jul 10:32pm, but at trakt it shows that I watched it at 6-Jul 6:32am.

 

 

 

Seems to me the DB could be updated wrongly. When I do a query to

http://emby_ip:8096/mediabrowser/Users/xxxx/Items?parentId=yyyy (where yyyy is the show season id), I got this:

 

 

....

  }, {
    "Name": "Greg Proops 1",
    "ServerId": "004081ff8ade482b86d51d60bf61330c",
    "Id": "6bc8d08df90c49d315f6bbb5cbea04d3",
    "HasSubtitles": true,
    "Container": "mkv,webm",
    "PremiereDate": "2018-07-01T16:00:00.0000000Z",
    "RunTimeTicks": 12508680192,
    "ProductionYear": 2018,
    "IndexNumber": 6,
    "ParentIndexNumber": 14,
    "IsHD": true,
    "IsFolder": false,
    "Type": "Episode",
    "ParentLogoItemId": "a2be131f851a74bf366d924ec1914028",
    "ParentBackdropItemId": "a2be131f851a74bf366d924ec1914028",
    "ParentBackdropImageTags": ["b6120fb29fe5bb10dd888d79c61d9dcb"],
    "LocalTrailerCount": 0,
    "UserData": {
      "PlaybackPositionTicks": 0,
      "PlayCount": 1,
      "IsFavorite": false,
      "LastPlayedDate": "2018-07-06T06:32:38.0000000+08:00",
      "Played": true,
      "Key": "76808014006"
    },
    "SeriesName": "Whose Line is it Anyway?",
    "SeriesId": "a2be131f851a74bf366d924ec1914028",
    "SeasonId": "fea3e1350e416742a05e8cf1ca9ee6f6",
    "SeriesPrimaryImageTag": "a68014a33689917dec8c2cf45a9ed818",
    "SeasonName": "Season 14",
    "VideoType": "VideoFile",
    "ImageTags": {
      "Primary": "1b239f433824dcc60fc5dc373c2140cd"
    },
    "BackdropImageTags": [],
    "ParentLogoImageTag": "c20b93360e8f8564b27420545fa536e2",
    "ParentThumbItemId": "a2be131f851a74bf366d924ec1914028",
    "ParentThumbImageTag": "587f2cf5cffe7d8e1412900719be7d1d",
    "LocationType": "FileSystem",
    "MediaType": "Video"
  }],

....

Posted

Our dates are in utc so that's what you would see from the emby api.

Posted (edited)

then why does the API returns 2018-07-06T06:32:38.0000000+08:00 instead of 2018-07-05T14:32:38.0000000+00:00

that's 16 hours diff (double of the +8 hour timezone)

 

 

izzit possible that the coding is wrong? should be subtract but got added instead?

Can you test it yourself and verify the time saved into the DB

Edited by quekky
Posted

The api returns UTC. It's  up to the client to localize it.

Posted

I click on watch at 20:32hours (timezone is +8, so it's actually 1432UTC)

 

 

If the API returns UTC, then why does it return 0632 the next day, instead of the actual 1432?

Posted

I would check your server machine's time zone settings and make sure they are correct.

Posted

which server?

 

the machine that runs emby have the correct timezone (+8hr), and is synced to ntp every day.

actually what does the timezone have anything to do? whichever timezone the UTC is still the same

Posted

Because if a conversion to/from local time is ever needed, that's when your server time zone setting will have an impact.

Posted

timezone is set correctly (+8), so izzit coz u added instead subtract? That's why there;s 16 hours ahead of time

Posted

We don't do any additions, subtractions, or conversions ourselves. We use system api's to handle that for us, so that's why I kept saying check your system timezone.

Posted

What platform are you running Emby server on?

Posted

synology, latest version

Posted

Have you checked the time zone settings on your Synology box?

Posted

already said in the previous post that it's set to the correct timzone (+8)

Posted

Are you using a VPN?

dranderson402
Posted

I just manually set an episode to watched and trakt marked it 10 hours earlier. My servers time settings are also correct. I'm running 3.5 on windows 10 pro.

 

Sent from my SM-G955U using Tapatalk

paulsalter
Posted

If I manually mark something as watched it gets a time of GMT +3

 

Current time in UK is 14:55 BST (GMT +1)

Manually mark as watched and it shows i watched at 16:55

Posted

Does this happen with movies, series or both?
Can you enable debug logging in emby, enable extra logging in trakt plugin and send the output?

Posted (edited)

here's the full debug log:

2018-07-25 00:04:57.981 Info App: Application version: 3.5.0.0
2018-07-25 00:04:57.982 Info App: Emby
	Command line: /var/packages/EmbyServer/target/server/MediaBrowser.Server.Mono.exe -package synology -programdata /var/packages/EmbyServer/target/var -ffmpeg /var/packages/EmbyServer/target/ffmpeg/bin/ffmpeg -ffprobe /var/packages/EmbyServer/target/ffmpeg/bin/ffprobe -restartpath /var/packages/EmbyServer/scripts/restart
	Operating system: Unix 3.10.105.0
	64-Bit OS: True
	64-Bit Process: True
	User Interactive: False
	Mono: 5.10.1.47 (tarball Sun Apr 22 22:48:00 CST 2018)
	Processor count: 4
	Program data path: /var/packages/EmbyServer/target/var
	Application directory: /volume1/@appstore/EmbyServer/releases/v3.5.0.0
2018-07-25 00:04:57.982 Info App: Plugins:
	Auto Box Sets 1.1.3.0
	IMVDb 1.0.1.0
	ISO Mounter for Emby Server 1.0.0.0
	TimeLordTV 18.6.20.923
	Open Subtitles 1.0.2.0
	Statistics 2.0.5.1
	Trakt 3.2.1.0
2018-07-25 00:04:57.982 Info TaskManager: Rotate log file Completed after 0 minute(s) and 0 seconds
2018-07-25 00:04:57.986 Info TaskManager: ExecuteQueuedTasks
2018-07-25 00:05:01.209 Debug App: Running FolderImageProvider for /volume1/Volume_1/My Videos/Series/House Of Cards/Season 1/screens S01E01
2018-07-25 00:05:01.426 Info HttpServer: HTTP POST http://172.23.217.61:8096/emby/Users/846309c5b13a47b6894ec08286160f83/PlayedItems/edff7a917ec132a4fe2a019a0f26ad9c?DatePlayed=20180725000459. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
2018-07-25 00:05:01.462 Info HttpServer: HTTP Response 200 to 172.23.217.56. Time: 36ms. http://172.23.217.61:8096/emby/Users/846309c5b13a47b6894ec08286160f83/PlayedItems/edff7a917ec132a4fe2a019a0f26ad9c?DatePlayed=20180725000459 
2018-07-25 00:05:02.683 Info HttpServer: HTTP GET http://172.23.217.61:8096/emby/Users/846309c5b13a47b6894ec08286160f83/Items?Recursive=true&Limit=3&Filters=IsNotFolder&SortBy=DateCreated&SortOrder=Descending&Ids=8093740633d0be3faf79c2071bacb896&MediaTypes=Audio%2CVideo&EnableTotalRecordCount=false. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
2018-07-25 00:05:02.700 Info HttpServer: HTTP Response 200 to 172.23.217.56. Time: 18ms. http://172.23.217.61:8096/emby/Users/846309c5b13a47b6894ec08286160f83/Items?Recursive=true&Limit=3&Filters=IsNotFolder&SortBy=DateCreated&SortOrder=Descending&Ids=8093740633d0be3faf79c2071bacb896&MediaTypes=Audio%2CVideo&EnableTotalRecordCount=false 
2018-07-25 00:05:03.570 Info HttpServer: HTTP GET http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml. UserAgent: Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.570 Info HttpServer: HTTP GET http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml. UserAgent: Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.572 Debug Dlna: No matching device profile found. HOST=172.23.217.61:8096, DATE=Tue, 24 Jul 2018 16:05:03 GMT, CONNECTION=close, USER-AGENT=Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.573 Debug Dlna: No matching device profile found. HOST=172.23.217.61:8096, DATE=Tue, 24 Jul 2018 16:05:03 GMT, CONNECTION=close, USER-AGENT=Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.578 Info HttpServer: HTTP Response 200 to 172.23.217.61. Time: 9ms. http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml 
2018-07-25 00:05:03.580 Info HttpServer: HTTP Response 200 to 172.23.217.61. Time: 10ms. http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml 
2018-07-25 00:05:03.678 Info HttpServer: HTTP GET http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml. UserAgent: Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.682 Debug Dlna: No matching device profile found. HOST=172.23.217.61:8096, DATE=Tue, 24 Jul 2018 16:05:03 GMT, CONNECTION=close, USER-AGENT=Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.685 Info HttpServer: HTTP GET http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml. UserAgent: Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.686 Debug Dlna: No matching device profile found. HOST=172.23.217.61:8096, DATE=Tue, 24 Jul 2018 16:05:03 GMT, CONNECTION=close, USER-AGENT=Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.688 Info HttpServer: HTTP Response 200 to 172.23.217.61. Time: 10ms. http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml 
2018-07-25 00:05:03.689 Info HttpServer: HTTP Response 200 to 172.23.217.61. Time: 4ms. http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml 
2018-07-25 00:05:03.775 Info HttpServer: HTTP GET http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml. UserAgent: Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.778 Debug Dlna: No matching device profile found. HOST=172.23.217.61:8096, DATE=Tue, 24 Jul 2018 16:05:03 GMT, CONNECTION=close, USER-AGENT=Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.781 Info HttpServer: HTTP GET http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml. UserAgent: Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.783 Info HttpServer: HTTP Response 200 to 172.23.217.61. Time: 8ms. http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml 
2018-07-25 00:05:03.787 Debug Dlna: No matching device profile found. HOST=172.23.217.61:8096, DATE=Tue, 24 Jul 2018 16:05:03 GMT, CONNECTION=close, USER-AGENT=Linux/3.10.105, UPnP/1.0, Portable SDK for UPnP devices/1.6.21
2018-07-25 00:05:03.792 Info HttpServer: HTTP Response 200 to 172.23.217.61. Time: 11ms. http://172.23.217.61:8096/dlna/004081ff8ade482b86d51d60bf61330c/description.xml 
2018-07-25 00:05:04.354 Debug App: ScheduledTasksWebSocketListener stop transmitting over websocket to [::ffff:172.23.217.56]:37622
2018-07-25 00:05:04.366 Info HttpServer: HTTP GET http://172.23.217.61:8096/emby/System/Logs. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
2018-07-25 00:05:04.366 Info HttpServer: HTTP GET http://172.23.217.61:8096/emby/System/Configuration. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
2018-07-25 00:05:04.370 Info HttpServer: HTTP Response 200 to 172.23.217.56. Time: 4ms. http://172.23.217.61:8096/emby/System/Configuration 
2018-07-25 00:05:04.380 Info HttpServer: HTTP Response 200 to 172.23.217.56. Time: 14ms. http://172.23.217.61:8096/emby/System/Logs 
2018-07-25 00:05:06.550 Debug Trakt: {"movies":[{"watched_at":"2018-07-25T08:04:59Z","title":"The Lady","year":2011,"ids":{"imdb":"tt1802197","tmdb":77878}}]}
2018-07-25 00:05:06.586 Info HttpClient: HttpClientManager POST: https://api.trakt.tv/sync/history
2018-07-25 00:05:10.570 Info HttpServer: HTTP GET http://172.23.217.61:8096/emby/System/Logs/Log?name=server.txt. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
Edited by quekky
Posted (edited)

same for series:

2018-07-25 00:11:15.708 Info HttpServer: HTTP POST http://172.23.217.61:8096/emby/Users/846309c5b13a47b6894ec08286160f83/PlayedItems/8093740633d0be3faf79c2071bacb896?DatePlayed=20180725001113. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
2018-07-25 00:11:15.715 Info HttpServer: HTTP Response 200 to 172.23.217.56. Time: 7ms. http://172.23.217.61:8096/emby/Users/846309c5b13a47b6894ec08286160f83/PlayedItems/8093740633d0be3faf79c2071bacb896?DatePlayed=20180725001113 
2018-07-25 00:11:17.672 Info HttpServer: HTTP GET http://172.23.217.61:8096/emby/System/Logs/Log?name=server.txt. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
2018-07-25 00:11:17.677 Debug HttpResultFactory: Transmit file /var/packages/EmbyServer/target/var/logs/server.txt
2018-07-25 00:11:17.679 Info HttpServer: HTTP Response 200 to 172.23.217.56. Time: 7ms. http://172.23.217.61:8096/emby/System/Logs/Log?name=server.txt 
2018-07-25 00:11:17.954 Info HttpServer: HTTP GET http://172.23.217.61:8096/favicon.ico. UserAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:61.0) Gecko/20100101 Firefox/61.0
2018-07-25 00:11:17.956 Info HttpServer: HTTP Response 304 to 172.23.217.56. Time: 1ms. http://172.23.217.61:8096/favicon.ico 
2018-07-25 00:11:20.789 Debug Trakt: {"shows":[],"episodes":[{"watched_at":"2018-07-25T08:11:13Z","ids":{"tvdb":6754141}}]}

you can see that I clicked it at 00:11AM (+8), yet it's sent to trakt that it's 08:11AM UTC. That's 16 hours ahead

Edited by quekky
Posted

lastplayeddate in the database is also showing as 8AM 

post-322318-0-44406600-1532449124_thumb.png

paulsalter
Posted

After browsing my library, the data on that link shows the following

Current time is 11:29 UK time (10:29 GMT/UTC)

 

"LastLoginDate":"2018-05-30T19:11:42.2618235Z","LastActivityDate":"2018-07-28T10:28:08.5167491Z",

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
×
×
  • Create New...