CoreMediaErrorDomain -12035 error when playing a Fairplay-protected HLS stream on iOS 18+ through the Apple lightning AV Adapter

Question

Created Dec ’24

Replies 5

Boosts 2

Participants 5

Our iOS/AppleTV video content playback app uses AVPlayer to play HLS video streams and supports both custom and system playback UIs. The Fairplay content key is retrieved using AVContentKeySession. AirPlay is supported too.

When the iPhone is connected to a TV through the lightning Apple Digital AV Adapter (A1438), the app is mirrored as expected.

Problem: when using an iPhone or iPad on iOS 18.1.1, FairPlay-protected HLS streams are not played and a CoreMediaErrorDomain -12035 error is received by the AVPlayerItem. Also, once the issue has occurred, the mirroring freezes (the TV indefinitely displays the app playback screen) although the app works fine on the iOS device.

The content key retrieval works as expected (I can see that 2 content key requests are made by the system by the way, probably one for the local playback and one for the adapter, as when AirPlaying) and the error is thrown after providing the AVContentKeyResponse.

Unfortunately, and as far as I know, there is not documentation on CoreMediaErrorDomain errors so I don't know what -12035 means.

The issue does not occur:

on an iPhone on iOS 17.7 (even with FairPlay-protected HLS streams)
when playing DRM-free video content (whatever the iOS version)
when using the USB-C AV Adapter (whatever the iOS version)

Also worth noting: the issue does not occur with other video playback apps such as Apple TV or Netflix although I don't have any details on the kind of streams these apps play and the way the FairPlay content key is retrieved (if any) so I don't know if it is relevant.

Boost

Answer 1

Engineer OP

Apple

Dec ’24

Hello @patatrouf, thank you for your post. Our engineering teams need to investigate this issue, as resolution may involve changes to Apple's software. I'd greatly appreciate it if you could open a bug report, include a sysdiagnose, and post the FB number here once you do. Bug Reporting: How and Why? has tips on creating your bug report.

0

Answer 2

patatrouf OP

Dec ’24

Thanks for your response.

I filed a bug report on Feedback Assistant with the following id: FB16047318 (CoreMediaErrorDomain -12035 error when playing a Fairplay-protected HLS stream on iOS 18+ through the Apple lightning AV Adapter).

0

Answer 3

Yuchih_Liu OP

3w

Hello @patatrouf,

I’m also encountering this issue. Have there been any updates or responses from Apple regarding a fix or workaround?

Thank you for sharing any progress!

0

Answer 4

iptv OP

2w

Hi all,

We are also encountering this issue starting from iOS 18.1.1, the issue still exists with iOS 18.3.1 on iPhone 14 Pro.

Attaching a console log for investigation.

12035 error

