Problem with path substitution

[BrettB]

So, I thought that I had the path substitution working to get X-NEWA to use the smb: share to access the file so that it would get the .edl files. However, as Martin pointed out, it seems like it is not working for one of the directories (F:\NPVR Recordings3\).

Here's my advancedsettings.xml file:

Code:

<advancedsettings>
  <video>
    <smallstepbackseconds>7</smallstepbackseconds>  <!-- Length of the small skip back when playing a video --> <!-- Will be replaced by a GUI option in v15 -->
    <usetimeseeking>true</usetimeseeking>  <!-- Whether to use time based or percentage based seeking. -->
    <timeseekforward>60</timeseekforward>  <!-- Time to seek forward in seconds when doing a short seek.  Defaults to 30. --> <!-- Deprecated. Will be replaced by a GUI option in v15. Note: Need to double check if it will actually be removed? -->
    <timeseekbackward>-20</timeseekbackward>  <!-- Time to seek backward in seconds when doing a short seek.  Defaults to -30. --> <!-- Deprecated. Will be replaced by a GUI option in v15. Note: Need to double check if it will actually be removed? -->
    <timeseekforwardbig>600</timeseekforwardbig>  <!-- Time to seek forward in seconds when doing a long seek.  Defaults to 600 (10 minutes). -->
    <timeseekbackwardbig>-600</timeseekbackwardbig>  <!-- Time to seek forward in seconds when doing a long seek.  Defaults to -600 (10 minutes). -->
    <percentseekforward>2</percentseekforward>  <!-- Amount to seek forward as a percentage, when doing a short seek.  Defaults to 2. -->
    <percentseekbackward>-2</percentseekbackward>  <!-- Amount to seek backward as a percentage, when doing a short seek.  Defaults to -2. -->
    <percentseekforwardbig>10</percentseekforwardbig>  <!-- Amount to seek forward as a percentage, when doing a long seek.  Defaults to 10. -->
    <percentseekbackwardbig>-10</percentseekbackwardbig>  <!-- Amount to seek forward as a percentage, when doing a long seek.  Defaults to -10. -->
  </video>
  <pathsubstitution>
    <substitute>
      <from>D:/NPVR Recordings/</from>
      <to>smb://192.168.143.10/NPVR Recordings/</to>
    </substitute>
    <substitute>
      <from>E:/NPVR Recordings2/</from>
      <to>smb://192.168.143.10/NPVR Recordings2/</to>
    </substitute>
    <substitute>
      <from>F:/NPVR Recordings3/</from>
      <to>smb://192.168.143.10/NPVR Recordings3/</to>
    </substitute>
  </pathsubstitution>
</advancedsettings>

Attached is a debug kodi.log showing playing a little bit of a The Amazing Race recording. It appears to start out ok:

Code:

21:19:32 T:1674568768  NOTICE: #XBMCPlayer#
21:19:32 T:1674568768  NOTICE: started player
21:19:32 T:1674568768  NOTICE: {'tvshowtitle': u'In It to Win It', 'Title': u'The Amazing Race'}
21:19:32 T:1674568768  NOTICE: F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts
21:19:32 T:1674568768  NOTICE: Playing F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts
21:19:32 T:1674568768  NOTICE: <xbmcgui.ListItem object at 0x63f84a58>
21:19:32 T:1674568768  NOTICE: player started
21:19:32 T:1674568768  NOTICE: entering loop
21:19:32 T:1970196480   DEBUG: Loading settings for F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts
21:19:32 T:1970196480   DEBUG: CPlayerCoreFactory::GetPlayers(F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts)

But then it get's strange when it looks for an external subtitle file:

Code:

