Film-Tech Cinema Systems
Film-Tech Forum ARCHIVE


  
my profile | my password | search | faq & rules | forum home
  next oldest topic   next newest topic
» Film-Tech Forum ARCHIVE   » Operations   » Digital Cinema Forum   » Barco DP2K-19B, lamp sometimes does not turn on (Page 1)

 
This topic comprises 2 pages: 1  2 
 
Author Topic: Barco DP2K-19B, lamp sometimes does not turn on
Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 07-31-2018 06:59 PM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
hi, a few months ago, one of our projectors (19B with alchemy server) started to not turn on the lamp occasionally. pressing the lamp button, the lamp started fine. happened about 5 times till last month, then i remove the lamp housing, reseated the lamp, cleaned the connectors, reseated all LPS cables, and then it worked fine for a month. today happened again.

on the log show as:

Jul 31 23:08:54 icmp-5626c9 user.warning SMS: Projector- read status failed on: lamp
Jul 31 23:08:59 icmp-5626c9 user.warning SMS: Projector- read status failed on: lamp runtime
Jul 31 23:09:03 icmp-5626c9 user.warning SMS: Projector- read status failed on: last executed macro
Jul 31 23:09:03 icmp-5626c9 user.warning SMS: Projector- read status failed on: dowser

don't know if is a software issue or hardware issue. the lamp is around 800h

any ideas?