default	11:02:46.282742+0800	mediaplaybackd	[0xb183aa440] activating connection: mach=false listener=false peer=true name=com.apple.coremedia.mediaplaybackd.asset.xpc.peer[858].0xb183aa440
default	11:02:46.282969+0800	mediaplaybackd	[0xb183a9680] activating connection: mach=false listener=false peer=true name=com.apple.xpc.anonymous.0xb183a8140.peer[858].0xb183a9680
default	11:02:46.283143+0800	mediaplaybackd	<<<< FigProcessStateMonitorServer >>>> fpsmServer_createCompanion: Created companion  {
	MEMRC="(null)",
	ENRD="(null)", AC="0", PS="NT", MRP="0@(null)",
}
default	11:02:46.283179+0800	mediaplaybackd	<<<< FigProcessStateMonitorServer >>>> figProcessStateMonitorHandleCreate: client:858 companion: {
	MEMRC="(null)",
	ENRD="(null)", AC="0", PS="NT", MRP="0@(null)",
} err:0
default	11:02:46.283581+0800	mediaplaybackd	[0xb185e0900] activating connection: mach=false listener=false peer=true name=com.apple.coremedia.mediaplaybackd.sandboxserver.xpc.peer[858].0xb185e0900
default	11:02:46.283818+0800	mediaplaybackd	<<< URLAsset >>> FigAssetCreateWithURL: Called for asset 0xb18313380 by client DRMSample, url [0xb183d7080]  createFlags 0x8 optionsDict (null)
default	11:02:46.284145+0800	mediaplaybackd	Updating configuration of monitor M583-6
default	11:02:46.284614+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: Created state monitor: 
default	11:02:46.284662+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18410b20>
default	11:02:46.284704+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18412320>
default	11:02:46.284734+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18412680>
default	11:02:46.284758+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18412240>
default	11:02:46.284781+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18412f60>
default	11:02:46.284806+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18413220>
default	11:02:46.284843+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18412de0>
default	11:02:46.284892+0800	mediaplaybackd	Received state update for 858 (app, running-active-Visible
default	11:02:46.284919+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb184114a0>: 
default	11:02:46.285043+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: Using existing monitor: 
default	11:02:46.285068+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18412de0>: 
default	11:02:46.285312+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> FigCustomURLLoaderCreate: newLoader: 0xb182dd440
default	11:02:46.285346+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18412240>: 
default	11:02:46.285629+0800	mediaplaybackd	[0xb185e2d00] activating connection: mach=false listener=false peer=true name=com.apple.coremedia.mediaplaybackd.customurlloader.xpc.peer[858].0xb185e2d00
default	11:02:46.286470+0800	mediaplaybackd	[0xb183ab5c0] activating connection: mach=false listener=false peer=false name=(anonymous)
default	11:02:46.286750+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> FigCustomURLHandlerCreate: newHandler: FigCustomURLHandlerRemoteShim.0xb18035880 options: (null)
default	11:02:46.286775+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_installHandler: 0xb182dd460: handler: 0xb181786e0 priority: 100
default	11:02:46.286873+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> FigCustomURLHandlerCreate: newHandler: FigCustomURLHandlerRemoteShim.0xb18035c80 options: (null)
default	11:02:46.286897+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_installHandler: 0xb182dd460: handler: 0xb18178eb0 priority: 800
default	11:02:46.287333+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> FigCustomURLHandlerCreate: newHandler: FigCustomURLHandlerRemoteShim.0xb18035500 options: {
}
default	11:02:46.287357+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_installHandler: 0xb182dd460: handler: 0xb18178550 priority: 600
default	11:02:46.287575+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> FigCustomURLHandlerCreate: newHandler: FigCustomURLHandlerRemoteShim.0xb18036680 options: (null)
default	11:02:46.287625+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_installHandler: 0xb182dd460: handler: 0xb1817abc0 priority: 900
default	11:02:46.288146+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> FigCustomURLHandlerCreate: newHandler: FigCustomURLHandlerRemoteShim.0xb18036900 options: {
    "CURLHOption_ClientRequestsRepresentAccurateNetworkStatistics" = 1;
}
default	11:02:46.288175+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_installHandler: 0xb182dd460: handler: 0xb18178460 priority: 1000
default	11:02:46.289658+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_updateHandler: application  updated to state 4 from state 0
default	11:02:46.292642+0800	mediaplaybackd	[0xb183ab340] activating connection: mach=false listener=false peer=true name=com.apple.coremedia.mediaplaybackd.player.xpc.peer[858].0xb183ab340
default	11:02:46.292881+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> FigPlayerSurrogateCreateWithOptions: new player 0xb1855c9c0 P/BR
default	11:02:46.293000+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> FigPlayerAirPlayRoute_Create: [0xb1875d300] P/BR created
default	11:02:46.293030+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> FigPlayerAirPlayCreateWithOptions: [0xb18a40280] P/BR returning err = 0, wrapping 0xb1855c9c0 for client DRMSample(com.pccw.nowtv.nmaf.DRMSample)
default	11:02:46.293083+0800	mediaplaybackd	[0xb183aa940] activating connection: mach=true listener=false peer=false name=com.apple.audio.AudioSession
default	11:02:46.296458+0800	mediaplaybackd	    AVAudioSession_iOS.mm:1141  Created session 0xb18964d50 with ID: 0x6d03e
default	11:02:46.297965+0800	mediaplaybackd	<<<< CELESTE >>>> FigPlayerCelesteCreateWithOptions: [0xb181c4b00] P/BR created primary audio session 
default	11:02:46.298223+0800	mediaplaybackd	<<<< CENTRAL >>>> playercentral_establishIfPlayerIsSilentAndTellMXSession: [0xb18828540] P/BR Established that player is 'Muted' (by NULL currentItem)
default	11:02:46.301472+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRoutingRegistryInternal: [0xb1875d300] P/BR Updating routing registry. playbackActive: 0. routingContextUUID: [9FF3A19E-9347-44BE-9999-3527693EBD42]. AudioSessionDisallowsBuffered: 0. Saved UUID: [(null)]
default	11:02:46.301647+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Called. Current route: (null) [pb: 0 t: [0x0] ][sc: 0x0][buf: 0x0][lpb: 1][usc:0]
default	11:02:46.301743+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Selected endpoint from routing context [0x0], Local Playback = 1
default	11:02:46.301907+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Exiting (current: (null) [pb: 0 t: [0x0] ][sc: 0x0][buf: 0x0][lpb: 1][usc:0][epsAPVwSharePlay:0])
default	11:02:46.301953+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR change route type to 0, err = 0
default	11:02:46.303534+0800	mediaplaybackd	<<<< CELESTE >>>> playerceleste_updatePlayerAudioSession: [0xb181c4b00] P/BR New sesssion silent mute status: UNMUTED
default	11:02:46.303586+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: Using existing monitor: 
default	11:02:46.303610+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18413120>: 
default	11:02:46.330424+0800	mediaplaybackd	<<< FigContentKeySession >>> FigContentKeySessionCreateWithCallbacks: 0xb188288c0: created new session err:0
default	11:02:46.330449+0800	mediaplaybackd	keyboss FigContentKeyBossCreate: 0xb18400a80
default	11:02:46.330473+0800	mediaplaybackd	ckeyboss FigContentKeyCompoundBossCreate: 0xb18766100 new
default	11:02:46.331429+0800	mediaplaybackd	[0xb183abe80] activating connection: mach=false listener=false peer=false name=com.apple.mediamlxpc
default	11:02:46.333101+0800	mediaplaybackd	<<<< FigNetworkPredictionArbiter >>>> FigNetworkPredictionArbiterCreate: allocated a new arbiter 0xb19270010
default	11:02:46.333307+0800	mediaplaybackd	Create activity 
default	11:02:46.333777+0800	mediaplaybackd	Create activity 
default	11:02:46.333885+0800	mediaplaybackd	Create activity 
default	11:02:46.334080+0800	mediaplaybackd	Create activity 
default	11:02:46.334644+0800	mediaplaybackd	Activated 
default	11:02:46.334841+0800	mediaplaybackd	Activated  with parent 
default	11:02:46.334918+0800	mediaplaybackd	Activated  with parent 
default	11:02:46.334988+0800	mediaplaybackd	Activated  with parent 
default	11:02:46.335067+0800	mediaplaybackd	 FigBytePumpCreateForHTTPChunk: 0xb18805000: bandwidthPredictionAlgorithm: 5 lowLatencyBandwidthPredictionAlgorithm: 3 secondaryPredictorAlgorithm: -1, flags lowLatencyBandwidthPredictionAlgorithm 0x1
default	11:02:46.337169+0800	mediaplaybackd	nw_path_evaluator_cancel [CEE5A825-F489-4C8D-843C-DFA542622F93] cancel
default	11:02:46.337402+0800	mediaplaybackd	nw_path_evaluator_start [39CD0908-DC5D-4C00-88E0-BFA8ABA35257  generic, attribution: developer]
	path: satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi
default	11:02:46.337434+0800	mediaplaybackd	<< FigNwPathEval >> FigNWPathEvaluatorCreate: [0xb1827fbb0] created FigNWPathEvaluator
default	11:02:46.337512+0800	mediaplaybackd	Create activity 
default	11:02:46.337640+0800	mediaplaybackd	HTTPRequest figHttpRequestSetupNSURLSessionTask: <0xb18522800> Created NSURLSessionDataTask: LocalDataTask <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> with networkServiceType: 8
default	11:02:46.337688+0800	mediaplaybackd	Activated  with parent 
default	11:02:46.337733+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> resuming, timeouts(300.0, 604800.0) qos(0x0) voucher() activity(41E02501-F0C0-4F8F-B3B2-2D9EB610212A)
default	11:02:46.337785+0800	mediaplaybackd	 segPumpCreateHTTPRequest: 0xb18805000:0: Byte pump 0xb18805020 created new request 0xb18522800 for session ref 0xb180464c0
default	11:02:46.337810+0800	mediaplaybackd	 segPumpSendIndexFileRequest: 0xb18805000:0: session 0xb180464c0 index req []
default	11:02:46.338262+0800	mediaplaybackd	Connection 0: creating secure tcp or quic connection
default	11:02:46.338386+0800	mediaplaybackd	Connection 9: enabling TLS
default	11:02:46.338411+0800	mediaplaybackd	Connection 9: starting, TC(0x1f4)
default	11:02:46.338438+0800	mediaplaybackd	[C9 8D80EF4A-B379-46B7-B6E3-DD034C9D8112 Hostname#3c6ac071:443/5228 quic-connection, bundle id: com.pccw.nowtv.nmaf.DRMSample, url hash: 2814da80, definite, attribution: developer, context: com.apple.CFNetwork.NSURLSession.{746DE90C-462F-4147-B1FB-6BD1D2F76918}{(null)}{Y}{3}{0x0} (sensitive), proc: 4ECAE968-F238-34DE-AD9D-BB4116E6B498, effective proc: 5C2ECC09-CD14-3FF5-B8F9-690E32666C4E, traffic class: 500, pid: 858] start
default	11:02:46.338498+0800	mediaplaybackd	[C9 Hostname#3c6ac071:443/5228 initial parent-flow ((null))] event: path:start @0.000s
default	11:02:46.338671+0800	mediaplaybackd	[C9 Hostname#3c6ac071:443/5228 waiting parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: path:satisfied @0.000s, uuid: F7F4C9F8-9583-4093-B450-AA942015DA97
default	11:02:46.338821+0800	mediaplaybackd	[C9 Hostname#3c6ac071:443/5228 in_progress parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:start_connect @0.000s
default	11:02:46.338846+0800	mediaplaybackd	nw_connection_report_state_with_handler_on_nw_queue [C9] reporting state preparing
default	11:02:46.338938+0800	mediaplaybackd	[C9 Hostname#3c6ac071:443/5228 in_progress parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:start_child @0.000s
default	11:02:46.339067+0800	mediaplaybackd	[C9.1 Hostname#3c6ac071:443/5228 initial path ((null))] event: path:start @0.000s
error	11:02:46.339117+0800	mediaplaybackd	nw_path_necp_check_for_updates Failed to copy updated result (22)
default	11:02:46.339498+0800	mediaplaybackd	[C9.1 Hostname#3c6ac071:443/5228 waiting path (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: path:satisfied @0.000s, uuid: F7F4C9F8-9583-4093-B450-AA942015DA97
default	11:02:46.339591+0800	mediaplaybackd	[C9.1 Hostname#3c6ac071:443/5228 in_progress transform (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: transform:start @0.000s
default	11:02:46.339729+0800	mediaplaybackd	[C9.1.1 Hostname#3c6ac071:443/5228 initial path ((null))] event: path:start @0.000s
default	11:02:46.340418+0800	mediaplaybackd	[C9.1.1 Hostname#3c6ac071:443/5228 waiting path (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: path:satisfied @0.000s, uuid: C64C6E49-B742-4181-9A84-09BDF054DA15
default	11:02:46.340744+0800	mediaplaybackd	[C9.1.1 Hostname#3c6ac071:443/5228 in_progress resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: resolver:start_dns @0.001s
default	11:02:46.340900+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> setting up Connection 9
default	11:02:46.340954+0800	mediaplaybackd	[C9] event: client:start_activity @0.001s, activity 
default	11:02:46.356441+0800	mediaplaybackd	nw_endpoint_resolver_update [C9.1.1 Hostname#3c6ac071:443/5228 in_progress resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] Adding endpoint handler for IPv4#8535a031:443/5228
default	11:02:46.356641+0800	mediaplaybackd	[C9.1.1 Hostname#3c6ac071:443/5228 in_progress resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: resolver:receive_dns @0.019s
default	11:02:46.356909+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 initial path ((null))] event: path:start @0.019s
default	11:02:46.357330+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 waiting path (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: path:satisfied @0.020s, uuid: 2BF44A31-A9F8-4B02-AA64-7638F4F586AD
default	11:02:46.357522+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:start_nexus @0.020s
default	11:02:46.357907+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:receive_nexus @0.020s
default	11:02:46.358689+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:start_connect @0.021s
default	11:02:46.359040+0800	mediaplaybackd	tcp_output [C9.1.1.1:3] flags=[SEC] seq=2307272223, ack=0, win=65535 state=SYN_SENT rcv_nxt=0, snd_una=2307272223
default	11:02:46.365672+0800	mediaplaybackd	tcp_input [C9.1.1.1:3] flags=[S.] seq=3679105905, ack=2307272224, win=65535 state=SYN_SENT rcv_nxt=0, snd_una=2307272223
default	11:02:46.365752+0800	mediaplaybackd	nw_flow_connected [C9.1.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] Transport protocol connected (tcp)
default	11:02:46.365979+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:finish_transport @0.028s
default	11:02:46.366537+0800	mediaplaybackd	boringssl_session_apply_protocol_options_for_transport_block_invoke(2042) [C9.1.1.1:2][0xb190b8c00] TLS configured [min_version(0x0301) max_version(0x0304) name(redacted) tickets(false) false_start(false) enforce_ev(false) enforce_ats(false) ech(false)]
default	11:02:46.366590+0800	mediaplaybackd	boringssl_context_info_handler(2231) [C9.1.1.1:2][0xb190b8c00] Client handshake started
default	11:02:46.366666+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client enter_early_data
default	11:02:46.366815+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_server_hello
default	11:02:46.379746+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_server_certificate
default	11:02:46.379924+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_certificate_status
default	11:02:46.379950+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client verify_server_certificate
default	11:02:46.380270+0800	mediaplaybackd	boringssl_context_evaluate_trust_async(1783) [C9.1.1.1:2][0xb190b8c00] Performing external trust evaluation
default	11:02:46.380312+0800	mediaplaybackd	boringssl_context_evaluate_trust_async_external(1768) [C9.1.1.1:2][0xb190b8c00] Asyncing for external verify block
default	11:02:46.380387+0800	mediaplaybackd	Connection 9: asked to evaluate TLS Trust
default	11:02:46.380628+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> auth completion disp=1 cred=0x0
default	11:02:46.380724+0800	mediaplaybackd	(Trust 0xb185fab80) No pending evals, starting
default	11:02:46.380814+0800	mediaplaybackd	[0xb18212100] activating connection: mach=true listener=false peer=false name=com.apple.trustd
default	11:02:46.380891+0800	mediaplaybackd	(Trust 0xb185fab80) Completed async eval kickoff
default	11:02:46.383704+0800	mediaplaybackd	(Trust 0xb185fab80) trustd returned 4
default	11:02:46.383783+0800	mediaplaybackd	Connection 9: TLS Trust result 0
default	11:02:46.383812+0800	mediaplaybackd	boringssl_context_evaluate_trust_async_external_block_invoke_3(1724) [C9.1.1.1:2][0xb190b8c00] Returning from external verify block with result: true
default	11:02:46.383866+0800	mediaplaybackd	boringssl_context_certificate_verify_callback(1945) [C9.1.1.1:2][0xb190b8c00] Certificate verification result: OK
default	11:02:46.383923+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_server_key_exchange
default	11:02:46.384191+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_certificate_request
default	11:02:46.384408+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_server_hello_done
default	11:02:46.384434+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client send_client_certificate
default	11:02:46.384483+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client send_client_key_exchange
default	11:02:46.384696+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client send_client_certificate_verify
default	11:02:46.384751+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client send_client_finished
default	11:02:46.384902+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client finish_flight
default	11:02:46.385018+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_session_ticket
default	11:02:46.385067+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client process_change_cipher_spec
default	11:02:46.385428+0800	mediaplaybackd	[0xb18212100] invalidated because the current process cancelled the connection by calling xpc_connection_cancel()
default	11:02:46.391763+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client read_server_finished
default	11:02:46.392065+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client finish_client_handshake
default	11:02:46.392210+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C9.1.1.1:2][0xb190b8c00] Client handshake state: TLS client done
default	11:02:46.392260+0800	mediaplaybackd	boringssl_context_info_handler(2237) [C9.1.1.1:2][0xb190b8c00] Client handshake done
default	11:02:46.392560+0800	mediaplaybackd	nw_protocol_boringssl_signal_connected(747) [C9.1.1.1:2][0xb190b8c00] TLS connected [version(0x0303) ciphersuite(TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256) group(0x001d) signature_alg(0x0401) alpn(nil) resumed(0) offered_ticket(0) false_started(0) ocsp_received(0) sct_received(0) connect_time(28ms) flight_time(22ms) rtt(13ms) write_stalls(0) read_stalls(8)]
default	11:02:46.392657+0800	mediaplaybackd	nw_flow_connected [C9.1.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] Output protocol connected (CFNetworkConnection-3176013202)
default	11:02:46.392828+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 ready channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:child_finish_connect @0.056s
default	11:02:46.393023+0800	mediaplaybackd	[C9.1.1 Hostname#3c6ac071:443/5228 ready resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:child_finish_connect @0.056s
default	11:02:46.393074+0800	mediaplaybackd	[C9.1 Hostname#3c6ac071:443/5228 ready transform (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:child_finish_connect @0.056s
default	11:02:46.393189+0800	mediaplaybackd	[C9.1.1.1 IPv4#8535a031:443/5228 ready channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:changed_viability @0.057s
default	11:02:46.393270+0800	mediaplaybackd	[C9.1.1 Hostname#3c6ac071:443/5228 ready resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:changed_viability @0.057s
default	11:02:46.393328+0800	mediaplaybackd	[C9.1 Hostname#3c6ac071:443/5228 ready transform (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:changed_viability @0.057s
default	11:02:46.393379+0800	mediaplaybackd	nw_flow_connected [C9 IPv4#8535a031:443/5228 in_progress parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] Output protocol connected (endpoint_flow)
default	11:02:46.393490+0800	mediaplaybackd	[C9 IPv4#8535a031:443/5228 ready parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:finish_connect @0.057s
default	11:02:46.393655+0800	mediaplaybackd	nw_connection_report_state_with_handler_on_nw_queue [C9] reporting state ready
default	11:02:46.393680+0800	mediaplaybackd	[C9 IPv4#8535a031:443/5228 ready parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:changed_viability @0.057s
default	11:02:46.393702+0800	mediaplaybackd	Connection 9: connected successfully
default	11:02:46.393726+0800	mediaplaybackd	Connection 9: TLS handshake complete
default	11:02:46.393749+0800	mediaplaybackd	Connection 9: ready C(N) E(N)
default	11:02:46.393799+0800	mediaplaybackd	[C9] event: client:end_activity @0.057s, activity 
default	11:02:46.393846+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> now using Connection 9
default	11:02:46.393873+0800	mediaplaybackd	[C9] event: client:start_activity @0.058s, activity 
default	11:02:46.393991+0800	mediaplaybackd	Connection 9: received viability advisory(Y)
default	11:02:46.394016+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> sent request, body N 0
default	11:02:46.396517+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> received response, status 200 content K
default	11:02:46.396608+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> response ended
default	11:02:46.396631+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> done using Connection 9
default	11:02:46.396660+0800	mediaplaybackd	[C9] event: client:end_activity @0.073s, activity 
default	11:02:46.396877+0800	mediaplaybackd	[C9] event: client:connection_idle @0.073s
default	11:02:46.396981+0800	mediaplaybackd	[C9] event: client:connection_idle @0.073s
default	11:02:46.397072+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> summary for task success {transaction_duration_ms=74, response_status=200, connection=9, protocol="http/1.1", domain_lookup_duration_ms=18, connect_duration_ms=36, secure_connection_duration_ms=28, private_relay=false, request_start_ms=58, request_duration_ms=0, response_start_ms=73, response_duration_ms=0, request_bytes=480, request_throughput_kbps=6597, response_bytes=1266, response_throughput_kbps=1246, cache_hit=false}
default	11:02:46.397161+0800	mediaplaybackd	Task <2017CB74-BE44-449F-ACE3-6DED1F798FC7>.<15> finished successfully
default	11:02:46.400249+0800	mediaplaybackd	 complete with reason 2 (success), duration 77ms
default	11:02:46.767215+0800	mediaplaybackd	<<<< CELESTE >>>> playerceleste_handleSetProperty: [0xb181c4b00] P/BR underlying audio session unchanged, using existing session 
default	11:02:46.772567+0800	mediaplaybackd	<<<< CELESTE >>>> playerceleste_setRateInternal: [0xb181c4b00] P/BR calling beginInterruption '(null)' newRate 1.000 options 
default	11:02:46.790105+0800	mediaplaybackd	    AVAudioSession_iOS.mm:1928  Activated session 0x6d03e
default	11:02:46.790280+0800	mediaplaybackd	<<<< CELESTE >>>> playerceleste_beginInterruptionInternal: [0xb181c4b00] Calling to re-evaluate route configuration
default	11:02:46.790604+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Called. Current route: (null) [pb: 0 t: [0x0] ][sc: 0x0][buf: 0x0][lpb: 1][usc:0]
default	11:02:46.790807+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Selected endpoint from routing context [0x0], Local Playback = 1
default	11:02:46.790906+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Exiting (current: (null) [pb: 0 t: [0x0] ][sc: 0x0][buf: 0x0][lpb: 1][usc:0][epsAPVwSharePlay:0])
default	11:02:46.795979+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR change route type to 0, err = 0
default	11:02:46.796133+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplay_setRateCommon: [0xb18a40280] P/BR Changing airplayRate 0.000 -> 1.000
default	11:02:46.800549+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplay_handleSetProperty: [0xb18a40280] P/BR AllowsAirPlayVideo set to TRUE, state NoAirPlay)
default	11:02:46.800826+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplay_handleSetProperty: [0xb18a40280] P/BR UsesAirPlayVideoWhileAirPlayScreenIsActive set to TRUE
default	11:02:46.801105+0800	mediaplaybackd	<<<< CENTRAL >>>> playercentral_updateNeroStatusBasedOnRouteAndSetting: [0xb18828540] P/BR Turning on WirePlay Video
default	11:02:46.801177+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_CreatePlaybackItemFromAsset: [0xb1855c9c0] P/BR Created new item 0xb18400c40 I/QYA.01
default	11:02:46.802829+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplay_CreatePlaybackItem: [0xb18a40280] P/BR -> new item 0xb187b4000 I/QYA.01 [61B0C92A-CA02-4038-A29D-CF170DB4240E] wrapping [0xb1855c9c0:0xb18400c40]
default	11:02:46.802958+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_AddToPlayQueue: [0xb1855c9c0] P/BR add 0xb18400c40 I/QYA.01 after 0x0
default	11:02:46.803056+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlaybackItem_addToPlayQueueInternal: [0xb1855c9c0] P/BR adding item 0xb18400c40(0x0) I/QYA.01 to play queue after item 0x0(0x0)
default	11:02:46.803108+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlaybackItem_addToPlayQueueInternal: [0xb1855c9c0] P/BR play queue now: [item 0xb18400c40 I/QYA.01]
default	11:02:46.803246+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_initiateLoadingOfItemAssetTypeInternal: [0xb1855c9c0] P/BR preparing item 0xb18400c40(0x0) I/QYA.01 for enqueueing
default	11:02:46.803272+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_initiateLoadingOfItemAssetTypeInternal: [0xb1855c9c0] P/BR load ok 0xb18400c40(0x0) I/QYA.01 already loaded
default	11:02:46.803422+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_respondToLoadingOfItemAssetTypeInternal: [0xb1855c9c0] P/BR called, enqueuing item 0xb18400c40 I/QYA.01 if appropriate
default	11:02:46.803472+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> FigPlayerStreamCreateWithOptions: [0xb18a9e400|P/BR]: playerName - , interstitialPrimaryPlayerName - 
default	11:02:46.805742+0800	mediaplaybackd	<<<< FigPlayerResourceArbiter >>>> FigPlayerResourceArbiterRegisterConsumer: 0xb185d4470: Registered new consumer: 3
default	11:02:46.805768+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> FigPlayerStreamCreateWithOptions: [QE Critical][0xb18a9e400|P/BR] pPlayer 0xb18a9e420
default	11:02:46.806518+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SetConnectionActive: [0xb18a9e400|P/BR]: activate (was Active/Prepared)
default	11:02:46.806900+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SetConnectionActive: [0xb18a9e400|P/BR]: returning err = 0
default	11:02:46.807420+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SilentMute: [0xb18a9e400|P/BR]: being UNMUTED
default	11:02:46.807904+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_CreatePlaybackItem: [QE Critical][0xb18a9e400|P/BR] -> new item <0xb18980000|I/QYA.01> (3)
default	11:02:46.808290+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_CreatePlaybackItem: [QE Critical]0xb18980000 asset URL  (asset ref 0xb18313380)
default	11:02:46.808458+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_haltStream: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: pump 0x0
default	11:02:46.808703+0800	mediaplaybackd	<<< FigReportingAgentRef >>> FigReportingAgentCreateFromAsset: Created the reporting agent with error=0, reportingAgent=0xb18401960, asset=0xb18313380, CMSession=
default	11:02:46.809573+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlaybackItem_createRealItemInternal: created real item 0xb18980000 for surrogate item 0xb18400c40 I/QYA.01
default	11:02:46.809648+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting StreamBufferFull on 0xb18980000 (0x0)
default	11:02:46.809743+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SeekDidComplete: <0xb18980000|I/QYA.01> Posting seek completion for 100000001 current seek ID 100000001 reason Unknown postSeekPosition 0.000000
default	11:02:46.810024+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting SeekDidComplete on 0xb18980000 (0xb185d6e00)
default	11:02:46.810204+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_respondToLoadingOfItemAssetTypeInternal: [0xb1855c9c0] P/BR called for item 0xb18400c40 I/QYA.01. item index is 0 in surrogate playQueue. realPlayer 0xb18a9e400, realItem 0xb18980000.
default	11:02:46.810329+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting TaggedRangeMetadataChanged on 0xb18980000 (0xb183ce940)
default	11:02:46.810420+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_respondToLoadingOfItemAssetTypeInternal: [0xb1855c9c0] P/BR called for item 0xb18400c40 I/QYA.01. switching real player from [0x0] to [0xb18a9e400].
default	11:02:46.810524+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_handleSetProperty: [0xb18a9e400|P/BR]: setting numCAImageQueueSlotsRequired to 1 (from 0)
default	11:02:46.810600+0800	mediaplaybackd	<<<< FigPlayerSurrogate >>>> surrogatePlayer_respondToLoadingOfItemAssetTypeInternal: [0xb1855c9c0] P/BR adding item 0xb18400c40(0xb18980000) I/QYA.01 to real player play queue
default	11:02:46.810653+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_AddToPlayQueue: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: add new item after <0x0>
default	11:02:46.810798+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfsi_MakeReadyForInspection: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: pItem->pumpRequestState = 0 called - not ready
default	11:02:46.811023+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SetRateWithOptionsAndAnchorTime: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: called at 0, rate = 0.000, fadeDuration = nan, immediately: no, reason: CurrentItemChanged
default	11:02:46.811075+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SetRateWithFadeInternal: [0xb18a9e400|P/BR]: called new rate 0.000000
default	11:02:46.811126+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PumpTransferCallback: [QE Critical]Transfer new pump 0xb18805000 to item 0xb18980000 with error  (0)
default	11:02:46.811151+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting PlayQueueBecameHungry on 0xb18a9e400 (0x0)
default	11:02:46.811218+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting ItemBecameCurrent on 0xb18980000 (0x0)
default	11:02:46.811244+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting CurrentItemDidChange on 0xb18a9e400 (0xb183cf4e0)
default	11:02:46.811407+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting Remote_RateWillChangeTo on 0xb18a9e400 (0xb185d4e70)
default	11:02:46.811434+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SetRateWithOptionsAndAnchorTime: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: called at 0, rate = 1.000, fadeDuration = nan, immediately: no, reason: ApplyCachedRate
default	11:02:46.812235+0800	mediaplaybackd	<<<< CENTRAL >>>> playercentral_performStartupTaskConfirmingRouteChoiceWithRoutingSessionManager: [0xb18828540] P/BR player is not eligible for RouteSessionManager, with reasons: routingSession manager = 0x0, allowsAirPlayVideo = true, willMixWithEveryone = false
default	11:02:46.812263+0800	mediaplaybackd	<<<< CENTRAL >>>> playercentral_performStartupTaskConfirmingRouteChoiceWithRoutingSessionManager: [0xb18828540] P/BR Auto-routing timing breakdown. 0 ms for getting player state + 0 ms for getting session state + 0 ms for making routing decision = 0 ms Total
default	11:02:46.815229+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfsi_SetAlternateForRateChangeIfNecessary: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: oldRate 0.000000 newRate 1.000000 wasDoingIFrames 0 willDoIFrames 0
default	11:02:46.820956+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfsi_handleIFrameOnlyRateTransition: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: rate 1.000000; oldRate 0.000000; wasDoingIFrames 0; willDoIFrames 0
default	11:02:46.821082+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_DeferredPumpTransferCompleted: [QE Critical][0xb18a9e400|P/BR] <0xb18980000|I/QYA.01> called - pump is 0xb18805000 err is  (0)
default	11:02:46.821501+0800	mediaplaybackd	 segPumpUpdateBytesRequiredForNetworkPrediction: 0xb18805000: using 332039 minimum number of bytes for network predictions
default	11:02:46.823170+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfsi_GetResolutionCapForFilter: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: displaySize 1920.000000 x 1080.000000 cap 1920.000000 x 1080.000000
default	11:02:46.823750+0800	mediaplaybackd	<<<< FigAlternateFilterMonitor >>>> fampfr_handleTriggerInvocationForSupportedFramerateBucketCap: 0xb19198e70: maxFramerate:120.000
default	11:02:46.828753+0800	mediaplaybackd	<<<< FigAlternateFilterMonitor >>>> fampfr_handleTriggerInvocationForSupportedFramerateBucketCap: 0xb19198e70: maxFramerate:120.000
default	11:02:46.828829+0800	mediaplaybackd	<<<< FigAlternateFilterMonitor >>>> fampfr_handleTriggerInvocationForSupportedFramerateBucketCap: 0xb19198e70: maxFramerate:120.000
default	11:02:46.828950+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfsi_GetResolutionCapForFilter: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: displaySize 1920.000000 x 1080.000000 cap 1920.000000 x 1080.000000
default	11:02:46.829118+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfsi_GetResolutionCapForFilter: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: displaySize 1920.000000 x 1080.000000 cap 1920.000000 x 1080.000000
default	11:02:46.829173+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_validAlternateHasChanged: 0xb1933c010:: updating BandwidthConditions for new alternate list
default	11:02:46.829236+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]

  Monitors:
  {
    [FigAlternateFilterMonitorForHDCP currentMaxProtectedHDCPLevel:-1 currentEPM:(null)]
    [FigAlternateFilterMonitorForNotification<0xb19198f10> "DisplayVideoRangeChanged" state:5 currentFilter:[FigAlternateFilter  priority:800]]
    [FigAlternateFilterMonitorForNotification<0xb19198e70> "DisplayVideoRangeChanged" state:2 currentFilter:[FigAlternateFilter  priority:700]]
    [FigAlternateFilterMonitorForNotification<0xb19198dd0> "DisplayVideoRangeChanged" state:5 currentFilter:[FigAlternateFilter  priority:1000]]
    [FigAlternateFilterMonitorForNotification<0xb19198d30> "PowerStateChanged" state:0 currentFilter:(null)]
default	11:02:46.829341+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
    [FigAlternateFilterMonitorForNotification<0xb19198c90> "StreamingRestrictions_RestrictionsChanged" state:0 currentFilter:(null)]
    [FigAlternateFilterMonitorForPlaybackBitrate lastMeasuredBitrate:0 ]
  }
  Filters:
  {
    To decode base64 encoded filter output, run:
    % B64="ENCODEDVALUE";python3 -c"import base64,sys;n=int.from_bytes(base64.b64decode(sys.argv[1]),'little');print([i for i in range(0,n.bit_length())if 0!=(n&(1<  4: [FigSimpleAlternateFilter  priority:1100]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000 systemCPC:0x3]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000 allowUnknownCodecs:NO]
default	11:02:46.829396+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000 ac3IsDecodable:YES ec3IsDecodable:YES atmosIsDecodable:NO, ac3CanPassthrough:NO ec3CanPassthrough:NO, atmosCanPassthrough:NO]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000 preferredRange:SDR preferredFormat:AVC]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:1000 mode:[Internal (HDR OK)]]
    Dw==      4 ->  4: [FigMediaSelectionAudibleAlternateFilter  priority: 950 persistentIDs: 0]
default	11:02:46.829533+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:881 contiguous]
                       [FigAlternateFilterTreeFilter  priority:880]
    Dw==      4 ->  4: |--> Leaf: [FigSimpleAlternateFilter  priority:880 lowestplayable:NONE/MONO/RECT]
    Dw==      4 ->  4: |--> Leaf: [FigSimpleAlternateFilter  priority:880 lowestplayable:NONE/MONO/RECT]
    Dw==      4 ->  4: [FigHDCPAlternateFilter  priority: 879 hdcp0:Unknown hdcp1:Unknown]
    Dw==      4 ->  4: [PassthroughFilter  priority: 877 Total Alternate 4]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:876 context:{length = 1, capacity = 1, bytes = 0x01}]
default	11:02:46.829657+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:800 preferredRange:PQ preferredFormat:Maximum]
                       [FigAlternateFilterTreeFilter  priority:760]
                       |--> Leaf: [FigAlternateFilterTreeFilter  priority:760]
    Dw==      4 ->  4: |          |--> Leaf: [FigSimpleAlternateFilter  priority:760]
    AA==      4 ->  0: |          |--> Leaf: [FigSimpleAlternateFilter  priority:760 capability:Immersive]
default	11:02:46.829761+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
                       |          |--> Leaf: [FigSimpleAlternateFilter  priority:750 preferredFormat:Maximum preferredMixableNumberOfChannels:2 ac3CanPassthrough:NO ec3CanPassthrough:NO atmosCanPassthrough:NO preferLossyEncodings:YES sampleRateContraints:]
                       |          |~~> Fall: [FigAlternateFilterTreeFilter  priority:760]
    Dw==      4 ->  4: |                     |--> Leaf: [FigSimpleAlternateFilter  priority:760]
    Dw==      4 ->  4: |                     |--> Leaf: [FigSimpleAlternateFilter  priority:760 capability:Unknown]
default	11:02:46.831557+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
    Dw==      4 ->  4: |                     |--> Leaf: [FigSimpleAlternateFilter  priority:750 preferredFormat:Maximum preferredMixableNumberOfChannels:2 ac3CanPassthrough:NO ec3CanPassthrough:NO atmosCanPassthrough:NO preferLossyEncodings:YES sampleRateContraints:]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:700 framerateBucketCap:Over60fpsBucket]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:700 displaySize:[1920x1080]]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:700 videoRange:SDR bestFormat:AVC]
    Dw==      4 ->  4: [FigSimpleAlternateFilter  priority:639 context:{length = 4, capacity = 4, bytes = 0x00000000}]
default	11:02:46.831585+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
    Dw==      4 ->  4: [PassthroughFilter  priority: 625 Total Alternate 4]
                       [FigAlternateFilterTreeFilter  priority:600]
    Dw==      4 ->  4: |--> Leaf: [PassthroughFilter  priority: 601 Total Alternate 4]
    AQ==      4 ->  1: |--> Leaf: [FigSimpleAlternateFilter  priority:555 hasVideoScore]
    AQ==      1 ->  1: |--> Leaf: [FigSimpleAlternateFilter  priority:460]
    AQ==      1 ->  1: |--> Leaf: [FigSimpleAlternateFilter  priority:200]
  }
  Alternates:
  {
    
default	11:02:46.831666+0800	mediaplaybackd	<> fasb_log: [0xb19270310:I/QYA.01]
    
    
    
  }
  Filtered Alternates:
  {
    
  }
LOG COMPLETE
default	11:02:46.831866+0800	mediaplaybackd	 segPumpSetCurrentAlternate: 0xb18805000: Attempting SwitchToAlternate bw 434179, at time nan, duration 0 1, isTrialSwitching=false isKeyFrame=false isNewAlternateCompletelyCached=false
default	11:02:46.835454+0800	mediaplaybackd	[C10] event: client:start_activity @0.002s, activity 
default	11:02:46.837479+0800	mediaplaybackd	nw_endpoint_resolver_update [C10.1 Hostname#3c6ac071:443/5228 in_progress resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] Adding endpoint handler for IPv4#8535a031:443/5228
default	11:02:46.837780+0800	mediaplaybackd	[C10.1 Hostname#3c6ac071:443/5228 in_progress resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: resolver:receive_dns @0.003s
default	11:02:46.838040+0800	mediaplaybackd	[C10.1.1 IPv4#8535a031:443/5228 initial path ((null))] event: path:start @0.003s
default	11:02:46.839343+0800	mediaplaybackd	<<<< CELESTE >>>> playerceleste_InterruptionNotification: [0xb181c4b00] P/BR received.
default	11:02:46.839369+0800	mediaplaybackd	<<<< CELESTE >>>> playerceleste_deferredInterruptionNotification: [0xb181c4b00] P/BR called. Command 6. 
default	11:02:46.839395+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SilentMute: [0xb18a9e400|P/BR]: being MUTED
default	11:02:46.840084+0800	mediaplaybackd	[C10.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:receive_nexus @0.006s
default	11:02:46.841555+0800	mediaplaybackd	[C10.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:start_connect @0.007s
default	11:02:46.841830+0800	mediaplaybackd	tcp_output [C10.1.1:3] flags=[SEC] seq=1484761603, ack=0, win=65535 state=SYN_SENT rcv_nxt=0, snd_una=1484761603
default	11:02:46.842165+0800	mediaplaybackd	Task <C0AD143C-2E67-456A-8C51-21E9F1730BD8>.<16> received response, status 200 content K
default	11:02:46.842895+0800	mediaplaybackd	Task <C0AD143C-2E67-456A-8C51-21E9F1730BD8>.<16> response ended
default	11:02:46.843036+0800	mediaplaybackd	Task <C0AD143C-2E67-456A-8C51-21E9F1730BD8>.<16> done using Connection 9
default	11:02:46.843159+0800	mediaplaybackd	[C9] event: client:end_activity @0.452s, activity 
default	11:02:46.843413+0800	mediaplaybackd	 complete with reason 2 (success), duration 42ms
default	11:02:46.845288+0800	mediaplaybackd	tcp_input [C10.1.1:3] flags=[S.] seq=2182801953, ack=1484761604, win=65535 state=SYN_SENT rcv_nxt=0, snd_una=1484761603
default	11:02:46.845701+0800	mediaplaybackd	nw_flow_connected [C10.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] Transport protocol connected (tcp)
default	11:02:46.846754+0800	mediaplaybackd	[C10.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:finish_transport @0.012s
default	11:02:46.850543+0800	mediaplaybackd	Received state update for 858 (app, running-active-Visible
default	11:02:46.852355+0800	mediaplaybackd	Received state update for 858 (app, running-active-Visible
default	11:02:46.857798+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C10.1.1:2][0xb190bb000] Client handshake state: TLS client read_server_certificate
default	11:02:46.858043+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C10.1.1:2][0xb190bb000] Client handshake state: TLS client read_certificate_status
default	11:02:46.858095+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C10.1.1:2][0xb190bb000] Client handshake state: TLS client verify_server_certificate
default	11:02:46.858565+0800	mediaplaybackd	boringssl_context_evaluate_trust_async(1783) [C10.1.1:2][0xb190bb000] Performing external trust evaluation
default	11:02:46.858649+0800	mediaplaybackd	boringssl_context_evaluate_trust_async_external(1768) [C10.1.1:2][0xb190bb000] Asyncing for external verify block
default	11:02:46.858854+0800	mediaplaybackd	Connection 10: asked to evaluate TLS Trust
default	11:02:46.859050+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> auth completion disp=1 cred=0x0
default	11:02:46.859121+0800	mediaplaybackd	(Trust 0xb185f8600) No pending evals, starting
default	11:02:46.859369+0800	mediaplaybackd	[0xb18212a00] activating connection: mach=true listener=false peer=false name=com.apple.trustd
default	11:02:46.859469+0800	mediaplaybackd	(Trust 0xb185f8600) Completed async eval kickoff
default	11:02:46.864515+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C10.1.1:2][0xb190bb000] Client handshake state: TLS client read_server_finished
default	11:02:46.864686+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C10.1.1:2][0xb190bb000] Client handshake state: TLS client finish_client_handshake
default	11:02:46.864778+0800	mediaplaybackd	boringssl_context_info_handler(2248) [C10.1.1:2][0xb190bb000] Client handshake state: TLS client done
default	11:02:46.864803+0800	mediaplaybackd	boringssl_context_info_handler(2237) [C10.1.1:2][0xb190bb000] Client handshake done
default	11:02:46.865192+0800	mediaplaybackd	nw_protocol_boringssl_signal_connected(747) [C10.1.1:2][0xb190bb000] TLS connected [version(0x0303) ciphersuite(TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256) group(0x001d) signature_alg(0x0401) alpn(nil) resumed(0) offered_ticket(0) false_started(0) ocsp_received(0) sct_received(0) connect_time(26ms) flight_time(21ms) rtt(14ms) write_stalls(0) read_stalls(8)]
default	11:02:46.865274+0800	mediaplaybackd	nw_flow_connected [C10.1.1 IPv4#8535a031:443/5228 in_progress channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] Output protocol connected (CFNetworkConnection-3176013202)
default	11:02:46.865449+0800	mediaplaybackd	[C10.1.1 IPv4#8535a031:443/5228 ready channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:child_finish_connect @0.040s
default	11:02:46.865629+0800	mediaplaybackd	[C10.1 Hostname#3c6ac071:443/5228 ready resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:child_finish_connect @0.040s
default	11:02:46.865737+0800	mediaplaybackd	[C10.1.1 IPv4#8535a031:443/5228 ready channel-flow (satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:changed_viability @0.040s
default	11:02:46.865799+0800	mediaplaybackd	[C10.1 Hostname#3c6ac071:443/5228 ready resolver (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:changed_viability @0.040s
default	11:02:46.865861+0800	mediaplaybackd	nw_flow_connected [C10 IPv4#8535a031:443/5228 in_progress parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] Output protocol connected (endpoint_flow)
default	11:02:46.865967+0800	mediaplaybackd	[C10 IPv4#8535a031:443/5228 ready parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:finish_connect @0.040s
default	11:02:46.866121+0800	mediaplaybackd	nw_connection_report_state_with_handler_on_nw_queue [C10] reporting state ready
default	11:02:46.866149+0800	mediaplaybackd	[C10 IPv4#8535a031:443/5228 ready parent-flow (satisfied (Path is satisfied), interface: en0[802.11], ipv4, dns, uses wifi)] event: flow:changed_viability @0.040s
default	11:02:46.866199+0800	mediaplaybackd	Connection 10: connected successfully
default	11:02:46.866292+0800	mediaplaybackd	Connection 10: TLS handshake complete
default	11:02:46.866645+0800	mediaplaybackd	Connection 10: ready C(N) E(N)
default	11:02:46.866749+0800	mediaplaybackd	[C10] event: client:end_activity @0.041s, activity 
default	11:02:46.866866+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> now using Connection 10
default	11:02:46.866909+0800	mediaplaybackd	[C10] event: client:start_activity @0.041s, activity 
default	11:02:46.867223+0800	mediaplaybackd	Connection 10: received viability advisory(Y)
default	11:02:46.867295+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> sent request, body N 0
default	11:02:46.874814+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> received response, status 200 content K
default	11:02:46.874887+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> response ended
default	11:02:46.874912+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> done using Connection 10
default	11:02:46.874941+0800	mediaplaybackd	[C10] event: client:end_activity @0.055s, activity 
default	11:02:46.875174+0800	mediaplaybackd	[C10] event: client:connection_idle @0.055s
default	11:02:46.875278+0800	mediaplaybackd	[C10] event: client:connection_idle @0.055s
default	11:02:46.875360+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> summary for task success {transaction_duration_ms=61, response_status=200, connection=10, protocol="http/1.1", domain_lookup_duration_ms=2, connect_duration_ms=33, secure_connection_duration_ms=26, private_relay=false, request_start_ms=47, request_duration_ms=0, response_start_ms=60, response_duration_ms=0, request_bytes=427, request_throughput_kbps=6726, response_bytes=1200, response_throughput_kbps=2558, cache_hit=false}
default	11:02:46.875385+0800	mediaplaybackd	Task <559DB247-B83C-4C72-BEC5-5FB6D152AB96>.<17> finished successfully
default	11:02:46.875595+0800	mediaplaybackd	<<<< FigNetworkPredictionArbiter >>>> fnpa_setProperty: 0xb19270010: use ML predictions: no
default	11:02:46.875618+0800	mediaplaybackd	 segPumpParseIndexFile2: 0xb18805000: Type of playlist is Live
default	11:02:46.875669+0800	mediaplaybackd	 segPumpParseIndexFile2: 0xb18805000:0: duration changed - old is 0 new is 32
default	11:02:46.875695+0800	mediaplaybackd	 segPumpOpen: 0xb18805000: opening []
default	11:02:46.875778+0800	mediaplaybackd	 segPumpSetStartingOffset: 0xb18805000:0: live start at 16.8 sec, playlist duration 32
default	11:02:46.875806+0800	mediaplaybackd	 segPumpSetStartingOffset: 0xb18805000:1: date Wed Feb 12 11:02:26 2025 resolves to 16 seconds
default	11:02:46.875830+0800	mediaplaybackd	 segPumpSetStartingOffset: 0xb18805000:1: start offset is 16
default	11:02:46.875857+0800	mediaplaybackd	 segPumpDetermineMediaSegmentToDeliver: 0xb18805000:0: startOffsetInSeconds 16.8 startOffsetinSecondsUpTime -1
default	11:02:46.875881+0800	mediaplaybackd	 segPumpDetermineMediaSegmentToDeliver: 0xb18805000:0: starting media file read at offset 16 s
default	11:02:46.875915+0800	mediaplaybackd	 segPumpDetermineMediaSegmentToDeliver: 0xb18805000:1: startOffsetInSeconds 16 startOffsetinSecondsUpTime -1
default	11:02:46.875938+0800	mediaplaybackd	 segPumpDetermineMediaSegmentToDeliver: 0xb18805000:1: starting media file read at offset 16 s
default	11:02:46.875962+0800	mediaplaybackd	Create activity 
default	11:02:46.876013+0800	mediaplaybackd	HTTPRequest figHttpRequestSetupNSURLSessionTask: <0xb18521b80> Created NSURLSessionDataTask: LocalDataTask <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> with networkServiceType: 8
default	11:02:46.876092+0800	mediaplaybackd	Activated  with parent 
default	11:02:46.876142+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> resuming, timeouts(300.0, 604800.0) qos(0x15) voucher() activity(C21FC055-B015-41AF-81AE-16E86E5F7056)
default	11:02:46.876193+0800	mediaplaybackd	 segPumpCreateHTTPRequest: 0xb18805000:0: Byte pump 0xb18805020 created new request 0xb18521b80 for session ref 0xb180464c0
default	11:02:46.876220+0800	mediaplaybackd	 segPumpCreateMediaHTTPRequest: 0xb18805000:0:0:  session 0xb180464c0 media req offset 16.000000 url [] 0 to 0 25
default	11:02:46.876245+0800	mediaplaybackd	keyboss ckb_ensureAndGetGroup: 0xb18400a80 ck grp 1 0xb182780f0
default	11:02:46.876271+0800	mediaplaybackd	keyboss ckb_createRequestWithRequestID: 0xb18400a80 16/0 grp 1 err 0
default	11:02:46.876301+0800	mediaplaybackd	keyboss ckb_processRequest: 0xb18400a80 16/0 [] groupID 1 client 0xb18766100 exsKey 0 excReq 0 err 0 isLeaseExpired 0
default	11:02:46.876332+0800	mediaplaybackd	ckeyboss ckcb_processRequest: 0xb18766100  [] child boss reqID 16/0 groupID 1 client 0xb193ca580 err 0
default	11:02:46.876359+0800	mediaplaybackd	 segPumpProcessContentKeyRequest: 0xb18805000:0: (null) audioReqId 15/0
default	11:02:46.876384+0800	mediaplaybackd	iomfb_populate_all_display_infos: All Display Instances enumerated successfully - FB Count = 1
default	11:02:46.876539+0800	mediaplaybackd	iomfb_populate_all_display_infos: All Display Instances enumerated successfully - FB Count = 1
default	11:02:46.876648+0800	mediaplaybackd	[C9] event: client:connection_idle @0.500s
default	11:02:46.876853+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> now using Connection 9
default	11:02:46.876879+0800	mediaplaybackd	[C9] event: client:start_activity @0.500s, activity 
default	11:02:46.877249+0800	mediaplaybackd	[C9] event: client:connection_reused @0.500s
default	11:02:46.877474+0800	mediaplaybackd	 IOMobileFramebufferOpenByName: Framebuffer found=1 return 0 Name = wireless0
default	11:02:46.877552+0800	mediaplaybackd	iomfb_populate_all_display_infos: All Display Instances enumerated successfully - FB Count = 1
default	11:02:46.877717+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> sent request, body N 0
default	11:02:46.878372+0800	mediaplaybackd	 IOMobileFramebufferOpen:  success, return 0
default	11:02:46.878423+0800	mediaplaybackd	 IOMobileFramebufferOpenByName: Framebuffer found=1 return 0 Name = primary
default	11:02:46.878474+0800	mediaplaybackd	keyboss ckg_ensureProtector: 0xb18400a80 grp 1 prot 0xb1833a260
default	11:02:46.878525+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> PKDKeyManagerCreateForPastis: 0xb183db880 created key manager creationOptions: err:0
default	11:02:46.878602+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> keyManagerEntry_create: 0xb183db880 created entry for C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 err:0
default	11:02:46.878629+0800	mediaplaybackd	keyboss ck_ensureCryptor: 0xb18400a80 key 0xb187ca8b0 cryp 0xb188d0f00
default	11:02:46.878654+0800	mediaplaybackd	keyboss ckg_ensureContentKeyForRequest: 0xb18400a80 16/0 grp 1 newCk 0xb187ca8b0
default	11:02:46.878679+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestOnQueue: FigCustomURLHandlerRemoteShim.0xb18036900: issuing requestID: 2
default	11:02:46.878704+0800	mediaplaybackd	keyboss ckr_startRequestTimer: 0xb18400a80 16/0 20s
default	11:02:46.878729+0800	mediaplaybackd	keyboss ckb_sendKeyRequestViaCustomURLLoader: 0xb18400a80 16/0 customURLReqID 2 err 0
default	11:02:46.878906+0800	mediaplaybackd	keyboss ckb_processRequestViaNextHandler: 0xb18400a80  handler 4
default	11:02:46.878931+0800	mediaplaybackd	[0xb185e1980] activating connection: mach=false listener=false peer=true name=com.apple.coremedia.mediaplaybackd.figcpecryptor.xpc.peer[858].0xb185e1980
default	11:02:46.878956+0800	mediaplaybackd	keyboss ckb_ensureAndGetGroup: 0xb18400a80 ck grp 4 0xb18279180
default	11:02:46.879007+0800	mediaplaybackd	keyboss ckb_createRequestWithRequestID: 0xb18400a80 18/0 grp 4 err 0
default	11:02:46.879296+0800	mediaplaybackd	keyboss ckb_processRequest: 0xb18400a80 18/0 [] groupID 4 client 0xb18766100 exsKey 0 excReq 0 err 0 isLeaseExpired 0
default	11:02:46.879394+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestCompletionHandler: FigCustomURLHandlerRemoteShim.0xb18036900: requestID: 2, willHandle: NO
default	11:02:46.879443+0800	mediaplaybackd	keyboss ckg_ensureProtector: 0xb18400a80 grp 4 prot 0xb1833a300
default	11:02:46.879533+0800	mediaplaybackd	ckeyboss ckcb_processRequest: 0xb18766100  [] child boss reqID 18/0 groupID 4 client 0xb193ca580 err 0
default	11:02:46.879587+0800	mediaplaybackd	 segPumpProcessContentKeyRequest: 0xb18805000:0: (null) reqId 17/0
default	11:02:46.879636+0800	mediaplaybackd	Create activity 
default	11:02:46.879688+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestOnQueue: FigCustomURLHandlerRemoteShim.0xb18036680: issuing requestID: 2
default	11:02:46.879739+0800	mediaplaybackd	HTTPRequest figHttpRequestSetupNSURLSessionTask: <0xb18521400> Created NSURLSessionDataTask: LocalDataTask <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> with networkServiceType: 8
default	11:02:46.879930+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_respondToHandleRequestCompletionOnQueue: 0xb182dd460: request: 2 removing handler 0xb1817abc0 due to err -17360
default	11:02:46.880058+0800	mediaplaybackd	Activated  with parent 
default	11:02:46.880110+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestOnQueue: FigCustomURLHandlerRemoteShim.0xb18035c80: issuing requestID: 2
default	11:02:46.880156+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> resuming, timeouts(300.0, 604800.0) qos(0x15) voucher() activity(DAF3D415-2A83-4026-9908-3D2E0F6833A8)
default	11:02:46.880259+0800	mediaplaybackd	 segPumpCreateHTTPRequest: 0xb18805000:1: Byte pump 0xb18805020 created new request 0xb18521400 for session ref 0xb180464c0
default	11:02:46.880287+0800	mediaplaybackd	 segPumpCreateMediaHTTPRequest: 0xb18805000:1:0:  session 0xb180464c0 media req offset 16.000000 url [] 0 to 0 26
default	11:02:46.880312+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting SeekableRangeChanged on 0xb18980000 (0xb183cfb00)
default	11:02:46.880414+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting DurationChanged on 0xb18980000 (0xb183cf0c0)
default	11:02:46.880577+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting EndTimeChanged on 0xb18980000 (0xb183cd3a0)
default	11:02:46.880629+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting ReadyForInspection on 0xb18980000 (0xb183ced80)
default	11:02:46.880677+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting ReadyForInspection on 0xb18980000 (0xb185d4bf0)
default	11:02:46.880724+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting NewRecommendedTimeOffsetFromLive on 0xb18980000 (0xb183cf4a0)
default	11:02:46.880837+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestCompletionHandler: FigCustomURLHandlerRemoteShim.0xb18035c80: requestID: 2, willHandle: NO
default	11:02:46.880930+0800	mediaplaybackd	 complete with reason 2 (success), duration 90ms
default	11:02:46.881221+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: Using existing monitor: 
default	11:02:46.881328+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18411e40>: 
default	11:02:46.881577+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestOnQueue: FigCustomURLHandlerRemoteShim.0xb18035500: issuing requestID: 2
default	11:02:46.881791+0800	mediaplaybackd	[C10] event: client:connection_idle @0.060s
default	11:02:46.881839+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: Using existing monitor: 
default	11:02:46.881918+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18411e40>
default	11:02:46.881972+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18411c20>: 
default	11:02:46.882224+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> now using Connection 10
default	11:02:46.882276+0800	mediaplaybackd	[C10] event: client:start_activity @0.061s, activity 
default	11:02:46.882324+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting InterstitialEventsChanged on 0xb18980000 (0x0)
default	11:02:46.882575+0800	mediaplaybackd	[C10] event: client:connection_reused @0.061s
default	11:02:46.882801+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> sent request, body N 0
default	11:02:46.883642+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> PKDKeyManagerGetKeyRequestStateAndID: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 keyRequestState:1 keyRequestID:0 err:0
default	11:02:46.886466+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> keyManager_createExchangeContextAndKeyRequestInternal: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 created key request for 0 with error:0
default	11:02:46.886493+0800	mediaplaybackd	<<<< FigCPECryptorPKD >>>> FigPKDCPECryptorCreateKeyRequest: 0xb188d0f00 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 keyInfo:[] err=0 keyRequest:0xb18880800
default	11:02:46.886706+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> received response, status 200 content K
default	11:02:46.887111+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestCompletionHandler: FigCustomURLHandlerRemoteShim.0xb18035500: requestID: 2, willHandle: YES
default	11:02:46.889791+0800	mediaplaybackd	 segPumpMediaFileReadCallback: 0xb18805000:1:0: new server address is 
default	11:02:46.892819+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> received response, status 200 content K
default	11:02:46.892980+0800	mediaplaybackd	 segPumpMediaFileReadCallback: 0xb18805000:0:0: new server address is 
default	11:02:46.895560+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> response ended
default	11:02:46.895642+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> done using Connection 10
default	11:02:46.895704+0800	mediaplaybackd	[C10] event: client:end_activity @0.089s, activity 
default	11:02:46.896074+0800	mediaplaybackd	[C10] event: client:connection_idle @0.089s
default	11:02:46.896163+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> summary for task success {transaction_duration_ms=29, response_status=200, connection=10, reused=1, reused_after_ms=0, request_start_ms=1, request_duration_ms=0, response_start_ms=9, response_duration_ms=19, request_bytes=455, request_throughput_kbps=5925, response_bytes=60910, response_throughput_kbps=2979, cache_hit=false}
default	11:02:46.896461+0800	mediaplaybackd	[C10] event: client:connection_idle @0.089s
default	11:02:46.896614+0800	mediaplaybackd	Task <AC98AB07-7623-48A9-AF55-6C40D10EBC91>.<19> finished successfully
default	11:02:46.897167+0800	mediaplaybackd	 complete with reason 2 (success), duration 31ms
default	11:02:46.897752+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> response ended
default	11:02:46.897775+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> done using Connection 9
default	11:02:46.897804+0800	mediaplaybackd	[C9] event: client:end_activity @0.544s, activity 
default	11:02:46.897985+0800	mediaplaybackd	[C9] event: client:connection_idle @0.544s
default	11:02:46.898015+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> summary for task success {transaction_duration_ms=43, response_status=200, connection=9, reused=1, reused_after_ms=0, request_start_ms=0, request_duration_ms=0, response_start_ms=19, response_duration_ms=24, request_bytes=455, request_throughput_kbps=11398, response_bytes=107535, response_throughput_kbps=4341, cache_hit=false}
default	11:02:46.898121+0800	mediaplaybackd	[C9] event: client:connection_idle @0.544s
default	11:02:46.898183+0800	mediaplaybackd	Task <A6A61576-EE6D-44B4-9343-7C510AA724C2>.<18> finished successfully
default	11:02:46.898236+0800	mediaplaybackd	keyboss ck_ensureCryptor: 0xb18400a80 key 0xb187ca920 cryp 0xb183fd080
default	11:02:46.898262+0800	mediaplaybackd	keyboss ckg_ensureContentKeyForRequest: 0xb18400a80 18/0 grp 4 newCk 0xb187ca920
default	11:02:46.898286+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestOnQueue: FigCustomURLHandlerRemoteShim.0xb18036900: issuing requestID: 4
default	11:02:46.898310+0800	mediaplaybackd	keyboss ckr_startRequestTimer: 0xb18400a80 18/0 20s
default	11:02:46.898339+0800	mediaplaybackd	keyboss ckb_sendKeyRequestViaCustomURLLoader: 0xb18400a80 18/0 customURLReqID 4 err 0
default	11:02:46.898364+0800	mediaplaybackd	keyboss ckb_processRequestViaNextHandler: 0xb18400a80  handler 4
default	11:02:46.898463+0800	mediaplaybackd	 complete with reason 2 (success), duration 44ms
default	11:02:46.898552+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestCompletionHandler: FigCustomURLHandlerRemoteShim.0xb18036900: requestID: 4, willHandle: NO
default	11:02:46.898580+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestOnQueue: FigCustomURLHandlerRemoteShim.0xb18035c80: issuing requestID: 4
default	11:02:46.898680+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestCompletionHandler: FigCustomURLHandlerRemoteShim.0xb18035c80: requestID: 4, willHandle: NO
default	11:02:46.898704+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestOnQueue: FigCustomURLHandlerRemoteShim.0xb18035500: issuing requestID: 4
default	11:02:46.901668+0800	mediaplaybackd	<<<< FigCPECryptorPKD >>>> FigPKDCPECryptorCreateKeyRequest: 0xb188d0b40 EA29B28A-9079-4D40-A64C-4DB884137447 keyInfo:[] err=0 keyRequest:0xb1981e000
default	11:02:47.556279+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_handleRequestCompletionHandler: FigCustomURLHandlerRemoteShim.0xb18035500: requestID: 4, willHandle: YES
default	11:02:47.556921+0800	mediaplaybackd	keyboss ckb_customURLReadCallback: 0xb18400a80 16/0 customURLReqID 2 isComplete 0 err 0 error  (0) dokeyCallbacksExist 0
default	11:02:47.556993+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_finishLoadingOnQueue: FigCustomURLHandlerRemoteShim.0xb18035500: requestID: 2, error:  (0)
default	11:02:47.557060+0800	mediaplaybackd	keyboss ckb_customURLReadCallback: 0xb18400a80 16/0 customURLReqID 2 isComplete 0 err 0 error  (0) dokeyCallbacksExist 0
default	11:02:47.557122+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> PKDKeyManagerGetKeyRequestStateAndID: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 keyRequestState:1 keyRequestID:0 err:0
default	11:02:47.557183+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> PKDKeyManagerSetKeyRequestResponseForKeyID: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 keyRequestResponse:0xb1810ad60
default	11:02:47.557245+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> keyManager_processOnlineKeyInternal: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 input:0xb197b83a0
default	11:02:47.576889+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> keyManager_processOnlineKeyInternal: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 consumed key response and created decryptContext:0xdcedcd06
default	11:02:47.581020+0800	mediaplaybackd	<<<< FigCPECryptorPKD >>>> FigPKDCPECryptorSetKeyRequestResponse: 0xb188d0f00 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 keyResponseOptions:[] keyRequestResponse:0xb1810ad60 err:0
default	11:02:47.581075+0800	mediaplaybackd	keyboss ckb_transitionRequestToTerminalState: 0xb18400a80 16/0 reqFin err  (0) dokeyCallbacksExist 0
default	11:02:47.581129+0800	mediaplaybackd	keyboss ckb_customURLReadCallback: 0xb18400a80 16/0 customURLReqID 2 isComplete 1 err 0 error  (0) dokeyCallbacksExist 0
default	11:02:47.581180+0800	mediaplaybackd	ckeyboss ckcb_sendStatusCallbackDispatch: 0xb18766100  cryptor 0xb188d0f00 error  (0)
default	11:02:47.581229+0800	mediaplaybackd	keyboss ckr_finalize: 0xb18400a80 16/0
default	11:02:47.581284+0800	mediaplaybackd	 segPumpKeyRequestDidSucceed: 0xb18805000:0: (null) 15/0
default	11:02:47.581336+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_cancelRequestOnQueue: 0xb182dd460: requestID: 2
default	11:02:47.642801+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curlh_finishLoadingOnQueue: FigCustomURLHandlerRemoteShim.0xb18035500: requestID: 4, error:  (0)
default	11:02:47.642829+0800	mediaplaybackd	keyboss ckb_customURLReadCallback: 0xb18400a80 18/0 customURLReqID 4 isComplete 0 err 0 error  (0) dokeyCallbacksExist 0
default	11:02:47.642857+0800	mediaplaybackd	keyboss ckb_customURLReadCallback: 0xb18400a80 18/0 customURLReqID 4 isComplete 0 err 0 error  (0) dokeyCallbacksExist 0
default	11:02:47.644861+0800	mediaplaybackd	keyboss ckb_transitionRequestToTerminalState: 0xb18400a80 18/0 reqFin err  (0) dokeyCallbacksExist 0
default	11:02:47.644897+0800	mediaplaybackd	ckeyboss ckcb_sendStatusCallbackDispatch: 0xb18766100  cryptor 0xb183fd080 error  (0)
default	11:02:47.644927+0800	mediaplaybackd	keyboss ckb_customURLReadCallback: 0xb18400a80 18/0 customURLReqID 4 isComplete 1 err 0 error  (0) dokeyCallbacksExist 0
default	11:02:47.644968+0800	mediaplaybackd	keyboss ckr_finalize: 0xb18400a80 18/0
default	11:02:47.645008+0800	mediaplaybackd	 segPumpKeyRequestDidSucceed: 0xb18805000:0: (null) 17/0
default	11:02:47.645035+0800	mediaplaybackd	<<<< FigCustomURLHandling >>>> curll_cancelRequestOnQueue: 0xb182dd460: requestID: 4
default	11:02:47.645066+0800	mediaplaybackd	 segPumpContinueStreamAfterCryptKeyArrival: 0xb18805000:0: now resuming pump 1 1
default	11:02:47.645173+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> PKDKeyManagerGetKeyRequestStateAndID: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 keyRequestState:1 keyRequestID:0 err:0
default	11:02:47.645207+0800	mediaplaybackd	 segPumpSendMediaCallback: 0xb18805000:0: sending time of 16 flags 0x4144, 107348 bytes cryptor:0xb183fd080 1 audioCryptor:0xb188d0f00 1 dateDelta:21.836908 from []
default	11:02:47.645260+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_BytePumpFn: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: NewAlternate subStream 0 role 0 - resetting manifold
default	11:02:47.645287+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_BytePumpFn: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: Initial timebase time set by pump to 16
default	11:02:47.645420+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: PID 584 was excluded from monitoring
default	11:02:47.645448+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_setBandwidthConditions: 0xb1933c010:: Set LowTrigger: 336143, currentAlternate Peak/Avg/Local: 434179/434179/336144, conditionID: 47649148928
default	11:02:47.645482+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_setBandwidthConditions: 0xb1933c010:: Set HighTrigger: 752618, currentAlternate Peak/Avg/Local: 434179/434179/336144, conditionID: 47649146368
default	11:02:47.645524+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> figPruneOSTransactionArrayWhilePerformingOperation: [Fig Transaction] Pruned transaction weak reference holder: <0xb18411c20>
default	11:02:47.645566+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_CreateAndPrimeTimebaseTimer: 0xb1933c010:: scheduled timer for 20.001000, currently 16.000000
default	11:02:47.645595+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18413aa0>: 
default	11:02:47.649291+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_AddNewTrack: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: (3) Added new track 1 for substream 0 trackID 1 discDomain 0, media type vide syncPairID 1
default	11:02:47.658304+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SetTrackStartTimeAndTimeOffset: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: lastplaying is -1
default	11:02:47.658349+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ChangeTrackState: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 1 state change 0 -> 2
default	11:02:47.658382+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PushSampleBuffer: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: first sample of track 1 is 16, startTime is 16, timeOffset is -16739.45, raw: 16755.45, discDomain 0
default	11:02:47.658415+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ChangeTrackState: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 1 state change 2 -> 3
default	11:02:47.658442+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_UpdatePumpOffset: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: new pumpOffset 0, now 16, dataStart 16, pts 16
default	11:02:47.774306+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRoutingRegistryInternal: [0xb1875d300] P/BR Updating routing registry. playbackActive: 0. routingContextUUID: [577E1BCA-2D9B-41C2-A8F8-C515CE8072D4]. AudioSessionDisallowsBuffered: 0. Saved UUID: [(null)]
default	11:02:47.775428+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Called. Current route: (null) [pb: 0 t: [0x0] ][sc: 0x0][buf: 0x0][lpb: 1][usc:0]
default	11:02:47.775943+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Selected endpoint from routing context [0x0], Local Playback = 1
default	11:02:47.776127+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR Exiting (current: (null) [pb: 0 t: [0x0] ][sc: 0x0][buf: 0x0][lpb: 1][usc:0][epsAPVwSharePlay:0])
default	11:02:47.776290+0800	mediaplaybackd	<<<< FigPlayer_AP >>>> playerairplayroute_updateRouteInformation: [0xb1875d300] P/BR change route type to 0, err = 0
default	11:02:47.972115+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_BytePumpFn: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: substream 0 has 3.96 buffered now 16.000000
default	11:02:47.972192+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting ExternalProtectionStatusChanged on 0xb18a9e400 (0xb197b8180)
default	11:02:47.972240+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PostNotificationFromDispatch: posting NewAccessLogEntry on 0xb18980000 (0x0)
default	11:02:47.972286+0800	mediaplaybackd	Create activity 
default	11:02:47.972358+0800	mediaplaybackd	HTTPRequest figHttpRequestSetupNSURLSessionTask: <0xb18522800> Created NSURLSessionDataTask: LocalDataTask <9C81EFCA-4351-4823-8AE2-158D0AD06535>.<20> with networkServiceType: 8
default	11:02:47.972563+0800	mediaplaybackd	Activated  with parent 
default	11:02:47.972795+0800	mediaplaybackd	Task <9C81EFCA-4351-4823-8AE2-158D0AD06535>.<20> resuming, timeouts(300.0, 604800.0) qos(0x15) voucher() activity(A54CB184-E212-47EB-A6A4-114BB91C1CBC)
default	11:02:47.974111+0800	mediaplaybackd	 segPumpCreateHTTPRequest: 0xb18805000:0: Byte pump 0xb18805020 created new request 0xb18522800 for session ref 0xb180464c0
default	11:02:47.974169+0800	mediaplaybackd	 segPumpCreateMediaHTTPRequest: 0xb18805000:0:0:  session 0xb180464c0 media req offset 20.000000 url [] 0 to 0 27
default	11:02:47.974325+0800	mediaplaybackd	 segPumpContinueStreamAfterCryptKeyArrival: 0xb18805000:1: now resuming pump 1 1
default	11:02:47.974529+0800	mediaplaybackd	<<<< FigPKDKeyManager >>>> PKDKeyManagerGetKeyRequestStateAndID: 0xb183db880 C3BDBABE-7A1F-4D8A-83AB-5E8B503F3391 keyRequestState:1 keyRequestID:0 err:0
default	11:02:47.974587+0800	mediaplaybackd	 segPumpSendMediaCallback: 0xb18805000:1: sending time of 16 flags 0x144, 60724 bytes cryptor:0xb183fd080 1 audioCryptor:0xb188d0f00 1 dateDelta:22.039005 from []
default	11:02:47.976869+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_BytePumpFn: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: NewAlternate subStream 1 role 0 - resetting manifold
default	11:02:47.978327+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_AddNewTrack: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: (3) Added new track 2 for substream 1 trackID 1 discDomain 0, media type soun syncPairID 2
default	11:02:47.979183+0800	mediaplaybackd	[C9] event: client:connection_idle @1.604s
default	11:02:47.982479+0800	mediaplaybackd	Task <9C81EFCA-4351-4823-8AE2-158D0AD06535>.<20> now using Connection 9
default	11:02:47.982574+0800	mediaplaybackd	[C9] event: client:start_activity @1.605s, activity 
default	11:02:47.987696+0800	mediaplaybackd	[C9] event: client:connection_reused @1.608s
default	11:02:47.989624+0800	mediaplaybackd	Task <9C81EFCA-4351-4823-8AE2-158D0AD06535>.<20> sent request, body N 0
default	11:02:47.990885+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_SetTrackStartTimeAndTimeOffset: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: lastplaying is -1
default	11:02:47.991481+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ChangeTrackState: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 2 state change 0 -> 2
default	11:02:47.992214+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_PushSampleBuffer: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: first sample of track 2 is 16.077, startTime is 16, timeOffset is -16739.45, raw: 16755.53, discDomain 0
default	11:02:47.992775+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ChangeTrackState: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 2 state change 2 -> 3
default	11:02:47.994599+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ResolveStartTimeAndEnqueueBuffers: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: found video track 1
default	11:02:47.994880+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ResolveStartTimeAndEnqueueBuffers: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 1 has min ts 1440000 90000 (16), lastSampleEnd 19.96
default	11:02:47.994930+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ResolveStartTimeAndEnqueueBuffers: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: found audio track 2
default	11:02:47.994991+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ResolveStartTimeAndEnqueueBuffers: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 2 has min ts 1446960 90000 (16.077), lastSampleEnd 16.568
default	11:02:47.995066+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ResolveStartTimeAndEnqueueBuffers: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: Jumping now from 16 to 16.077s to skip 0.077333 of ragged starts
default	11:02:47.995115+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_CreateAndPrimeTimebaseTimer: 0xb1933c010:: scheduled timer for 20.001000, currently 16.077333
default	11:02:47.996740+0800	mediaplaybackd	<<<< FAVD >>>> FigAggregateVideoDestinationCreate: videoDestination created 0xb18744e80 [layers 0] [previous 0x0] [outputs ]
default	11:02:47.996788+0800	mediaplaybackd	<<<< FAVD >>>> favd_CopyFigImageQueueArrayAndOptions:  [0xb18744e80] FIQs , options (null)
default	11:02:47.996835+0800	mediaplaybackd	<<<< FAVD >>>> favd_CopyFigImageQueueArrayAndOptions:  [0xb18744e80] FIQs , options (null)
default	11:02:47.996884+0800	mediaplaybackd	<<<< FAVD >>>> favd_UpdateImageQueuesToMatchOutputsArray:  [0xb18744e80] Called for outputs (null)
default	11:02:48.000365+0800	mediaplaybackd	Received state update for 858 (app, running-active-Visible
default	11:02:48.001359+0800	mediaplaybackd	Task <9C81EFCA-4351-4823-8AE2-158D0AD06535>.<20> received response, status 200 content K
default	11:02:50.020318+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_attemptToSwitch: 0xb1933c010:: Try to switch down, measuredBw 315390, factor 0.774, currentAlternateBitrate 434179/434179/336144, bufferDuration 0.491/16.568, timebase 16.077/0.000, fileEnd 0, okayToAttemptSwitchUp 0, minSwitch 12.000, buffFull 0, LL 0, RTT 100000
default	11:02:50.222254+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_attemptToSwitch: 0xb1933c010:: Try to switch down, measuredBw 280476, factor 0.774, currentAlternateBitrate 434179/434179/336144, bufferDuration 0.491/16.568, timebase 16.077/0.000, fileEnd 0, okayToAttemptSwitchUp 0, minSwitch 12.000, buffFull 0, LL 0, RTT 100000
default	11:02:50.420126+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_attemptToSwitch: 0xb1933c010:: Try to switch down, measuredBw 251031, factor 0.774, currentAlternateBitrate 434179/434179/336144, bufferDuration 0.491/16.568, timebase 16.077/0.000, fileEnd 0, okayToAttemptSwitchUp 0, minSwitch 12.000, buffFull 0, LL 0, RTT 100000
default	11:02:50.619882+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_attemptToSwitch: 0xb1933c010:: Try to switch down, measuredBw 226165, factor 0.774, currentAlternateBitrate 434179/434179/336144, bufferDuration 0.491/16.568, timebase 16.077/0.000, fileEnd 0, okayToAttemptSwitchUp 0, minSwitch 12.000, buffFull 0, LL 0, RTT 100000
default	11:02:50.819439+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_attemptToSwitch: 0xb1933c010:: Try to switch down, measuredBw 204789, factor 0.774, currentAlternateBitrate 434179/434179/336144, bufferDuration 0.491/16.568, timebase 16.077/0.000, fileEnd 0, okayToAttemptSwitchUp 0, minSwitch 12.000, buffFull 0, LL 0, RTT 100000
default	11:02:50.943382+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_StartTrackPlaying: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: Could not create render pipeline (-12035). Halting playback
default	11:02:50.943747+0800	mediaplaybackd	<<<< FigAlternateFilterMonitorForPlaybackBitrate >>>> fampb_attemptToSwitch: 0xb1933c010:: Try to switch down, measuredBw 192974, factor 0.774, currentAlternateBitrate 434179/434179/336144, bufferDuration 0.491/16.568, timebase 16.077/0.000, fileEnd 0, okayToAttemptSwitchUp 0, minSwitch 12.000, buffFull 0, LL 0, RTT 100000
default	11:02:50.946254+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_DeleteTrack: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: (3) track 1
default	11:02:50.948391+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_StopFeedingTrack: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 1 stopped feeding without setting EndTimer
default	11:02:50.948479+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: Using existing monitor: 
default	11:02:50.948577+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18412800>: 
default	11:02:50.949081+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ChangeTrackState: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 1 state change 3 -> 8
default	11:02:50.949177+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_DeleteTrack: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: (3) track 2
default	11:02:50.949564+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_StopFeedingTrack: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 2 stopped feeding without setting EndTimer
default	11:02:50.949665+0800	mediaplaybackd	<<<< FigApplicationStateMonitor >>>> fasm_ensureApplicationStateMonitor: Using existing monitor: 
default	11:02:50.949819+0800	mediaplaybackd	<<< FigOSTransactionsUtilities >>> FigOSTransactionCreateWithProcessName: [Fig Transaction] Added transaction weak reference holder <0xb18411240>: 
default	11:02:50.950026+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ChangeTrackState: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: track 2 state change 3 -> 8
default	11:02:50.951529+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_StopPlayingItem: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: Pausing, err=Error Domain=CoreMediaErrorDomain Code=-12035
default	11:02:50.951625+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_haltStream: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: pump 0xb18805000
default	11:02:50.952004+0800	mediaplaybackd	 complete with reason 4 (cancelled), duration 3028ms
default	11:02:50.953181+0800	mediaplaybackd	 complete with reason 2 (success), duration 4216ms
default	11:02:50.953557+0800	mediaplaybackd	 complete with reason 2 (success), duration 4632ms
default	11:02:50.953676+0800	mediaplaybackd	Connection 9: cleaning up
default	11:02:50.953933+0800	mediaplaybackd	[C9 8D80EF4A-B379-46B7-B6E3-DD034C9D8112 Hostname#3c6ac071:443/5228 quic-connection, bundle id: com.pccw.nowtv.nmaf.DRMSample, pid: 858, url hash: 2814da80, traffic class: 500, definite, attribution: developer] cancel
default	11:02:50.954482+0800	mediaplaybackd	 complete with reason 2 (success), duration 4218ms
default	11:02:50.955028+0800	mediaplaybackd	 complete with reason 2 (success), duration 4633ms
default	11:02:50.955977+0800	mediaplaybackd	[C9 8D80EF4A-B379-46B7-B6E3-DD034C9D8112 Hostname#3c6ac071:443/5228 quic-connection, bundle id: com.pccw.nowtv.nmaf.DRMSample, pid: 858, url hash: 2814da80, traffic class: 500, definite, attribution: developer] cancelled
	[C9.1.1.1 2BF44A31-A9F8-4B02-AA64-7638F4F586AD 192.168.1.112:54661<->IPv4#8535a031:443/5228]
	Connected Path: satisfied (Path is satisfied), viable, interface: en0[802.11], ipv4, dns, uses wifi
	Privacy Stance: Not Eligible
	Duration: 4.630s, DNS @0.001s took 0.018s, TCP @0.021s took 0.007s, TLS 1.2 took 0.028s
	bytes in/out: 231166/2543, packets in/out: 37/43, rtt: 0.007s, retransmitted bytes: 0, out-of-order bytes: 0
	ecn packets sent/acked/marked/lost: 0/0/0/0
default	11:02:50.956227+0800	mediaplaybackd	 complete with reason 2 (success), duration 4633ms
default	11:02:50.956903+0800	mediaplaybackd	 complete with reason 2 (success), duration 4634ms
default	11:02:50.956988+0800	mediaplaybackd	nw_protocol_tcp_log_summary [C9.1.1.1:3] 
	[0A3E5DAF-09F6-4A66-8C85-DFA9DA05BB92 :54661<->:443]
	Init: 1, Conn_Time: 6.848ms, SYNs: 1, WR_T: 0/0, RD_T: 0/0, TFO: 0/0/0, ECN: 0/1/1, Accurate ECN (client/server): Unavailable/Enabled, TS: 0, TSO: 0
	rtt_cache: kernel, rtt_upd: 7, rtt: 7.812ms, rtt_var: 2.000ms rtt_nc: 7.687ms, rtt_var_nc: 2.312ms base rtt: 5ms
	ACKs-compressed: 9, ACKs delayed: 0 delayed ACKs sent: 0
default	11:02:50.957288+0800	mediaplaybackd	nw_flow_disconnected [C9 IPv4#8535a031:443/5228 cancelled parent-flow ((null))] Output protocol disconnected
default	11:02:50.957703+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_haltStream: [0xb18a9e400|P/BR] <0xb18980000|I/QYA.01>: pump 0x0
default	11:02:50.958153+0800	mediaplaybackd	<<<< FAVD >>>> favd_CopyFigImageQueueArrayAndOptions:  [0xb18744e80] FIQs , options (null)
default	11:02:50.958194+0800	mediaplaybackd	<<<< FAVD >>>> favd_UpdateImageQueuesToMatchOutputsArray:  [0xb18744e80] Called for outputs (null)
default	11:02:50.958275+0800	mediaplaybackd	nw_connection_report_state_with_handler_on_nw_queue [C9] reporting state cancelled
default	11:02:50.958358+0800	mediaplaybackd	<<<< FAVD >>>> favd_Finalize: Finalize 0xb18744e80
default	11:02:50.958400+0800	mediaplaybackd	Task <9C81EFCA-4351-4823-8AE2-158D0AD06535>.<20> done using Connection 9
default	11:02:50.958656+0800	mediaplaybackd	Connection 9: done
default	11:02:50.958745+0800	mediaplaybackd	<<<< FigStreamPlayer >>>> fpfs_ResetAudioHardwareFormat: [0xb18a9e400|P/BR] No more audio rendering, set preferred channel count back to stereo
error	11:02:50.958965+0800	mediaplaybackd	tcp_output [C9.1.1.1:3] flags=[R.] seq=2307274798, ack=3679337072, win=6749 state=CLOSED rcv_nxt=3679337072, snd_una=2307274767

0

Answer 5

HyptoKrypto OP

4d

Hi all, same here with iOS 18.4 beta ... there were already some issues with iOS 16 and HDMI connection using lightning HDMI accessory. One could suppose Apple obsoletes this use case. Our TV Service customers are not really happy of the situation.

0