21:19:32 T:1656554560   DEBUG: CSMBFile::Open - opened NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts, fd=10000
21:19:32 T:1656554560   DEBUG: ScanForExternalSubtitles: Searching for subtitles...
21:19:32 T:1656554560   DEBUG: OpenDir: Using authentication url smb://192.168.143.10/NPVR%20Recordings3/The%20Amazing%20Race
21:19:32 T:1656554560    INFO: ScanForExternalSubtitles: found subtitle file D:/NPVR Recordings/The Amazing Race/The Amazing Race.S26E11.In It to Win It.txt
21:19:32 T:1656554560   DEBUG: ScanForExternalSubtitles: END (total time: 66 ms)
21:19:32 T:1656554560   DEBUG: GetExternalStreamDetailsFromFilename - Language = '' / Name = '(External)' / Flag = '0' from D:/NPVR Recordings/The Amazing Race/The Amazing Race.S26E11.In It to Win It.txt
21:19:32 T:1656554560  NOTICE: Creating Demuxer
21:19:32 T:1656554560   DEBUG: Open - probing detected format [mpegts]
21:19:32 T:1656554560   DEBUG: Open - avformat_find_stream_info starting

It changes from "NPVR Recordings3/..." to "D:/NPVR Recordings/..."! Then when it gets down to the EDL section:

Code:

21:19:33 T:1627386944   DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_SYNCHRONIZE
21:19:33 T:1656554560   DEBUG: CSMBFile::Open - opened NPVR Recordings/The Amazing Race/The Amazing Race.S26E11.In It to Win It.txt, fd=-1
21:19:33 T:1656554560    INFO: SMBFile->Open: Unable to open file : 'smb://192.168.143.10/NPVR%20Recordings/The%20Amazing%20Race/The%20Amazing%20Race.S26E11.In%20It%20to%20Win%20It.txt'
                                            unix_err:'2' error : 'No such file or directory'
21:19:33 T:1656554560   ERROR: OpenStream - Unable to create subtitle parser
21:19:33 T:1656554560   DEBUG: ReadEditDecisionLists - Checking for edit decision lists (EDL) on local drive or remote share for: F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts
21:19:33 T:1656554560   DEBUG: CSMBFile::Open - opened NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.edl, fd=10001
21:19:33 T:1656554560   DEBUG: AddCut - Pushing new cut to back [00:03:00.050 - 00:05:13.610], 3
21:19:33 T:1656554560   DEBUG: AddCut - Pushing new cut to back [00:15:07.270 - 00:18:34.850], 3
21:19:33 T:1656554560   DEBUG: AddCut - Pushing new cut to back [00:30:22.620 - 00:33:49.430], 3
21:19:33 T:1656554560   DEBUG: AddCut - Pushing new cut to back [00:44:56.530 - 00:49:13.580], 3
21:19:33 T:1656554560   DEBUG: CSMBFile::Close closing fd 10001
21:19:33 T:1656554560   DEBUG: ReadEdl - Read 4 cuts and 0 scene markers in EDL file: F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.edl
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:03:00.050
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:05:13.610
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:15:07.270
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:18:34.850
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:30:22.620
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:33:49.430
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:44:56.530
21:19:33 T:1656554560   DEBUG: AddSceneMarker - Inserting new scene marker: 00:49:13.580
21:19:33 T:1656554560   DEBUG: OnPlayBackStarted: play state was 1, starting 1
21:19:33 T:1656554560   DEBUG: CDVDPlayer::SetCaching - caching state 3
21:19:33 T:1970196480   DEBUG: PlayFile: OpenFile succeed, play state 2
21:19:33 T:1635775552   DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_SETSPEED 0
21:19:33 T:1970196480   DEBUG: OnPlayBackStarted: play state was 2, starting 0
21:19:33 T:1627386944   DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED 0
21:19:33 T:1635775552   DEBUG: COMXPlayerVideo - CDVDMsg::PLAYER_STARTED 0
21:19:33 T:1627386944   DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_STARTED 0
21:19:33 T:1970196480   DEBUG: LIRC: Update - NEW at 74788:cf 0 KEY_PLAY_UP devinput (KEY_PLAY_UP)
21:19:33 T:1970196480   DEBUG: CGUIInfoManager::SetCurrentMovie(F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts)
21:19:33 T:1674568768  NOTICE: #Playback Started#
21:19:33 T:1674568768  NOTICE: #Im playing :: F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts
21:19:33 T:1674568768  NOTICE: 0.0
21:19:33 T:1656554560   DEBUG: CDVDDemuxFFmpeg::Read() fetching extradata, extradata_size(34)
21:19:33 T:1656554560   DEBUG: CDVDDemuxFFmpeg::AddStream(0, ...) -> 0
21:19:33 T:1656554560  NOTICE: Opening stream: 0 source: 256