here a full log of the show:
quote:
Jul 31 22:56:59 icmp-5626c9 user.info SM: SM- Security log event: Key::KDMDeleted
Jul 31 22:56:59 icmp-5626c9 user.info SM: SM- Security log event: Key::KDMDeleted
Jul 31 22:56:59 icmp-5626c9 user.info SM: SM- Security log event: Key::KDMDeleted
Jul 31 22:56:59 icmp-5626c9 user.notice SMS: SMS- admin@10.230.192.150:58276>clear() accepted
Jul 31 22:57:16 icmp-5626c9 user.notice SMS: SMS- admin@10.230.192.150:58276>select("SPL", "1b340b84-c640-440a-9173-c33e6aa18568") accepted
Jul 31 22:57:16 icmp-5626c9 user.warning SMS: Player- Unsupported cue behavior [volume 3.5]: - default punctual behavior used
Jul 31 22:57:16 icmp-5626c9 user.warning SMS: Player- Unsupported cue behavior [volume 4.0]: - default punctual behavior used
Jul 31 22:57:16 icmp-5626c9 user.warning SMS: Player- Unsupported cue behavior [volume 4.0]: - default punctual behavior used
Jul 31 22:57:17 icmp-5626c9 user.info SM: SM- Security log event: Validation::CPLCheck
Jul 31 22:57:19 icmp-5626c9 user.info SM: SM- Security log event: Key::KDMKeysReceived
Jul 31 22:57:19 icmp-5626c9 user.info SMS: Player- KDM [7668ae1f-ec11-46d6-a695-3e21901a6548] Security validation successful
Jul 31 22:57:21 icmp-5626c9 user.info SM: SM- Security log event: Key::KDMKeysReceived
Jul 31 22:57:22 icmp-5626c9 user.info SMS: Player- KDM [c964e4e5-1914-4d74-af47-d6d00ec01bbc] Security validation successful
Jul 31 22:57:22 icmp-5626c9 user.info SMS: Player- CPL [HotelTransyl3_FTR-2-3D_F_QBP-XX_BR_51-Dbox_2K_SPE_20180627_EKN_IOP-3D_VF] Security validation successful
Jul 31 22:57:22 icmp-5626c9 user.debug SM: SM- DEBUG:: KDM c964e4e5-1914-4d74-af47-d6d00ec01bbc
Jul 31 22:57:22 icmp-5626c9 user.info SMS: Report- |SHOW-SELECT| [14:40, 20:30) HOTEL 3D F DUB 2018.07.26_02:46_LEANDRO]
Jul 31 22:57:22 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 1500 - streams: AV
Jul 31 22:57:22 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 1500, status: 0)
Jul 31 22:57:22 icmp-5626c9 user.debug SMS: Player- Player subtitles: updating gip timeline: 00:00:00:000
Jul 31 23:01:59 icmp-5626c9 user.notice SMS: SMS- admin@10.230.192.150:58276>play() accepted
Jul 31 23:01:59 icmp-5626c9 user.debug SM: SM- DEBUG:: KDM c964e4e5-1914-4d74-af47-d6d00ec01bbc
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Player- Playback Security validation accepted
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Player- play settings: audio delay: 0 ms, freq: 48000 Hz - output size: AUTO
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Report- |SHOW-START| [14:40, 20:30) HOTEL 3D F DUB 2018.07.26_02:46_LEANDRO]
Jul 31 23:01:59 icmp-5626c9 user.debug SMS: Player- Player subtitles: set gip timeline: PLAY
Jul 31 23:01:59 icmp-5626c9 user.err GIP: Starting play while image is blanked
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Report- |CUE| ["USER_CUE" "SCOPE"] from [SHOW]: 3 action(s)
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Automation- Executing action ["PROJECTOR" "Execute Macro"( "SCOPE" )]
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Report- |CUE| ["USER_CUE" "volume 3.5"] from [SHOW]: 1 action(s)
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Report- |PLAYING| [Black]
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Automation- Executing action ["PROJECTOR" "Open Dowser"( )]
Jul 31 23:01:59 icmp-5626c9 user.info SMS: Automation- Executing action ["PROJECTOR" "Turn Lamp On"( )]
Jul 31 23:02:00 icmp-5626c9 user.info SMS: Automation- Executing action ["CP750" "Send Text"( "cp750.sys.fader 35" )]
Jul 31 23:02:00 icmp-5626c9 user.info SMS: Player- received GIP input selection request: input 0
Jul 31 23:02:00 icmp-5626c9 user.debug SM: IMB Controller- switchToInputSource [Media Player]: switching... (not playing)
Jul 31 23:02:00 icmp-5626c9 user.info SMS: Player- select input source [Media Player] successful
Jul 31 23:02:00 icmp-5626c9 user.info SMS: Player- received GIP input selection request: input 0
Jul 31 23:02:00 icmp-5626c9 user.debug SM: IMB Controller- switchToInputSource [Media Player]: switching...
Jul 31 23:02:00 icmp-5626c9 user.info SMS: Player- select input source [Media Player] successful
Jul 31 23:02:00 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:02:00 icmp-5626c9 user.info GIP: Scaling the image from 2048 x 858 to 2048 x 858
Jul 31 23:02:00 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:02:00 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:02:00 icmp-5626c9 user.info GIP: TLPF = 1936, TPPL = 3252, APPL = 2048, ALPF = 858, framerate = 4800 (4800)
Jul 31 23:02:03 icmp-5626c9 user.warning SMS: Projector- read status failed on: lamp runtime
Jul 31 23:02:03 icmp-5626c9 user.info GIP: Loading active file : DCDM_XYZ_239
Jul 31 23:02:03 icmp-5626c9 user.info GIP: Scaling the image from 2048 x 858 to 2048 x 858
Jul 31 23:02:03 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:02:03 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:02:03 icmp-5626c9 user.info GIP: TLPF = 1936, TPPL = 3252, APPL = 2048, ALPF = 858, framerate = 4800 (4800)
Jul 31 23:02:03 icmp-5626c9 user.info GIP: Loading active file : SCOPE
Jul 31 23:02:03 icmp-5626c9 user.info GIP: Loading active file : No3D
Jul 31 23:02:03 icmp-5626c9 user.info GIP: loading a new sequence, set 2, element index 0, frametime 97 Hz.
Jul 31 23:02:03 icmp-5626c9 user.info GIP: loading a new sequence, set 1, element index 6, frametime 51 Hz.
Jul 31 23:02:03 icmp-5626c9 user.info GIP: Loading active file : Nominal
Jul 31 23:02:54 icmp-5626c9 user.info SMS: Report- |CUE| ["USER_CUE" "LUZ - INICIO SHOW"] from [SHOW]: 1 action(s)
Jul 31 23:02:54 icmp-5626c9 user.info SMS: Automation- Executing action ["GPIO" "Set Outputs"( "Unset", "Unset", "Unset", "Unset", "Unset", "Down", "Up", "Up" )]
Jul 31 23:02:59 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 1500, status: 2)
Jul 31 23:02:59 icmp-5626c9 user.info SMS: Report- |PLAYING| [ RDMIER_CONTINUE_SONHANDO_SCOPE]
Jul 31 23:02:59 icmp-5626c9 user.debug SM: SM- Audio input mux: 0 1 - - - - - - - - - - - - - -
Jul 31 23:02:59 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:02:59 icmp-5626c9 user.info GIP: Scaling the image from 2048 x 858 to 2048 x 858
Jul 31 23:02:59 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:02:59 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:02:59 icmp-5626c9 user.info GIP: TLPF = 3872, TPPL = 3252, APPL = 2048, ALPF = 858, framerate = 2400 (2400)
Jul 31 23:02:59 icmp-5626c9 user.info GIP: loading a new sequence, set 1, element index 0, frametime 25 Hz.
Jul 31 23:02:59 icmp-5626c9 user.info SMS: Player- set gip media player timings: 2048x858, 24 fps, XYZ, 2D, standalone, LTC on
Jul 31 23:03:00 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 1500 - CPL frame offset: 1500
Jul 31 23:03:00 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=5ec wd1=104000 FifoLevelAboveThreshold 16
Jul 31 23:03:00 icmp-5626c9 user.info SMS: SMS- preload: 112 AV frames
Jul 31 23:03:00 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=412245 wd1=17737 J2KtoMemBufferThresholdReached VideoFifo=69 AudioFifo=68 Audio2MemFifo=4
Jul 31 23:03:00 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:03:01 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, state: playing
Jul 31 23:03:01 icmp-5626c9 user.info SM: SM- Auro: no license - decoder disabled
Jul 31 23:03:25 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 2577 - CPL frame offset: 2577
Jul 31 23:03:25 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 2577, status: 2)
Jul 31 23:03:45 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:03:45 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:03:45 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: 69396939 - 00796939 - 61792052 - 00522052
Jul 31 23:03:45 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:03:45 icmp-5626c9 user.info SMS: Report- |PLAYING| [LEFFA_MOVEIS_SCOPE_2]
Jul 31 23:04:23 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 4027 - streams: AV
Jul 31 23:04:24 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 4026, status: 0)
Jul 31 23:04:29 icmp-5626c9 user.notice GIP: B log mark - 0000003732f9 - #015#012
Jul 31 23:04:46 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:04:46 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:04:46 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: 25a025a0 - 00b125a0 - 11b12067 - 00672067
Jul 31 23:04:46 icmp-5626c9 user.debug SM: IMB Controller- Notify STOPPED state for frame 4026
Jul 31 23:04:46 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, previous value: 1, state: stopped
Jul 31 23:04:46 icmp-5626c9 user.info SMS: Report- |PLAYING| [MONTE_BELLO_SCOPE]
Jul 31 23:04:46 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 4027, status: 2)
Jul 31 23:04:46 icmp-5626c9 user.debug SM: SM- Audio input mux: 0 1 - - - - - - - - - - - - - -
Jul 31 23:04:46 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:04:46 icmp-5626c9 user.info SMS: Player- set gip media player timings: 2048x858, 30 fps, XYZ, 2D, standalone, LTC on
Jul 31 23:04:46 icmp-5626c9 user.info GIP: Scaling the image from 2048 x 858 to 2048 x 858
Jul 31 23:04:46 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:04:46 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:04:46 icmp-5626c9 user.info GIP: TLPF = 3099, TPPL = 3252, APPL = 2048, ALPF = 858, framerate = 3000 (3000)
Jul 31 23:04:46 icmp-5626c9 user.info GIP: loading a new sequence, set 1, element index 2, frametime 31 Hz.
Jul 31 23:04:46 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 4027 - CPL frame offset: 4027
Jul 31 23:04:46 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=fcb wd1=104000 FifoLevelAboveThreshold 16
Jul 31 23:04:47 icmp-5626c9 user.info SMS: SMS- preload: 130 AV frames
Jul 31 23:04:47 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=412b56 wd1=16eef J2KtoMemBufferThresholdReached VideoFifo=86 AudioFifo=86 Audio2MemFifo=4
Jul 31 23:04:47 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:04:47 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, state: playing
Jul 31 23:04:47 icmp-5626c9 user.info SM: SM- Auro: no license - decoder disabled
Jul 31 23:05:16 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 5497 - streams: AV
Jul 31 23:05:16 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 5496, status: 0)
Jul 31 23:05:36 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:05:36 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:05:36 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: 981a981a - 0022981a - 282220eb - 00eb20eb
Jul 31 23:05:36 icmp-5626c9 user.debug SM: IMB Controller- Notify STOPPED state for frame 5496
Jul 31 23:05:36 icmp-5626c9 user.info SMS: Report- |PLAYING| [NOSSA_CASA_SCOPE]
Jul 31 23:05:36 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 5497, status: 2)
Jul 31 23:05:36 icmp-5626c9 user.debug SM: SM- Audio input mux: 0 1 - - - - - - - - - - - - - -
Jul 31 23:05:36 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:05:36 icmp-5626c9 user.info GIP: Scaling the image from 2048 x 858 to 2048 x 858
Jul 31 23:05:36 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:05:36 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:05:36 icmp-5626c9 user.info GIP: TLPF = 3872, TPPL = 3252, APPL = 2048, ALPF = 858, framerate = 2400 (2400)
Jul 31 23:05:36 icmp-5626c9 user.info SMS: Player- set gip media player timings: 2048x858, 24 fps, XYZ, 2D, standalone, LTC on
Jul 31 23:05:36 icmp-5626c9 user.info GIP: loading a new sequence, set 1, element index 0, frametime 25 Hz.
Jul 31 23:05:36 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, previous value: 1, state: stopped
Jul 31 23:05:37 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 5497 - CPL frame offset: 5497
Jul 31 23:05:37 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=1589 wd1=104000 FifoLevelAboveThreshold 16
Jul 31 23:05:37 icmp-5626c9 user.info SMS: SMS- preload: 112 AV frames
Jul 31 23:05:37 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=12244 wd1=15e5f J2KtoMemBufferThresholdReached VideoFifo=68 AudioFifo=68 Audio2MemFifo=4
Jul 31 23:05:37 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:05:37 icmp-5626c9 user.info SMS: Report- |CUE| ["USER_CUE" "volume 4.0"] from [SHOW]: 1 action(s)
Jul 31 23:05:37 icmp-5626c9 user.info SMS: Automation- Executing action ["CP750" "Send Text"( "cp750.sys.fader 40" )]
Jul 31 23:05:37 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, state: playing
Jul 31 23:05:38 icmp-5626c9 user.info SM: SM- Auro: no license - decoder disabled
Jul 31 23:05:38 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 5928, status: 0)
Jul 31 23:05:38 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 5929 - streams: AV
Jul 31 23:05:55 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:05:55 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:05:55 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: e909e909 - 00dde909 - e8dd20bc - 00bc20bc
Jul 31 23:05:55 icmp-5626c9 user.debug SM: IMB Controller- Notify STOPPED state for frame 5928
Jul 31 23:05:55 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 5929, status: 2)
Jul 31 23:05:55 icmp-5626c9 user.info SMS: Report- |PLAYING| [WreckItRalph2_TLR-G-2D_S_QBP-XX_BR_51_2K_DI_20180601_DDS_IOP]
Jul 31 23:05:55 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, previous value: 1, state: stopped
Jul 31 23:05:56 icmp-5626c9 user.debug SM: SM- Audio input mux: 0 1 2 3 4 5 - - - - - - - - - -
Jul 31 23:05:56 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:05:56 icmp-5626c9 user.info SMS: Player- set gip media player timings: 2048x858, 24 fps, XYZ, 2D, standalone, LTC on
Jul 31 23:05:56 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 5929 - CPL frame offset: 5929
Jul 31 23:05:56 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=1739 wd1=104000 FifoLevelAboveThreshold 16
Jul 31 23:05:57 icmp-5626c9 user.info SMS: SMS- preload: 112 AV frames
Jul 31 23:05:57 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=12244 wd1=14a4b J2KtoMemBufferThresholdReached VideoFifo=68 AudioFifo=68 Audio2MemFifo=4
Jul 31 23:05:57 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:05:57 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, state: playing
Jul 31 23:05:57 icmp-5626c9 user.info SM: SM- Auro: no license - decoder disabled
Jul 31 23:08:01 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 9433 - CPL frame offset: 9433
Jul 31 23:08:01 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 9433, status: 2)
Jul 31 23:08:23 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:08:23 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:08:23 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: abb8abb8 - 0007abb8 - 490720d3 - 00d320d3
Jul 31 23:08:23 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:08:23 icmp-5626c9 user.info SMS: Report- |PLAYING| [ALFA_TLR-A-2D_S_QBP-XX_51_2K_SPE_20170719_AUW_IOP_OV]
Jul 31 23:08:54 icmp-5626c9 user.warning SMS: Projector- read status failed on: lamp
Jul 31 23:08:59 icmp-5626c9 user.warning SMS: Projector- read status failed on: lamp runtime
Jul 31 23:09:03 icmp-5626c9 user.warning SMS: Projector- read status failed on: last executed macro
Jul 31 23:09:03 icmp-5626c9 user.warning SMS: Projector- read status failed on: dowser
Jul 31 23:09:58 icmp-5626c9 user.info GIP: RSC controller- Sequencer (--B) is stopped unexpectedly, restarting all...
Jul 31 23:10:38 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 13022 - CPL frame offset: 13022
Jul 31 23:10:38 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 13022, status: 2)
Jul 31 23:10:53 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:10:53 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:10:53 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: 91c691c6 - 002091c6 - 262020aa - 00aa20aa
Jul 31 23:10:53 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:10:53 icmp-5626c9 user.info SMS: Report- |PLAYING| [HwToTrnYrDrgn3_TLR-A-2D_S_QBP-XX_BR_51_2K_UP_20180611_MPS_IOP_OV]
Jul 31 23:12:49 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 16527 - streams: AV
Jul 31 23:12:51 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 16526, status: 0)
Jul 31 23:13:19 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:13:19 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:13:19 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: ea14ea14 - 001cea14 - 0b1c20ec - 00ec20ec
Jul 31 23:13:19 icmp-5626c9 user.debug SM: IMB Controller- Notify STOPPED state for frame 16526
Jul 31 23:13:19 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, previous value: 1, state: stopped
Jul 31 23:13:19 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 16527, status: 2)
Jul 31 23:13:19 icmp-5626c9 user.info SMS: Report- |PLAYING| [TheMeg_TLR-F1-2D_S_QBP-XX_BR_51_2K_WR_20180625_DTB_IOP_OV]
Jul 31 23:13:19 icmp-5626c9 user.debug SM: SM- Audio input mux: 0 1 2 3 4 5 21 20 - - - - - - - -
Jul 31 23:13:19 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:13:19 icmp-5626c9 user.info SMS: Player- set gip media player timings: 2048x858, 24 fps, XYZ, 2D, standalone, LTC on
Jul 31 23:13:19 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 16527 - CPL frame offset: 16527
Jul 31 23:13:19 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=409f wd1=104000 FifoLevelAboveThreshold 16
Jul 31 23:13:20 icmp-5626c9 user.info SMS: SMS- preload: 112 AV frames
Jul 31 23:13:20 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=412244 wd1=163e4 J2KtoMemBufferThresholdReached VideoFifo=68 AudioFifo=68 Audio2MemFifo=4
Jul 31 23:13:20 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:13:20 icmp-5626c9 user.info SM: SM- Auro: no license - decoder disabled
Jul 31 23:13:20 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, state: playing
Jul 31 23:15:23 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 20043 - CPL frame offset: 16527
Jul 31 23:15:23 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 20043, status: 2)
Jul 31 23:15:25 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 20665 - streams: AV
Jul 31 23:15:25 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 20164, status: 0)
Jul 31 23:15:47 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: e209e209 - 0084e209 - 84842060 - 00602060
Jul 31 23:15:52 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:15:52 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:15:52 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: 47764776 - 00b14776 - bdb1209f - 009f209f
Jul 31 23:15:52 icmp-5626c9 user.debug SM: IMB Controller- Notify STOPPED state for frame 20164
Jul 31 23:15:52 icmp-5626c9 user.info SMS: Report- |PLAYING| [Black]
Jul 31 23:15:52 icmp-5626c9 user.info SMS: Report- |CUE| ["USER_CUE" "FLAT 3D"] from [SHOW]: 3 action(s)
Jul 31 23:15:52 icmp-5626c9 user.info SMS: Automation- Executing action ["PROJECTOR" "Execute Macro"( "3D_FLAT" )]
Jul 31 23:15:52 icmp-5626c9 user.info SMS: Automation- Executing action ["PROJECTOR" "Turn Lamp On"( )]
Jul 31 23:15:52 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, previous value: 1, state: stopped
Jul 31 23:15:52 icmp-5626c9 user.info SMS: Automation- Executing action ["PROJECTOR" "Open Dowser"( )]
Jul 31 23:15:52 icmp-5626c9 user.info SMS: Player- received GIP input selection request: input 0
Jul 31 23:15:52 icmp-5626c9 user.debug SM: IMB Controller- switchToInputSource [Media Player]: switching... (not playing)
Jul 31 23:15:52 icmp-5626c9 user.info SMS: Player- select input source [Media Player] successful
Jul 31 23:15:53 icmp-5626c9 user.info SMS: Player- received GIP input selection request: input 0
Jul 31 23:15:53 icmp-5626c9 user.debug SM: IMB Controller- switchToInputSource [Media Player]: switching...
Jul 31 23:15:53 icmp-5626c9 user.info SMS: Player- select input source [Media Player] successful
Jul 31 23:15:53 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Scaling the image from 2048 x 858 to 2048 x 858
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:15:53 icmp-5626c9 user.info GIP: TLPF = 3872, TPPL = 3252, APPL = 2048, ALPF = 858, framerate = 2400 (2400)
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Loading active file : DCDM_XYZ_185
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Scaling the image from 2000 x 1080 to 2000 x 1080
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:15:53 icmp-5626c9 user.info GIP: TLPF = 3872, TPPL = 3252, APPL = 1998, ALPF = 1080, framerate = 2400 (2400)
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Loading active file : FLAT
Jul 31 23:15:53 icmp-5626c9 user.info GIP: Loading active file : VOLFONI
Jul 31 23:15:53 icmp-5626c9 user.info GIP: loading a new sequence, set 8, element index 0, frametime 24 Hz.
Jul 31 23:15:54 icmp-5626c9 user.info GIP: Loading active file : MeasuredColors
Jul 31 23:15:57 icmp-5626c9 user.info GIP: EtherAcceptConnection on the port 43680 from client 10.230.192.150
Jul 31 23:15:57 icmp-5626c9 user.info GIP: EtherMain - Started EtherLoop thread
Jul 31 23:16:12 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 20665, status: 2)
Jul 31 23:16:12 icmp-5626c9 user.info SMS: Report- |PLAYING| [OCULOS_3D_FLAT]
Jul 31 23:16:12 icmp-5626c9 user.debug SM: SM- Audio input mux: - - - - - - - - - - - - - - - -
Jul 31 23:16:12 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:16:12 icmp-5626c9 user.info GIP: Scaling the image from 2000 x 1080 to 2000 x 1080
Jul 31 23:16:12 icmp-5626c9 user.info GIP: Horizontal downscale sequence = 1 (x 1.00), Vertical downscale sequence = 1 (x 1.00)
Jul 31 23:16:12 icmp-5626c9 user.info GIP: Loading the framereader with following new timings
Jul 31 23:16:12 icmp-5626c9 user.info GIP: TLPF = 1936, TPPL = 3252, APPL = 1998, ALPF = 1080, framerate = 4800 (4800)
Jul 31 23:16:12 icmp-5626c9 user.info GIP: loading a new sequence, set 9, element index 1, frametime 28 Hz.
Jul 31 23:16:12 icmp-5626c9 user.info SMS: Player- set gip media player timings: 1998x1080, 48 fps, XYZ, 3D, standalone, LTC on
Jul 31 23:16:12 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 20665 - CPL frame offset: 20665
Jul 31 23:16:12 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=50c1 wd1=104000 FifoLevelAboveThreshold 16
Jul 31 23:16:13 icmp-5626c9 user.info SMS: SMS- preload: 112 AV frames
Jul 31 23:16:13 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=40007f wd1=1712e J2KtoMemBufferThresholdReached VideoFifo=127 AudioFifo=0 Audio2MemFifo=0
Jul 31 23:16:13 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:16:13 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 20810 - streams: AV
Jul 31 23:16:13 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 20809, status: 0)
Jul 31 23:16:13 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, state: playing
Jul 31 23:16:14 icmp-5626c9 user.info GIP: 3D-sync- PulseWidth error detected, sync3D_err = 1, 0
Jul 31 23:16:15 icmp-5626c9 user.info SMS: SMS- Login attempt from 10.230.192.150:54296 (User barco)
Jul 31 23:16:15 icmp-5626c9 user.notice SMS: SMS- >login("barco", "") accepted
Jul 31 23:16:19 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLEnd
Jul 31 23:16:19 icmp-5626c9 user.info SM: SM- Security log event: Playout::PlayoutComplete
Jul 31 23:16:19 icmp-5626c9 user.debug SM: IMB Event- End of track CRC values: ff32ff32 - 00b1ff32 - bdb1cacd - 00b4cacd
Jul 31 23:16:19 icmp-5626c9 user.debug SM: IMB Controller- Notify STOPPED state for frame 20809
Jul 31 23:16:19 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 20810, status: 2)
Jul 31 23:16:19 icmp-5626c9 user.info SMS: Report- |PLAYING| [SR_VAPOR2_FLAT_3D]
Jul 31 23:16:19 icmp-5626c9 user.debug SM: SM- Audio input mux: 0 1 - - - - - - - - - - - - - -
Jul 31 23:16:19 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, previous value: 1, state: stopped
Jul 31 23:16:19 icmp-5626c9 user.info GIP: LTC sync- set LTC SMPTE-12M out
Jul 31 23:16:19 icmp-5626c9 user.info SMS: Player- set gip media player timings: 1998x1080, 48 fps, XYZ, 3D, standalone, LTC on
Jul 31 23:16:20 icmp-5626c9 user.debug SM: IMB Controller- CPL offset update: frame id: 20810 - CPL frame offset: 20810
Jul 31 23:16:20 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=5152 wd1=104000 FifoLevelAboveThreshold 16
Jul 31 23:16:20 icmp-5626c9 user.info SMS: SMS- preload: 112 AV frames
Jul 31 23:16:20 icmp-5626c9 user.debug SM: IMB Event- Monitoring event wd0=60a37f wd1=15292 J2KtoMemBufferThresholdReached VideoFifo=127 AudioFifo=70 Audio2MemFifo=2
Jul 31 23:16:21 icmp-5626c9 user.info SM: SM- Security log event: Playout::CPLStart
Jul 31 23:16:21 icmp-5626c9 user.info SM: SM- ADSP: SPORT resync counter: 1, state: playing
Jul 31 23:16:21 icmp-5626c9 user.debug SM: IMB Controller- Sync Payload Updated (frameId: 20988, status: 0)
Jul 31 23:16:21 icmp-5626c9 user.debug SMS: Player- starting streams at frame id: 20989 - streams: AV
Jul 31 23:16:21 icmp-5626c9 user.info SM: SM- Auro: no license - decoder disabled


 |  IP: Logged