It seems to try " SMBFile->Open: Unable to open file : 'smb://192.168.143.10/NPVR%20Recordings/..." (without the "3" at then end) which it doesn't find (and which doesn't exist since it's in the /NPVR Recordings3/ share). But then it successfully reads in the 4 cut points from the EDL file.

Very confusing...

- Brett

[mvallevand]

I did a quick search and there is certainly a possibility that that there CIFS sharename length limit

Martin

[BrettB]

I did a quick search and there is certainly a possibility that that there CIFS sharename length limit

I don't think that the problem is a length limit for the share name. I changed to share names to "Recordings", "Recordings2", and "Recordings3", and then tried playing 2 different recordings in "Recordings3". Here are excerpts from the log:

Code:

14:13:26 T:1681912896  NOTICE: #XBMCPlayer#
14:13:26 T:1681912896  NOTICE: started player
14:13:26 T:1681912896  NOTICE: {'tvshowtitle': u'In It to Win It', 'Title': u'The Amazing Race'}
14:13:26 T:1681912896  NOTICE: F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts
14:13:26 T:1969668096   DEBUG: LIRC: Update - NEW at 498938:cf 0 KEY_PLAY_UP devinput (KEY_PLAY_UP)
14:13:26 T:1681912896  NOTICE: Playing F:/NPVR Recordings3/The Amazing Race/The Amazing Race.S26E11.In It to Win It.ts
14:13:26 T:1681912896  NOTICE: <xbmcgui.ListItem object at 0x65f75a40>
14:13:26 T:1681912896  NOTICE: player started

...

14:14:20 T:1663038528  NOTICE: #XBMCPlayer#
14:14:20 T:1663038528  NOTICE: started player
14:14:20 T:1663038528  NOTICE: {'tvshowtitle': u'Gingerbread Man', 'Title': u'Battle Creek'}
14:14:20 T:1663038528  NOTICE: F:/NPVR Recordings3/Battle Creek/Battle Creek.S01E09.Gingerbread Man.ts
14:14:20 T:1663038528  NOTICE: not found
14:14:20 T:1663038528  NOTICE: /live?recording=119957
14:14:20 T:1663038528  NOTICE: Playing http://192.168.143.10:8866/live?recording=119957
14:14:20 T:1663038528  NOTICE: <xbmcgui.ListItem object at 0x65f65158>
14:14:20 T:1663038528  NOTICE: player started
14:14:20 T:1663038528  NOTICE: entering loop

So for The Amazing Race it appears for be using SMB access, but for Battle Creek it's using http streaming.

[mvallevand]

Yes that is a different problem probably share related for Battle Creek. Are you just trying to understand the logs? When Kodi is playing files it will use the database for metadata and if you've changed your libraries without scanning or resetting then some things probably work like they should.

Martin

[BrettB]

Yes that is a different problem probably share related for Battle Creek. Are you just trying to understand the logs? When Kodi is playing files it will use the database for metadata and if you've changed your libraries without scanning or resetting then some things probably work like they should.

This is all within X-NEWA--going to the recordings listing and then playing recordings from there. Some of them (like The Amazing Race) are getting the comskip edl data and some of them (like Battle Creek) are not. At first I thought that ones in the Recordings2 directory were working and ones in the Recordings3 directory were not. But then I came upon these 2 examples where they are both in the Recordings3 directory.

[mvallevand]

To be clear x-newa uses Kodi for playback, if you check the Kodi sqlite database files you will see they get entered. If substitution works some times I still consider it a permission issue.

Martin

[NYPlayer]

Brettb

Are you running windows 7 or windows 8 if you are look in event viewer (Custom Views / Administrator events) and see if you are getting errors 2017 or 2019 on srv?

[jcjefferies]

I have recently realised that "Path Substitution" is no longer working on both my OpenElec clients. I seem to be getting similar problem with smb failing and falling back to http. Was any conclusion reached about the problem?

20:08:47 T:140165418923776 NOTICE: #XBMCPlayer#
20:08:47 T:140165418923776 NOTICE: started player
20:08:47 T:140165418923776 NOTICE: {'tvshowtitle': None, 'Title': u'Watchdog'}
20:08:47 T:140165418923776 NOTICE: D:/Watchdog/Watchdog_20151029_19302030.ts
20:08:47 T:140165418923776 NOTICE: WakeOnAccess [192.168.0.146] trigged by accessing : smb://192.168.0.146/d/Watchdog/Watchdog_20151029_19302030.ts
20:08:47 T:140165418923776 NOTICE: WakeOnAccess success exit, server already running
20:08:47 T:140165418923776 NOTICE: not found
20:08:47 T:140165418923776 NOTICE: /live?recording=227708
20:08:47 T:140165418923776 NOTICE: Playing http://192.168.0.146:8866/live?recording=227708
20:08:47 T:140165418923776 NOTICE: <xbmcgui.ListItem object at 0x7f7ac461caa8>
20:08:47 T:140165418923776 NOTICE: player started
20:08:47 T:140165418923776 NOTICE: entering loop
20:08:47 T:140165932054400 INFO: easy_aquire - Created session to http://192.168.0.146
20:08:47 T:140165932054400 DEBUG: CCurlFile::GetMimeType - http://192.168.0.146:8866/live?recording=227708 -> video/MP2T


Chris

[mvallevand]

I have recently realised that "Path Substitution" is no longer working on both my OpenElec clients. I seem to be getting similar problem with smb failing and falling back to http. Was any conclusion reached about the problem?

20:08:47 T:140165418923776 NOTICE: #XBMCPlayer#
20:08:47 T:140165418923776 NOTICE: started player
20:08:47 T:140165418923776 NOTICE: {'tvshowtitle': None, 'Title': u'Watchdog'}
20:08:47 T:140165418923776 NOTICE: D:/Watchdog/Watchdog_20151029_19302030.ts
20:08:47 T:140165418923776 NOTICE: WakeOnAccess [192.168.0.146] trigged by accessing : smb://192.168.0.146/d/Watchdog/Watchdog_20151029_19302030.ts
20:08:47 T:140165418923776 NOTICE: WakeOnAccess success exit, server already running
20:08:47 T:140165418923776 NOTICE: not found
20:08:47 T:140165418923776 NOTICE: /live?recording=227708
20:08:47 T:140165418923776 NOTICE: Playing http://192.168.0.146:8866/live?recording=227708
20:08:47 T:140165418923776 NOTICE: <xbmcgui.ListItem object at 0x7f7ac461caa8>
20:08:47 T:140165418923776 NOTICE: player started
20:08:47 T:140165418923776 NOTICE: entering loop
20:08:47 T:140165932054400 INFO: easy_aquire - Created session to http://192.168.0.146
20:08:47 T:140165932054400 DEBUG: CCurlFile::GetMimeType - http://192.168.0.146:8866/live?recording=227708 -> video/MP2T


Chris

I suggest adding a CIFS share to the same folder //192.168.0.146/d/ and playing that same file from the library to see if the share itself is an issue. If not upload Kodi.log showing the playback.

Martin

[jcjefferies]

I am not 100% sure this is what you mean but in Kodi under Videos I created a link to smb://192.168.0.146/d/ and also replacing IP address with server name and I am able to play files on the D: drive of the server after I had entered a server user name and password.

I was wondering if the user name and password were the problem but I have always had a working link to D: so I can play some files as a video in Kodi. I deleted the original and recreated it to check.

I don't often play In Progress Recordings so don't know when it stopped working but I did change from Vista to Windows 8 about two months ago.

Chris