Dave Macaulay
Film God

Posts: 2321
From: Toronto, Canada
Registered: Apr 2001


 - posted 08-01-2018 12:04 AM      Profile for Dave Macaulay   Email Dave Macaulay   Send New Private Message       Edit/Delete Post 
That's a lot of logs. I see lamp runtime read fails. This is stored in the lamphouse data module - the little PCB on the lamphouse. Maybe it's going bad, maybe there's a bad connection to the lampouse or backplane. Clean the lamphouse connector and the connector that mates with it (mutlicontact blue or white connectors). If you feel competent reseat the other end of the lamphouse cable to the backplane - either behind the air filter or under the top lid, not sure but think it's behind the filter.
Check lamp hours in installation/lamp/lamp information - if the numbers seem reasonable then it's reading the data but apparently sometimes it fails.
Reseating all the boards is a good plan whenever anything weird and intermittent happens.
You need the Dallas key and authorization passcode before opening the inner covers or pulling boards out, no show afterwards without those.

 |  IP: Logged

Steve Guttag
We forgot the crackers Gromit!!!

Posts: 12814
From: Annapolis, MD
Registered: Dec 1999


 - posted 08-01-2018 12:45 AM      Profile for Steve Guttag   Email Steve Guttag   Send New Private Message       Edit/Delete Post 
I suspect that the lamphouse isn't in all of the way and you are getting intermittent connections on the lamphouse data connector. Make sure that the right hand screw is fully screwed in and that the lamphouse really seats all of the way in.

 |  IP: Logged

Stephan Shelley
Jedi Master Film Handler

Posts: 854
From: castro valley, CA, usa
Registered: Nov 2014


 - posted 08-01-2018 01:25 PM      Profile for Stephan Shelley   Email Stephan Shelley   Send New Private Message       Edit/Delete Post 
In addition to the above make sure you are on the latest software for the cinema controller and lamp supplies. It has been several years but there was an update back then that updated the lamp supplies and stabilized lamp operation.

 |  IP: Logged

Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 08-02-2018 07:30 PM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
thanks for the answer guys. i cleaned all contacts, including the blue one, and reseated the boards and connectors, including the on in the lamphouse circuit. everything looks clean, but only time will tell now.

i will ask for the installers to do a remote update on everything, as it is beyond my knowledge and responsibility [Wink]

 -

 |  IP: Logged

Leo Enticknap
Film God

Posts: 7474
From: Loma Linda, CA
Registered: Jul 2000


 - posted 08-02-2018 10:22 PM      Profile for Leo Enticknap   Author's Homepage   Email Leo Enticknap   Send New Private Message       Edit/Delete Post 
Do you have another bulb (or even better, another lamphouse module containing a bulb of the same size) that you could swap in to test?

I encountered something similar on a DP2K-32B a couple of months ago, and to cut a long story short, it turned out to be a bad bulb. Bulb failed to strike (brief flash as the SPG fired, then nothing). A wild goose chase was started by the presence of red lights on two of the three lamp power supply modules. So I naturally suspected them first, and swapped in two from another screen's projector. Same result. Then I suspected the SPG and swapped that out, again. Still no joy. The bulb was literally about the last thing I tried, despite being the easiest part to check. As it had been replaced four days prior and had only done 60 hours, I simply assumed that it couldn't be the culprit. It was.

 |  IP: Logged

Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 08-02-2018 10:54 PM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
but it was giving similar errors as mine or just "could not turn lamp on" kind of error?

we have two screens with the same 19b, swap the entire housing is not a bad idea... [Wink]

 |  IP: Logged

Leo Enticknap
Film God

Posts: 7474
From: Loma Linda, CA
Registered: Jul 2000


 - posted 08-03-2018 08:17 AM      Profile for Leo Enticknap   Author's Homepage   Email Leo Enticknap   Send New Private Message       Edit/Delete Post 
I was just getting "Sorry pal, can't strike." From the errors you describe, I'm leaning towards the info module.

If you have another lamphouse, then if swapping them doesn't get you any further forward, the experiment only cost you 2-3 minutes, and even for that price you get three potential causes ruled out.

However, if the problem swaps with them, you've narrowed it down to one of those three causes:

- A bad bulb
- A bad bulb info module
- As Steve suggests, a bad connection between the lamphouse and the projector chassis (either the cathode or anode, or the info module connector).

 |  IP: Logged

Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 08-08-2018 07:48 PM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
we will exchange the lamphouses between the projectors as suggested, see "which one will break first" [Wink]

thanks for the help so far guys!

 |  IP: Logged

Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 08-24-2018 04:47 PM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
today we got the problem again. changing the lamphouse between projectors did not fix the problem. (still happening in the same projector) the log:

local0.err dp61[2073]: lamp - lamp on failed (no or invalid lim data)
local0.err dp61[2073]: lamp - no communication (#5004)
local0.err dp61[2073]: lamp run time - read failed (#5654)
local0.err dp61[2073]: lamp run time - read limits failed (#5658)

had to power off the projector to make i turn on (resetting the server did not solve)

maybe change the power supplies perhaps?

 |  IP: Logged

Monte L Fullmer
Film God

Posts: 8367
From: Nampa, Idaho, USA
Registered: Nov 2004


 - posted 08-24-2018 05:11 PM      Profile for Monte L Fullmer   Email Monte L Fullmer   Send New Private Message       Edit/Delete Post 
You would have a "can't detect one of the LPS" error message if power supplies are bad.

It has to be that blue connector, or the on board computer on the module, to the projector that isn't doing its thing.

It also could be the socket on the projector that could have gone bad.

Check the wiring that feeds that outlet by taking off the igniter plate. One connector could have been pushed by the plug on the module in to make this erratic contact issue, or the total connection itself isn't faring too well by the module not being pushed in all the way. I usually gauge the distance between the air outlet square duct to the right being almost a fit tight gap to the air entrance on the module. Any wider gap tells me that the module isn't all the way in where I have to pull the module out to get reseated.

 |  IP: Logged

Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 10-02-2018 12:22 AM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
finally the technicians updated remotely, we re-seated all boards and cleaned all contacts and verified all the plugs (as
Monte suggested). comparing with the other 19b, the placement of connectors and everything else is as should be. let's wait and see if the problem reappear [Wink]

the funny thing is, on the same morning they updated remotely, the other projector we had was also updated. but then it got a tons of errors on the voltage rails and etc (24v led was blinking and fans where stopping). Initially i was sure they updated and did something wrong, the projector is running fine for 2 years, and it show problems ON THE SAME MORNING they updated??? well, reviewing the logs, was really just a coincidence. after a lot of back and forth boards with the other projector, to find the problems, the cinema controller and fan controller boards where the problem. they replaced now and is all good [Wink] (fingers crossed)

 |  IP: Logged

Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 10-29-2018 12:53 AM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
the 19B since then did not show any problem turning on the lamp.

but a few days ago, the projector status led became "blinking green", and the projector did not do a proper startup cycle, freezing forever on the led blinking green. the control panel buttons did not lit up. no response trying to connect to communicator. (the hardware error led stayed lit)

after hours swapping boards with the other 19b, the problem was discovered to be the control panel. (disconnecting it the projector did a proper power up). after further digging, the cause was the button above the dallas key slot was oxidated, and was permanently pressed. cleaning it and fixing the button the projector is now fully working.

well, not fully, strangely, the left smps fan failed a few weeks ago. then yesterday the same cooler on the other 19b failed too. so weird.

 |  IP: Logged

Carsten Kurz
Film God

Posts: 4340
From: Cologne, NRW, Germany
Registered: Aug 2009


 - posted 10-29-2018 05:35 AM      Profile for Carsten Kurz   Email Carsten Kurz   Send New Private Message       Edit/Delete Post 
Maybe you have very unfortunate environmental conditions there?

- Carsten

 |  IP: Logged

Marlon Martins
Film Handler

Posts: 78
From: Torres, RS, Brazil
Registered: Apr 2015


 - posted 10-29-2018 06:29 AM      Profile for Marlon Martins   Email Marlon Martins   Send New Private Message       Edit/Delete Post 
Yes, 2 blocks from the beach. [Frown]

but we have air filters in the air inlets to the projectors rooms.

 |  IP: Logged



All times are Central (GMT -6:00)
This topic comprises 2 pages: 1  2 
 
   Close Topic    Move Topic    Delete Topic    next oldest topic   next newest topic
 - Printer-friendly view of this topic
Hop To:



Powered by Infopop Corporation
UBB.classicTM 6.3.1.2

The Film-Tech Forums are designed for various members related to the cinema industry to express their opinions, viewpoints and testimonials on various products, services and events based upon speculation, personal knowledge and factual information through use, therefore all views represented here allow no liability upon the publishers of this web site and the owners of said views assume no liability for any ill will resulting from these postings. The posts made here are for educational as well as entertainment purposes and as such anyone viewing this portion of the website must accept these views as statements of the author of that opinion and agrees to release the authors from any and all liability.

© 1999-2020 Film-Tech Cinema Systems, LLC. All rights reserved.