SMS issue if long and sent to various users
- /e/ version: q 0.12 2020111084008
- Device model(s): FP3+
Summary
When sending a long SMS (e.g. 700 characters) to various recipients (grouped SMS or individual sent rather quickly), the SMS is not sent to every recipient, and it is quite hard to know who received it or not
The problem
Steps to reproduce
- Type a long SMS
- choose some recipients (5 is enough)
- send the SMS
What is the current behavior?
My GUI is in french. Here is an approximate translation
- a pop-up appears "Message sends a big number of SMS. Do you allow this application to keep sending messages ?"
- simultaneously, I get various notifications "The message to could not be sent"
- I click on "Allow", various times (I assume the pop-up has appeared multiple times ?)
- If I go to the conversation with one of the quoted recipient in the notifications, nothing tells me that the message has not been sent. I even have a time displayed below the message that makes me think it has been sent.
- I'm sure these recipients have not received the message
What is the expected correct behavior?
The SMS should be sent to each recipient, or at least I should be warned in the conversation and be given the opportunity to re-send the message.
Technical informations
Relevant logs (adb logcat)
11-25 12:55:01.567 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:01.567 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:01.572 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:01.585 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:274 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.585 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.587 2061 2709 I QImsService: ImsSenderRxr : [0529]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.602 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:275 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.602 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.603 2061 2709 I QImsService: ImsSenderRxr : [0530]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.616 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:276 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.616 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.617 2061 2709 I QImsService: ImsSenderRxr : [0531]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.635 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:277 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.635 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.635 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:01.636 2061 2419 I QImsService: ImsSenderRxr : [0532]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.634 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:01.639 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:278 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.639 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.640 2061 2709 I QImsService: ImsSenderRxr : [0533]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.642 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:01.658 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:279 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.658 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.659 2061 2419 I QImsService: ImsSenderRxr : [0534]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.660 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:280 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.660 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.661 2061 2709 I QImsService: ImsSenderRxr : [0535]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.681 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:281 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.681 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.682 2061 2419 I QImsService: ImsSenderRxr : [0536]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.686 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:282 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.686 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.687 2061 2709 I QImsService: ImsSenderRxr : [0537]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.693 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:01.694 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:01.699 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:01.700 1597 3169 W ActivityTaskManager: Duplicate finish request for ActivityRecord{42f5fa0 u0 foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity t731 f}
11-25 12:55:01.703 2061 2475 I QImsService: ImsSmsImpl : sendSms:: token:283 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.703 2061 2475 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.707 2061 2475 I QImsService: ImsSenderRxr : [0538]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.716 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:284 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.716 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.717 2061 2419 I QImsService: ImsSenderRxr : [0539]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.726 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:285 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.726 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.727 2061 2709 I QImsService: ImsSenderRxr : [0540]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.755 2061 2475 I QImsService: ImsSmsImpl : sendSms:: token:286 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.755 2061 2475 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.756 2061 2475 I QImsService: ImsSenderRxr : [0541]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.757 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:287 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.758 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.759 2061 2419 I QImsService: ImsSenderRxr : [0542]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.775 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:01.776 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:01.789 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:288 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.790 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.790 2061 2709 I QImsService: ImsSenderRxr : [0543]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.810 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:01.823 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:289 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.823 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.826 2061 2419 I QImsService: ImsSenderRxr : [0544]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.826 1838 1851 I ndroid.systemu: NativeAlloc concurrent copying GC freed 58656(2283KB) AllocSpace objects, 20(808KB) LOS objects, 50% free, 11MB/23MB, paused 163us total 125.329ms
11-25 12:55:01.844 2294 2333 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=21
11-25 12:55:01.845 2294 2294 D QcrilMsgTunnelIfaceManager: handleMessage what = 0
11-25 12:55:01.854 2061 2475 I QImsService: ImsSmsImpl : sendSms:: token:290 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.854 2061 2475 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.855 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:01.864 2061 2475 I QImsService: ImsSenderRxr : [0545]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.865 2061 2399 I QImsService: ImsSmsImpl : sendSms:: token:291 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.865 2061 2399 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.867 2061 2399 I QImsService: ImsSenderRxr : [0546]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.878 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:292 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.879 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.881 2061 2709 I QImsService: ImsSenderRxr : [0547]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.889 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:01.918 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:293 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.919 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.928 2061 2419 I QImsService: ImsSenderRxr : [0548]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.944 2061 2475 I QImsService: ImsSmsImpl : sendSms:: token:294 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.944 2061 2475 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.945 2061 2475 I QImsService: ImsSenderRxr : [0549]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.964 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:295 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.964 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.968 2061 2709 I QImsService: ImsSenderRxr : [0550]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.988 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:296 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.989 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.996 2061 2419 I QImsService: ImsSenderRxr : [0551]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:01.998 2061 2399 I QImsService: ImsSmsImpl : sendSms:: token:297 msgRef:0 format:3gpp isRetry:false
11-25 12:55:01.998 2061 2399 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:01.999 2061 2399 I QImsService: ImsSenderRxr : [0552]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:02.013 2061 2475 I QImsService: ImsSmsImpl : sendSms:: token:298 msgRef:0 format:3gpp isRetry:false
11-25 12:55:02.013 2061 2475 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:02.015 2061 2475 I QImsService: ImsSenderRxr : [0553]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:02.044 2061 2506 I QImsService: ImsSmsImpl : sendSms:: token:299 msgRef:0 format:3gpp isRetry:false
11-25 12:55:02.044 2061 2506 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:02.049 2061 2506 I QImsService: ImsSenderRxr : [0554]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:02.055 1838 1838 W HeadsUpManagerPhone: onHeadsUpPinnedModeChanged
11-25 12:55:02.070 2061 2399 I QImsService: ImsSmsImpl : sendSms:: token:300 msgRef:0 format:3gpp isRetry:false
11-25 12:55:02.070 2061 2399 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:02.070 2061 2061 D ServiceStateProvider: subId=1
11-25 12:55:02.072 2061 2399 I QImsService: ImsSenderRxr : [0555]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:02.081 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:02.081 2061 2219 I QImsService: ImsSenderRxr : [0529]< REQUEST_SEND_IMS_SMS { mMessageRef = 170, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:02.081 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:02.081 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:274 smsResponse:{ mMessageRef = 170, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:02.087 26400 26400 D CellBroadcastReceiver: onReceive Intent { act=android.intent.action.SERVICE_STATE flg=0x1000010 cmp=com.android.cellbroadcastreceiver/.CellBroadcastReceiver (has extras) }
11-25 12:55:02.093 2061 2709 I QImsService: ImsSmsImpl : sendSms:: token:301 msgRef:0 format:3gpp isRetry:false
11-25 12:55:02.093 2061 2709 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:02.094 2044 2620 D QCNEJ/WwanInfoRelay: onServiceStateChanged: dataState: 2 DDS:1 Notify service state update
11-25 12:55:02.095 2061 2709 I QImsService: ImsSenderRxr : [0556]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:02.096 1597 17716 D AlarmManagerService: Kernel timezone updated to -60 minutes west of GMT
11-25 12:55:02.100 2061 2419 I QImsService: ImsSmsImpl : sendSms:: token:302 msgRef:0 format:3gpp isRetry:false
11-25 12:55:02.100 2061 2419 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:02.105 2061 2419 I QImsService: ImsSenderRxr : [0557]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:02.110 2061 2475 I QImsService: ImsSmsImpl : sendSms:: token:303 msgRef:0 format:3gpp isRetry:false
11-25 12:55:02.110 2061 2475 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:02.111 2061 2475 I QImsService: ImsSenderRxr : [0558]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:02.261 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:55:02.268 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:55:02.278 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:02.330 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:02.331 2061 2219 I QImsService: ImsSenderRxr : [0530]< REQUEST_SEND_IMS_SMS { mMessageRef = 171, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:02.331 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:02.331 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:275 smsResponse:{ mMessageRef = 171, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:02.378 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:02.389 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:02.487 8532 8532 D AutofillManager: onActivityFinishing(): calling cancelLocked()
11-25 12:55:02.539 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:02.595 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:02.599 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:02.599 2061 2219 I QImsService: ImsSenderRxr : [0531]< REQUEST_SEND_IMS_SMS { mMessageRef = 172, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:02.600 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:02.600 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:276 smsResponse:{ mMessageRef = 172, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:02.607 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:02.620 1838 1838 D StatusBar: disable<e i a s b h r c s > disable2<q i n >
11-25 12:55:02.645 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:02.710 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:02.715 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:02.733 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:02.776 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:02.781 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:02.782 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:02.782 2061 2219 I QImsService: ImsSenderRxr : [0532]< REQUEST_SEND_IMS_SMS { mMessageRef = 173, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:02.783 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:02.783 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:277 smsResponse:{ mMessageRef = 173, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:02.814 11126 11126 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=7
11-25 12:55:02.815 937 11943 D NuPlayerDriver: NuPlayerDriver(0xe8233280) created, clientPid(1838)
11-25 12:55:02.819 937 11943 I Codec2Client: Creating a Codec2 client to service "software"
11-25 12:55:02.824 937 11943 I Codec2Client: Client to Codec2 service "software" created
11-25 12:55:02.844 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:02.845 937 6315 D GenericSource: FileSource remote
11-25 12:55:02.856 3407 3407 D NotificationRepository: updateNotification() called with: list = [18]
11-25 12:55:02.872 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50086|null|10114
11-25 12:55:02.874 1597 2006 I MediaFocusControl: requestAudioFocus() from uid/pid 10055/1838 clientId=android.media.AudioManager@90391b1 callingPack=com.android.systemui req=3 flags=0x0 sdk=29
11-25 12:55:02.881 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:02.885 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:02.930 3407 3407 D NotificationRepository: updateNotification() called with: list = [19]
11-25 12:55:02.936 1838 1838 W HeadsUpManagerPhone: onHeadsUpPinnedModeChanged
11-25 12:55:02.940 1838 1838 D StatusBar: disable<e i a s b h r c s > disable2<q i n >
11-25 12:55:02.943 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:02.989 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:02.993 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.000 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50051|null|10114
11-25 12:55:03.013 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:03.013 2061 2219 I QImsService: ImsSenderRxr : [0533]< REQUEST_SEND_IMS_SMS { mMessageRef = 174, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:03.013 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:03.013 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:278 smsResponse:{ mMessageRef = 174, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:03.025 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.045 3407 3407 D NotificationRepository: updateNotification() called with: list = [20]
11-25 12:55:03.058 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.062 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.070 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50071|null|10114
11-25 12:55:03.112 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.125 3407 3407 D NotificationRepository: updateNotification() called with: list = [20]
11-25 12:55:03.157 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50086|null|10114
11-25 12:55:03.175 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.193 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.217 3407 3407 D NotificationRepository: updateNotification() called with: list = [20]
11-25 12:55:03.228 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.237 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:03.237 2061 2219 I QImsService: ImsSenderRxr : [0534]< REQUEST_SEND_IMS_SMS { mMessageRef = 175, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:03.240 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:03.240 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:279 smsResponse:{ mMessageRef = 175, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:03.252 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50058|null|10114
11-25 12:55:03.290 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.301 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.341 3407 3407 D NotificationRepository: updateNotification() called with: list = [21]
11-25 12:55:03.342 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.380 11126 11126 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=7
11-25 12:55:03.380 937 6314 I GenericSource: start
11-25 12:55:03.395 1838 1838 V MediaRouter: Selecting route: RouteInfo{ name=Téléphone, description=null, status=null, category=RouteCategory{ name=Système types=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO groupable=false }, supportedTypes=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO , presentationDisplay=null }
11-25 12:55:03.395 937 6328 D CCodec : allocate(c2.android.vorbis.decoder)
11-25 12:55:03.402 937 6328 I CCodec : Created component [c2.android.vorbis.decoder]
11-25 12:55:03.402 937 6328 D CCodecConfig: read media type: audio/vorbis
11-25 12:55:03.407 937 6328 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.max-count.values
11-25 12:55:03.407 937 6328 D ReflectedParamUpdater: extent() != 1 for single value type: output.subscribed-indices.values
11-25 12:55:03.408 937 6328 D ReflectedParamUpdater: extent() != 1 for single value type: input.buffers.allocator-ids.values
11-25 12:55:03.408 937 6328 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.allocator-ids.values
11-25 12:55:03.408 937 6328 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.allocator-ids.values
11-25 12:55:03.409 937 6328 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.pool-ids.values
11-25 12:55:03.409 937 6328 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.pool-ids.values
11-25 12:55:03.415 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50051|null|10114
11-25 12:55:03.418 937 6328 I CCodecConfig: query failed after returning 7 values (BAD_INDEX)
11-25 12:55:03.419 937 6328 D CCodecConfig: c2 config diff is Dict {
11-25 12:55:03.419 937 6328 D CCodecConfig: c2::u32 coded.bitrate.value = 64000
11-25 12:55:03.419 937 6328 D CCodecConfig: c2::u32 input.buffers.max-size.value = 32768
11-25 12:55:03.419 937 6328 D CCodecConfig: c2::u32 input.delay.value = 0
11-25 12:55:03.419 937 6328 D CCodecConfig: string input.media-type.value = "audio/vorbis"
11-25 12:55:03.419 937 6328 D CCodecConfig: string output.media-type.value = "audio/raw"
11-25 12:55:03.419 937 6328 D CCodecConfig: c2::u32 raw.channel-count.value = 1
11-25 12:55:03.419 937 6328 D CCodecConfig: c2::u32 raw.sample-rate.value = 48000
11-25 12:55:03.419 937 6328 D CCodecConfig: }
11-25 12:55:03.423 937 6328 D CCodecConfig: no c2 equivalents for durationUs
11-25 12:55:03.423 937 6328 D CCodecConfig: no c2 equivalents for csd-1
11-25 12:55:03.423 937 6328 D CCodecConfig: no c2 equivalents for channel-mask
11-25 12:55:03.424 937 6328 D CCodecConfig: c2 config diff is c2::u32 raw.channel-count.value = 2
11-25 12:55:03.424 937 6328 D CCodecConfig: c2::u32 raw.sample-rate.value = 44100
11-25 12:55:03.426 937 6328 W Codec2Client: query -- param skipped: index = 1107298332.
11-25 12:55:03.426 937 6328 D CCodec : setup formats input: AMessage(what = 0x00000000) = {
11-25 12:55:03.426 937 6328 D CCodec : int32_t channel-count = 2
11-25 12:55:03.426 937 6328 D CCodec : int32_t max-input-size = 32768
11-25 12:55:03.426 937 6328 D CCodec : string mime = "audio/vorbis"
11-25 12:55:03.426 937 6328 D CCodec : int32_t sample-rate = 44100
11-25 12:55:03.426 937 6328 D CCodec : } and output: AMessage(what = 0x00000000) = {
11-25 12:55:03.426 937 6328 D CCodec : int32_t channel-count = 2
11-25 12:55:03.426 937 6328 D CCodec : string mime = "audio/raw"
11-25 12:55:03.426 937 6328 D CCodec : int32_t sample-rate = 44100
11-25 12:55:03.426 937 6328 D CCodec : int32_t channel-mask = 3
11-25 12:55:03.426 937 6328 D CCodec : }
11-25 12:55:03.428 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.430 937 6328 I MediaCodec: MediaCodec will operate in async mode
11-25 12:55:03.430 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:03.431 2061 2219 I QImsService: ImsSenderRxr : [0535]< REQUEST_SEND_IMS_SMS { mMessageRef = 176, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:03.432 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:03.432 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:280 smsResponse:{ mMessageRef = 176, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:03.432 937 6328 W Codec2Client: query -- param skipped: index = 1342179345.
11-25 12:55:03.432 937 6328 W Codec2Client: query -- param skipped: index = 2415921170.
11-25 12:55:03.434 937 6328 D BufferPoolAccessor: bufferpool2 0xec740a10 : 7(229376 size) total buffers - 7(229376 size) used buffers - 10/21 (recycle/alloc) - 11/34 (fetch/transfer)
11-25 12:55:03.434 937 6328 D CCodecBufferChannel: [c2.android.vorbis.decoder#421] Created input block pool with allocatorID 16 => poolID 473 - OK (0)
11-25 12:55:03.435 979 29494 D BufferPoolAccessor: bufferpool2 0x2a9d87e830 : 0(0 size) total buffers - 0(0 size) used buffers - 41/45 (recycle/alloc) - 4/44 (fetch/transfer)
11-25 12:55:03.435 979 29494 D BufferPoolAccessor: Destruction - bufferpool2 0x2a9d87e830 cached: 0/0M, 0/0% in use; allocs: 45, 91% recycled; transfers: 44, 91% unfetced
11-25 12:55:03.438 979 25963 D BufferPoolAccessor: bufferpool2 0x2a9d885830 : 0(0 size) total buffers - 0(0 size) used buffers - 12/15 (recycle/alloc) - 3/14 (fetch/transfer)
11-25 12:55:03.440 6240 6269 D BufferPoolAccessor: bufferpool2 0x76f4871e20 : 0(0 size) total buffers - 0(0 size) used buffers - 3/9 (recycle/alloc) - 6/56 (fetch/transfer)
11-25 12:55:03.440 6240 6269 D BufferPoolAccessor: Destruction - bufferpool2 0x76f4871e20 cached: 0/0M, 0/0% in use; allocs: 9, 33% recycled; transfers: 56, 89% unfetced
11-25 12:55:03.441 937 6328 I CCodecBufferChannel: [c2.android.vorbis.decoder#421] Created output block pool with allocatorID 16 => poolID 581 - OK
11-25 12:55:03.441 937 6328 D CCodecBufferChannel: [c2.android.vorbis.decoder#421] Configured output block pool ids 581 => OK
11-25 12:55:03.447 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.454 979 6329 D SimpleC2Component: Using output block pool with poolID 581 => got 581 - 0
11-25 12:55:03.457 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.484 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:03.500 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50058|null|10114
11-25 12:55:03.520 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:03.521 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.525 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.526 692 1781 D audio_hw_primary: adev_get_parameters:vr_audio_mode_on
11-25 12:55:03.527 692 1781 I audio_hw_primary: getting vr mode to 0
11-25 12:55:03.527 692 1781 D audio_hw_primary: adev_get_parameters: exit: returns - vr_audio_mode_on=false
11-25 12:55:03.527 737 20328 I hash_map_utils: key: 'vr_audio_mode_on' value: ''
11-25 12:55:03.529 737 20328 I AudioPolicyManagerCustom: VR mode is 0, switch to primary output if request is for fast|raw
11-25 12:55:03.529 737 20328 I AudioPolicyManagerCustom: FLAG None hence request for a primary output
11-25 12:55:03.529 737 20328 D AudioFlinger: Client defaulted notificationFrames to 11025 for frameCount 22050
11-25 12:55:03.534 737 20328 D AF::TrackHandle: OpPlayAudio: track:631 usage:5 not muted
11-25 12:55:03.551 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:03.566 692 1781 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
11-25 12:55:03.568 692 1781 D audio_hw_extn: audio_extn_set_anc_parameters: anc_enabled:0
11-25 12:55:03.568 692 1781 D audio_hw_spkr_prot: audio_extn_fbsp_set_parameters: Speaker protection disabled
11-25 12:55:03.578 692 4013 D audio_hw_primary: start_output_stream: enter: stream(0xef7ec800)usecase(1: low-latency-playback) devices(0x2)
11-25 12:55:03.578 692 4013 D audio_hw_primary: select_devices for use case (low-latency-playback)
11-25 12:55:03.578 692 4013 D audio_hw_primary: select_devices: out_snd_device(2: speaker) in_snd_device(0: )
11-25 12:55:03.578 692 4013 I msm8916_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
11-25 12:55:03.578 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
11-25 12:55:03.578 692 4013 I msm8916_platform: platform_check_and_set_codec_backend_cfg: becf: new_snd_devices[0] is speaker
11-25 12:55:03.578 692 4013 I msm8916_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 current bit width: 16 sample rate: 48000 channels: 2 usecase 1 device (speaker)
11-25 12:55:03.578 692 4013 D msm8916_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
11-25 12:55:03.578 692 4013 I msm8916_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 16 sample rate: 48000 channels: 2
11-25 12:55:03.578 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
11-25 12:55:03.578 692 4013 E msm8916_platform: platform_check_backends_match: Invalid snd_device =
11-25 12:55:03.578 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: (65) check_usecases curr device: speaker, usecase device: backends match 0
11-25 12:55:03.578 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
11-25 12:55:03.578 692 4013 D hardware_info: hw_info_append_hw_type : device_name = speaker
11-25 12:55:03.578 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:03.578 692 4013 D audio_hw_primary: enable_snd_device: snd_device(2: speaker)
11-25 12:55:03.578 692 4013 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 1, with Raise=0
11-25 12:55:03.578 692 4013 D audio_route: Apply path: speaker
11-25 12:55:03.579 692 4013 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 3, with Raise=0
11-25 12:55:03.579 692 4013 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device speaker
11-25 12:55:03.579 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:03.579 692 4013 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
11-25 12:55:03.579 692 4013 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69937, acdb_dev_id 14, sample_rate 48000, snd_device_be_idx 2
11-25 12:55:03.580 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
11-25 12:55:03.580 692 4013 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 14, path = 0, app id = 0x11131, sample rate = 48000, afe_sample_rate = 48000
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> send_asm_topology
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> send_adm_topology
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> send_audtable
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE_SIZE
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[14] app_type[69937]
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> send_audvoltable
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE_SIZE
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE, vol index 0
11-25 12:55:03.580 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_SIZE
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> send_audstrmtable
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_V2
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 16
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> send_afe_topology
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 14, Topology Id 1025e
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> send_afe_cal
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE_SIZE
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[16] acdb_id[14]
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 14 path = 0
11-25 12:55:03.581 692 4013 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
11-25 12:55:03.581 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:03.581 692 4013 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:55:03.581 692 4013 D audio_hw_primary: enable_audio_route: apply mixer and update path: low-latency-playback
11-25 12:55:03.581 692 4013 D audio_route: Apply path: low-latency-playback
11-25 12:55:03.583 692 4013 D audio_hw_primary: select_devices: done
11-25 12:55:03.587 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.588 692 4013 D msm8916_platform: platform_set_channel_map mixer_ctl_name:Playback Channel Map12
11-25 12:55:03.589 692 4013 D msm8916_platform: platform_set_channel_map: set mapping(1 2 0 0 0 0 0 0) for channel:2
11-25 12:55:03.628 692 4013 D audio_hw_primary: start_output_stream: exit
11-25 12:55:03.628 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:03.628 692 4013 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:55:03.631 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50086|null|10114
11-25 12:55:03.641 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.652 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:03.653 2061 2219 I QImsService: ImsSenderRxr : [0536]< REQUEST_SEND_IMS_SMS { mMessageRef = 177, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:03.657 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.657 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:03.657 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:281 smsResponse:{ mMessageRef = 177, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:03.694 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:03.702 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.754 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.756 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50071|null|10114
11-25 12:55:03.762 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.797 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.833 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:03.856 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.872 11126 11126 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=8
11-25 12:55:03.875 937 2124 D NuPlayerDriver: NuPlayerDriver(0xec75d040) created, clientPid(1838)
11-25 12:55:03.884 937 2124 I Codec2Client: Creating a Codec2 client to service "software"
11-25 12:55:03.885 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:03.889 1838 1858 W MessageQueue: Handler (android.media.MediaPlayer$EventHandler) {f60e37d} sending message to a Handler on a dead thread
11-25 12:55:03.889 1838 1858 W MessageQueue: java.lang.IllegalStateException: Handler (android.media.MediaPlayer$EventHandler) {f60e37d} sending message to a Handler on a dead thread
11-25 12:55:03.889 1838 1858 W MessageQueue: at android.os.MessageQueue.enqueueMessage(MessageQueue.java:558)
11-25 12:55:03.889 1838 1858 W MessageQueue: at android.os.Handler.enqueueMessage(Handler.java:754)
11-25 12:55:03.889 1838 1858 W MessageQueue: at android.os.Handler.sendMessageAtTime(Handler.java:703)
11-25 12:55:03.889 1838 1858 W MessageQueue: at android.os.Handler.sendMessageDelayed(Handler.java:673)
11-25 12:55:03.889 1838 1858 W MessageQueue: at android.os.Handler.sendMessage(Handler.java:611)
11-25 12:55:03.889 1838 1858 W MessageQueue: at android.media.MediaPlayer.postEventFromNative(MediaPlayer.java:3676)
11-25 12:55:03.894 937 2124 I Codec2Client: Client to Codec2 service "software" created
11-25 12:55:03.908 937 6335 D GenericSource: FileSource remote
11-25 12:55:03.908 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:03.912 2061 2219 I QImsService: ImsSenderRxr : [0537]< REQUEST_SEND_IMS_SMS { mMessageRef = 178, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:03.913 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:03.913 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:282 smsResponse:{ mMessageRef = 178, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:03.915 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:03.919 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:03.970 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.978 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.013 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.034 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.064 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:03.948 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50071|null|10114
11-25 12:55:04.067 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50086|null|10114
11-25 12:55:04.069 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.097 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.115 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.134 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.140 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.149 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50058|null|10114
11-25 12:55:04.172 937 6328 D CCodecBufferChannel: [c2.android.vorbis.decoder#421] buffers after EOS ignored (0 us)
11-25 12:55:04.173 937 6328 I chatty : uid=1013(media) NPDecoder-CL identical 1 line
11-25 12:55:04.174 937 6328 D CCodecBufferChannel: [c2.android.vorbis.decoder#421] buffers after EOS ignored (0 us)
11-25 12:55:04.175 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:04.175 2061 2219 I QImsService: ImsSenderRxr : [0538]< REQUEST_SEND_IMS_SMS { mMessageRef = 179, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:04.175 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:04.175 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:283 smsResponse:{ mMessageRef = 179, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:04.176 937 6326 D AudioTrack: stop(727): called with 44100 frames delivered
11-25 12:55:04.182 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.205 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.227 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.233 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50071|null|10114
11-25 12:55:04.236 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.279 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.306 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.326 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50086|null|10114
11-25 12:55:04.340 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.346 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.355 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.399 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.413 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50058|null|10114
11-25 12:55:04.415 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.424 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.444 11126 11126 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=8
11-25 12:55:04.445 937 6334 I GenericSource: start
11-25 12:55:04.446 1838 6332 V MediaPlayer: resetDrmState: mDrmInfo=null mDrmProvisioningThread=null mPrepareDrmInProgress=false mActiveDrmScheme=false
11-25 12:55:04.446 1838 6332 V MediaPlayer: cleanDrmObj: mDrmObj=null mDrmSessionId=null
11-25 12:55:04.447 937 2124 D NuPlayerDriver: reset(0xe8233280) at state 5
11-25 12:55:04.450 11126 11126 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=7
11-25 12:55:04.450 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:04.450 2061 2219 I QImsService: ImsSenderRxr : [0539]< REQUEST_SEND_IMS_SMS { mMessageRef = 180, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:04.450 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:04.450 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:284 smsResponse:{ mMessageRef = 180, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:04.459 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.462 937 6314 D NuPlayerDriver: notifyResetComplete(0xe8233280)
11-25 12:55:04.462 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.467 1838 1838 V MediaRouter: Selecting route: RouteInfo{ name=Téléphone, description=null, status=null, category=RouteCategory{ name=Système types=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO groupable=false }, supportedTypes=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO , presentationDisplay=null }
11-25 12:55:04.468 937 6341 D CCodec : allocate(c2.android.vorbis.decoder)
11-25 12:55:04.468 1838 1838 V MediaRouter: Selecting route: RouteInfo{ name=Téléphone, description=null, status=null, category=RouteCategory{ name=Système types=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO groupable=false }, supportedTypes=ROUTE_TYPE_LIVE_AUDIO ROUTE_TYPE_LIVE_VIDEO , presentationDisplay=null }
11-25 12:55:04.474 937 6341 I CCodec : Created component [c2.android.vorbis.decoder]
11-25 12:55:04.474 937 6327 D AudioTrack: stop(727): called with 0 frames delivered
11-25 12:55:04.475 937 6341 D CCodecConfig: read media type: audio/vorbis
11-25 12:55:04.483 937 6341 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.max-count.values
11-25 12:55:04.484 937 6341 D ReflectedParamUpdater: extent() != 1 for single value type: output.subscribed-indices.values
11-25 12:55:04.484 937 6341 D ReflectedParamUpdater: extent() != 1 for single value type: input.buffers.allocator-ids.values
11-25 12:55:04.484 937 6341 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.allocator-ids.values
11-25 12:55:04.485 937 6341 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.allocator-ids.values
11-25 12:55:04.485 937 6341 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.pool-ids.values
11-25 12:55:04.485 937 6341 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.pool-ids.values
11-25 12:55:04.488 937 6341 I CCodecConfig: query failed after returning 7 values (BAD_INDEX)
11-25 12:55:04.488 937 6341 D CCodecConfig: c2 config diff is Dict {
11-25 12:55:04.488 937 6341 D CCodecConfig: c2::u32 coded.bitrate.value = 64000
11-25 12:55:04.488 937 6341 D CCodecConfig: c2::u32 input.buffers.max-size.value = 32768
11-25 12:55:04.488 937 6341 D CCodecConfig: c2::u32 input.delay.value = 0
11-25 12:55:04.488 937 6341 D CCodecConfig: string input.media-type.value = "audio/vorbis"
11-25 12:55:04.488 937 6341 D CCodecConfig: string output.media-type.value = "audio/raw"
11-25 12:55:04.488 937 6341 D CCodecConfig: c2::u32 raw.channel-count.value = 1
11-25 12:55:04.488 937 6341 D CCodecConfig: c2::u32 raw.sample-rate.value = 48000
11-25 12:55:04.488 937 6341 D CCodecConfig: }
11-25 12:55:04.489 937 6341 D CCodecConfig: no c2 equivalents for durationUs
11-25 12:55:04.489 937 6341 D CCodecConfig: no c2 equivalents for csd-1
11-25 12:55:04.489 937 6341 D CCodecConfig: no c2 equivalents for channel-mask
11-25 12:55:04.490 937 6341 D CCodecConfig: c2 config diff is c2::u32 raw.channel-count.value = 2
11-25 12:55:04.490 937 6341 D CCodecConfig: c2::u32 raw.sample-rate.value = 44100
11-25 12:55:04.492 937 6341 W Codec2Client: query -- param skipped: index = 1107298332.
11-25 12:55:04.492 937 6341 D CCodec : setup formats input: AMessage(what = 0x00000000) = {
11-25 12:55:04.492 937 6341 D CCodec : int32_t channel-count = 2
11-25 12:55:04.492 937 6341 D CCodec : int32_t max-input-size = 32768
11-25 12:55:04.492 937 6341 D CCodec : string mime = "audio/vorbis"
11-25 12:55:04.492 937 6341 D CCodec : int32_t sample-rate = 44100
11-25 12:55:04.492 937 6341 D CCodec : } and output: AMessage(what = 0x00000000) = {
11-25 12:55:04.492 937 6341 D CCodec : int32_t channel-count = 2
11-25 12:55:04.492 937 6341 D CCodec : string mime = "audio/raw"
11-25 12:55:04.492 937 6341 D CCodec : int32_t sample-rate = 44100
11-25 12:55:04.492 937 6341 D CCodec : int32_t channel-mask = 3
11-25 12:55:04.492 937 6341 D CCodec : }
11-25 12:55:04.492 937 6341 I MediaCodec: MediaCodec will operate in async mode
11-25 12:55:04.494 937 6341 W Codec2Client: query -- param skipped: index = 1342179345.
11-25 12:55:04.494 937 6341 W Codec2Client: query -- param skipped: index = 2415921170.
11-25 12:55:04.495 937 6341 D CCodecBufferChannel: [c2.android.vorbis.decoder#533] Created input block pool with allocatorID 16 => poolID 474 - OK (0)
11-25 12:55:04.498 937 6341 I CCodecBufferChannel: [c2.android.vorbis.decoder#533] Created output block pool with allocatorID 16 => poolID 582 - OK
11-25 12:55:04.498 937 6341 D CCodecBufferChannel: [c2.android.vorbis.decoder#533] Configured output block pool ids 582 => OK
11-25 12:55:04.502 979 6342 D SimpleC2Component: Using output block pool with poolID 582 => got 582 - 0
11-25 12:55:04.520 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.524 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.524 692 1781 D audio_hw_primary: adev_get_parameters:vr_audio_mode_on
11-25 12:55:04.524 692 1781 I audio_hw_primary: getting vr mode to 0
11-25 12:55:04.524 692 1781 D audio_hw_primary: adev_get_parameters: exit: returns - vr_audio_mode_on=false
11-25 12:55:04.524 737 28805 I hash_map_utils: key: 'vr_audio_mode_on' value: ''
11-25 12:55:04.525 737 28805 I AudioPolicyManagerCustom: VR mode is 0, switch to primary output if request is for fast|raw
11-25 12:55:04.526 737 28805 I AudioPolicyManagerCustom: FLAG None hence request for a primary output
11-25 12:55:04.526 737 28805 D AudioFlinger: Client defaulted notificationFrames to 11025 for frameCount 22050
11-25 12:55:04.529 737 28805 D AF::TrackHandle: OpPlayAudio: track:632 usage:5 not muted
11-25 12:55:04.532 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.533 937 6338 D AudioTrack: getTimestamp_l(728): device stall time corrected using current time 110746415876762
11-25 12:55:04.573 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.577 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.587 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.625 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.631 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.651 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.664 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:04.665 2061 2219 I QImsService: ImsSenderRxr : [0540]< REQUEST_SEND_IMS_SMS { mMessageRef = 181, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:04.665 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:04.665 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:285 smsResponse:{ mMessageRef = 181, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:04.669 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50071|null|10114
11-25 12:55:04.688 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.693 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.734 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.739 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.783 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.788 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.794 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.803 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.843 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.855 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.866 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:04.873 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.905 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:04.906 2061 2219 I QImsService: ImsSenderRxr : [0541]< REQUEST_SEND_IMS_SMS { mMessageRef = 182, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:04.906 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:04.906 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:286 smsResponse:{ mMessageRef = 182, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:04.910 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.914 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.928 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:04.961 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:04.966 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.974 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.011 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.015 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:05.021 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.059 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.063 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:05.065 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.098 937 6341 D CCodecBufferChannel: [c2.android.vorbis.decoder#533] buffers after EOS ignored (0 us)
11-25 12:55:05.098 937 6341 I chatty : uid=1013(media) NPDecoder-CL identical 1 line
11-25 12:55:05.099 937 6341 D CCodecBufferChannel: [c2.android.vorbis.decoder#533] buffers after EOS ignored (0 us)
11-25 12:55:05.100 937 6338 D AudioTrack: stop(728): called with 44100 frames delivered
11-25 12:55:05.106 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.110 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:05.114 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.147 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.152 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:05.160 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.194 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.194 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:05.195 2061 2219 I QImsService: ImsSenderRxr : [0542]< REQUEST_SEND_IMS_SMS { mMessageRef = 183, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:05.195 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:05.195 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:287 smsResponse:{ mMessageRef = 183, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:05.198 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:05.240 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.293 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.300 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:04.719 1597 1597 I chatty : uid=1000 system_server identical 1 line
11-25 12:55:04.800 1597 1597 E NotificationService: Muting recently noisy 0|foundation.e.message|50071|null|10114
11-25 12:55:05.366 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:55:05.372 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:55:05.449 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:05.449 2061 2219 I QImsService: ImsSenderRxr : [0543]< REQUEST_SEND_IMS_SMS { mMessageRef = 184, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:05.449 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:05.449 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:288 smsResponse:{ mMessageRef = 184, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:05.502 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.543 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.547 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:05.611 1597 3117 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
11-25 12:55:05.627 1597 6910 I MediaFocusControl: abandonAudioFocus() from uid/pid 10055/1838 clientId=android.media.AudioManager@90391b1
11-25 12:55:05.629 11126 11126 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=7
11-25 12:55:05.629 1838 6332 V MediaPlayer: resetDrmState: mDrmInfo=null mDrmProvisioningThread=null mPrepareDrmInProgress=false mActiveDrmScheme=false
11-25 12:55:05.630 1838 6332 V MediaPlayer: cleanDrmObj: mDrmObj=null mDrmSessionId=null
11-25 12:55:05.630 937 2124 D NuPlayerDriver: reset(0xec75d040) at state 6
11-25 12:55:05.632 11126 11126 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=6
11-25 12:55:05.649 937 6334 D NuPlayerDriver: notifyResetComplete(0xec75d040)
11-25 12:55:05.656 937 6340 W AMessage: failed to post message as target looper for handler 0 is gone.
11-25 12:55:05.693 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:05.694 2061 2219 I QImsService: ImsSenderRxr : [0544]< REQUEST_SEND_IMS_SMS { mMessageRef = 185, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:05.694 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:05.694 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:289 smsResponse:{ mMessageRef = 185, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:05.779 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:05.822 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:05.826 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:05.908 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:05.909 2061 2219 I QImsService: ImsSenderRxr : [0545]< REQUEST_SEND_IMS_SMS { mMessageRef = 186, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:05.909 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:05.909 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:290 smsResponse:{ mMessageRef = 186, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:06.007 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:06.048 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:06.054 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:06.143 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:06.144 2061 2219 I QImsService: ImsSenderRxr : [0546]< REQUEST_SEND_IMS_SMS { mMessageRef = 187, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:06.145 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:06.145 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:291 smsResponse:{ mMessageRef = 187, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:06.234 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:06.274 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:06.280 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:06.390 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:06.390 2061 2219 I QImsService: ImsSenderRxr : [0547]< REQUEST_SEND_IMS_SMS { mMessageRef = 188, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:06.390 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:06.391 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:292 smsResponse:{ mMessageRef = 188, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:06.416 1597 1597 V SettingsProvider: Notifying for 0: content://settings/system/screen_brightness
11-25 12:55:06.461 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:06.503 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:06.516 1597 19027 E LightsService: Light requested not available on this device. 2
11-25 12:55:06.517 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:06.518 1838 6346 W RingtonePlayer: STOP command without a player
11-25 12:55:06.521 1597 1701 E LightsService: Light requested not available on this device. 2
11-25 12:55:06.572 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:06.572 2061 2219 I QImsService: ImsSenderRxr : [0548]< REQUEST_SEND_IMS_SMS { mMessageRef = 189, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:06.572 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:06.572 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:293 smsResponse:{ mMessageRef = 189, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:06.579 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncAdapterService] foundation.e.tasks sync of Account {name=frederic.moulis@e.email, type=e.foundation.webdav.eelo} has been initiated
11-25 12:55:06.579 13262 6348 I davx5 : PARAMETER #0 =
11-25 12:55:06.647 1597 11978 I AccountManagerService: the accounts changed, sending broadcast of android.accounts.LOGIN_ACCOUNTS_CHANGED
11-25 12:55:06.673 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:06.693 3448 3448 I Exchange: Accounts changed - requesting FolderSync for unsynced accounts
11-25 12:55:06.696 3414 3441 D Profiled: Time spent in Update: 6 milliseconds
11-25 12:55:06.709 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:06.713 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.EeloTasksSyncAdapterService] Synchronizing task list #2 [https://ecloud.global/remote.php/dav/calendars/frederic.moulis@e.email/personal/]
11-25 12:55:06.713 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] SyncManager: using up to 4 processing threads and 2 download threads
11-25 12:55:06.714 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:06.727 32515 32515 I cert4android: [foundation.e.cert4android.CustomCertService] CustomCertService created
11-25 12:55:06.731 32515 32515 I cert4android: [foundation.e.cert4android.CustomCertService] No persistent key store (yet), creating in-memory key store. This is not an error!
11-25 12:55:06.731 32515 32515 I cert4android: EXCEPTION java.io.FileNotFoundException: /data/user/0/foundation.e.accountmanager/app_KeyStore/KeyStore.bks: open failed: ENOENT (No such file or directory)
11-25 12:55:06.731 32515 32515 I cert4android: at libcore.io.IoBridge.open(IoBridge.java:496)
11-25 12:55:06.731 32515 32515 I cert4android: at java.io.FileInputStream.<init>(FileInputStream.java:159)
11-25 12:55:06.731 32515 32515 I cert4android: at foundation.e.cert4android.CustomCertService.onCreate(CustomCertService.kt:89)
11-25 12:55:06.731 32515 32515 I cert4android: at android.app.ActivityThread.handleCreateService(ActivityThread.java:3953)
11-25 12:55:06.731 32515 32515 I cert4android: at android.app.ActivityThread.access$1500(ActivityThread.java:219)
11-25 12:55:06.731 32515 32515 I cert4android: at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1875)
11-25 12:55:06.731 32515 32515 I cert4android: at android.os.Handler.dispatchMessage(Handler.java:107)
11-25 12:55:06.731 32515 32515 I cert4android: at android.os.Looper.loop(Looper.java:214)
11-25 12:55:06.731 32515 32515 I cert4android: at android.app.ActivityThread.main(ActivityThread.java:7356)
11-25 12:55:06.731 32515 32515 I cert4android: at java.lang.reflect.Method.invoke(Native Method)
11-25 12:55:06.731 32515 32515 I cert4android: at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:491)
11-25 12:55:06.731 32515 32515 I cert4android: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:940)
11-25 12:55:06.731 32515 32515 I cert4android: Caused by: android.system.ErrnoException: open failed: ENOENT (No such file or directory)
11-25 12:55:06.731 32515 32515 I cert4android: at libcore.io.Linux.open(Native Method)
11-25 12:55:06.731 32515 32515 I cert4android: at libcore.io.ForwardingOs.open(ForwardingOs.java:167)
11-25 12:55:06.731 32515 32515 I cert4android: at libcore.io.BlockGuardOs.open(BlockGuardOs.java:252)
11-25 12:55:06.731 32515 32515 I cert4android: at libcore.io.ForwardingOs.open(ForwardingOs.java:167)
11-25 12:55:06.731 32515 32515 I cert4android: at android.app.ActivityThread$AndroidOs.open(ActivityThread.java:7255)
11-25 12:55:06.731 32515 32515 I cert4android: at libcore.io.IoBridge.open(IoBridge.java:482)
11-25 12:55:06.731 32515 32515 I cert4android: ... 11 more
11-25 12:55:06.748 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Preparing synchronization
11-25 12:55:06.753 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Querying server capabilities
11-25 12:55:06.759 610 6349 E ResolverController: No valid NAT64 prefix (132, <unspecified>/0)
11-25 12:55:06.794 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:06.794 2061 2219 I QImsService: ImsSenderRxr : [0549]< REQUEST_SEND_IMS_SMS { mMessageRef = 190, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:06.795 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:06.795 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:294 smsResponse:{ mMessageRef = 190, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:06.845 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:06.872 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:06.876 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:07.039 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:07.039 2061 2219 I QImsService: ImsSenderRxr : [0550]< REQUEST_SEND_IMS_SMS { mMessageRef = 191, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:07.040 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:07.040 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:295 smsResponse:{ mMessageRef = 191, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:07.119 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:07.175 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:07.183 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:07.233 692 1781 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
11-25 12:55:07.235 692 1781 D audio_hw_primary: select_devices for use case (low-latency-playback)
11-25 12:55:07.235 692 1781 D audio_hw_extn: audio_extn_set_anc_parameters: anc_enabled:0
11-25 12:55:07.235 692 1781 D audio_hw_spkr_prot: audio_extn_fbsp_set_parameters: Speaker protection disabled
11-25 12:55:07.253 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Sending local deletes/updates to server
11-25 12:55:07.275 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Removed 0 record(s) from server
11-25 12:55:07.303 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Sent 0 record(s) to server
11-25 12:55:07.317 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Local sync state = {"type":"SYNC_TOKEN","value":"http:\/\/sabre.io\/ns\/sync\/1"}, remote sync state = {"type":"SYNC_TOKEN","value":"http:\/\/sabre.io\/ns\/sync\/1"}
11-25 12:55:07.318 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Remote collection didn't change, no reason to sync
11-25 12:55:07.324 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.EeloTasksSyncAdapterService] Task sync complete
11-25 12:55:07.328 32515 32515 I cert4android: [foundation.e.cert4android.CustomCertService] CustomCertService destroyed
11-25 12:55:07.331 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:07.332 2061 2219 I QImsService: ImsSenderRxr : [0551]< REQUEST_SEND_IMS_SMS { mMessageRef = 192, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:07.333 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:07.333 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:296 smsResponse:{ mMessageRef = 192, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:07.339 13262 6348 I davx5 : [foundation.e.accountmanager.syncadapter.SyncAdapterService] Sync for (foundation.e.tasks, Account {name=frederic.moulis@e.email, type=e.foundation.webdav.eelo}) finished
11-25 12:55:07.423 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:07.434 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncAdapterService] com.android.calendar sync of Account {name=frederic.moulis@e.email, type=e.foundation.webdav.eelo} has been initiated
11-25 12:55:07.434 13262 6350 I davx5 : PARAMETER #0 =
11-25 12:55:07.444 13262 6350 I ical4android: [foundation.e.ical4android.AndroidCalendar] Removing event colors from account Account {name=frederic.moulis@e.email, type=e.foundation.webdav.eelo}
11-25 12:55:07.465 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:07.469 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:07.499 32490 32507 W ContentResolver: Failed to get type for: content://com.android.calendar (Unknown URL content://com.android.calendar)
11-25 12:55:07.540 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.EeloCalendarsSyncAdapterService] Synchronizing calendar #1, URL: https://ecloud.global/remote.php/dav/calendars/frederic.moulis@e.email/personal/
11-25 12:55:07.540 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] SyncManager: using up to 4 processing threads and 2 download threads
11-25 12:55:07.550 32515 32515 I cert4android: [foundation.e.cert4android.CustomCertService] CustomCertService created
11-25 12:55:07.553 32515 32515 I cert4android: [foundation.e.cert4android.CustomCertService] No persistent key store (yet), creating in-memory key store. This is not an error!
11-25 12:55:07.553 32515 32515 I cert4android: EXCEPTION java.io.FileNotFoundException: /data/user/0/foundation.e.accountmanager/app_KeyStore/KeyStore.bks: open failed: ENOENT (No such file or directory)
11-25 12:55:07.553 32515 32515 I cert4android: at libcore.io.IoBridge.open(IoBridge.java:496)
11-25 12:55:07.553 32515 32515 I cert4android: at java.io.FileInputStream.<init>(FileInputStream.java:159)
11-25 12:55:07.553 32515 32515 I cert4android: at foundation.e.cert4android.CustomCertService.onCreate(CustomCertService.kt:89)
11-25 12:55:07.553 32515 32515 I cert4android: at android.app.ActivityThread.handleCreateService(ActivityThread.java:3953)
11-25 12:55:07.553 32515 32515 I cert4android: at android.app.ActivityThread.access$1500(ActivityThread.java:219)
11-25 12:55:07.553 32515 32515 I cert4android: at android.app.ActivityThread$H.handleMessage(ActivityThread.java:1875)
11-25 12:55:07.553 32515 32515 I cert4android: at android.os.Handler.dispatchMessage(Handler.java:107)
11-25 12:55:07.553 32515 32515 I cert4android: at android.os.Looper.loop(Looper.java:214)
11-25 12:55:07.553 32515 32515 I cert4android: at android.app.ActivityThread.main(ActivityThread.java:7356)
11-25 12:55:07.553 32515 32515 I cert4android: at java.lang.reflect.Method.invoke(Native Method)
11-25 12:55:07.553 32515 32515 I cert4android: at com.android.internal.os.RuntimeInit$MethodAndArgsCaller.run(RuntimeInit.java:491)
11-25 12:55:07.553 32515 32515 I cert4android: at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:940)
11-25 12:55:07.553 32515 32515 I cert4android: Caused by: android.system.ErrnoException: open failed: ENOENT (No such file or directory)
11-25 12:55:07.553 32515 32515 I cert4android: at libcore.io.Linux.open(Native Method)
11-25 12:55:07.553 32515 32515 I cert4android: at libcore.io.ForwardingOs.open(ForwardingOs.java:167)
11-25 12:55:07.553 32515 32515 I cert4android: at libcore.io.BlockGuardOs.open(BlockGuardOs.java:252)
11-25 12:55:07.553 32515 32515 I cert4android: at libcore.io.ForwardingOs.open(ForwardingOs.java:167)
11-25 12:55:07.553 32515 32515 I cert4android: at android.app.ActivityThread$AndroidOs.open(ActivityThread.java:7255)
11-25 12:55:07.553 32515 32515 I cert4android: at libcore.io.IoBridge.open(IoBridge.java:482)
11-25 12:55:07.553 32515 32515 I cert4android: ... 11 more
11-25 12:55:07.572 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Preparing synchronization
11-25 12:55:07.579 13262 6350 I davx5 : [foundation.e.accountmanager.resource.LocalCalendar] Processing deleted exceptions
11-25 12:55:07.594 13262 6350 I davx5 : [foundation.e.accountmanager.resource.LocalCalendar] Processing dirty exceptions
11-25 12:55:07.611 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:07.612 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Querying server capabilities
11-25 12:55:07.612 2061 2219 I QImsService: ImsSenderRxr : [0552]< REQUEST_SEND_IMS_SMS { mMessageRef = 193, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:07.612 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:07.612 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:297 smsResponse:{ mMessageRef = 193, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:07.701 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:07.733 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:07.737 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:07.803 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:07.803 2061 2219 I QImsService: ImsSenderRxr : [0553]< REQUEST_SEND_IMS_SMS { mMessageRef = 194, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:07.803 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:07.803 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:298 smsResponse:{ mMessageRef = 194, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:07.859 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:07.894 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:07.900 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:08.005 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:08.006 2061 2219 I QImsService: ImsSenderRxr : [0554]< REQUEST_SEND_IMS_SMS { mMessageRef = 195, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:08.006 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:08.006 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:299 smsResponse:{ mMessageRef = 195, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:08.062 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:08.094 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:08.100 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:08.134 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.CalendarSyncManager] Server supports Collection Sync: true
11-25 12:55:08.134 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Sending local deletes/updates to server
11-25 12:55:08.157 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Removed 0 record(s) from server
11-25 12:55:08.196 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Sent 0 record(s) to server
11-25 12:55:08.216 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Local sync state = {"type":"SYNC_TOKEN","value":"http:\/\/sabre.io\/ns\/sync\/1"}, remote sync state = {"type":"SYNC_TOKEN","value":"http:\/\/sabre.io\/ns\/sync\/1"}
11-25 12:55:08.217 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncManager] Remote collection didn't change, no reason to sync
11-25 12:55:08.226 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.EeloCalendarsSyncAdapterService] Calendar sync complete
11-25 12:55:08.226 13262 6350 I davx5 : [foundation.e.accountmanager.syncadapter.SyncAdapterService] Sync for (com.android.calendar, Account {name=frederic.moulis@e.email, type=e.foundation.webdav.eelo}) finished
11-25 12:55:08.226 32515 32515 I cert4android: [foundation.e.cert4android.CustomCertService] CustomCertService destroyed
11-25 12:55:08.271 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:08.272 2061 2219 I QImsService: ImsSenderRxr : [0555]< REQUEST_SEND_IMS_SMS { mMessageRef = 196, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:08.272 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:08.272 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:300 smsResponse:{ mMessageRef = 196, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:08.275 2061 2466 D MmsService: getAutoPersisting
11-25 12:55:08.324 30458 30525 W IncomingMessageObserver: Application level read timeout...
11-25 12:55:08.331 30458 30525 D IncomingMessageObserver: Network: true, Foreground: false, FCM: false, Censored: false, Registered: true, Websocket Registered: true
11-25 12:55:08.332 30458 30525 D IncomingMessageObserver: Reading message...
11-25 12:55:08.356 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:08.402 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:08.406 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:08.458 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:55:08.470 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:55:08.545 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:08.552 2061 2219 I QImsService: ImsSenderRxr : [0556]< REQUEST_SEND_IMS_SMS { mMessageRef = 197, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:08.557 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:08.557 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:301 smsResponse:{ mMessageRef = 197, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:08.559 2061 2466 D MmsService: getAutoPersisting
11-25 12:55:08.641 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:08.649 6240 6271 E BufferQueueProducer: [unnamed-6240-2] setMaxDequeuedBufferCount: 2 dequeued buffers would exceed the maxBufferCount (2) (maxAcquired 1 async 0 mDequeuedBufferCannotBlock 0)
11-25 12:55:08.650 6240 6271 E Surface : IGraphicBufferProducer::setBufferCount(3) returned Invalid argument
11-25 12:55:08.673 6240 6271 E BufferQueueProducer: [unnamed-6240-3] setMaxDequeuedBufferCount: 2 dequeued buffers would exceed the maxBufferCount (2) (maxAcquired 1 async 0 mDequeuedBufferCannotBlock 0)
11-25 12:55:08.673 6240 6271 E Surface : IGraphicBufferProducer::setBufferCount(3) returned Invalid argument
11-25 12:55:08.681 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:08.687 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:08.776 6240 6276 I GlobalScreenshot: Screenshot Intelligence not enabled, returning empty list.
11-25 12:55:08.785 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:08.785 2061 2219 I QImsService: ImsSenderRxr : [0557]< REQUEST_SEND_IMS_SMS { mMessageRef = 198, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:08.788 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:08.789 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:302 smsResponse:{ mMessageRef = 198, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:08.790 2061 2466 D MmsService: getAutoPersisting
11-25 12:55:08.832 1597 1618 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
11-25 12:55:08.931 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:08.956 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:08.985 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:08.995 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:09.003 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:09.004 2061 2219 I QImsService: ImsSenderRxr : [0558]< REQUEST_SEND_IMS_SMS { mMessageRef = 199, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:09.004 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:09.004 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:303 smsResponse:{ mMessageRef = 199, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:09.007 2061 2466 D MmsService: getAutoPersisting
11-25 12:55:09.113 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:09.176 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:09.182 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:09.254 2061 10903 D OpenGLRenderer: endAllActiveAnimators on 0x76fa50e400 (RippleDrawable) with handle 0x76f48335e0
11-25 12:55:09.268 2061 2061 I QImsService: ImsSmsImpl : sendSms:: token:304 msgRef:0 format:3gpp isRetry:false
11-25 12:55:09.268 2061 2061 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:09.270 2061 2061 I QImsService: ImsSenderRxr : [0559]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:09.275 1597 2006 E InputDispatcher: Window handle Window{779a7ce u0 com.android.phone} has no registered input channel
11-25 12:55:09.511 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:09.546 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:09.546 2061 2219 I QImsService: ImsSenderRxr : [0559]< REQUEST_SEND_IMS_SMS { mMessageRef = 200, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:09.547 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:09.547 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:304 smsResponse:{ mMessageRef = 200, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:09.603 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:09.615 1838 1851 I ndroid.systemu: NativeAlloc concurrent copying GC freed 109125(4787KB) AllocSpace objects, 69(5868KB) LOS objects, 49% free, 12MB/25MB, paused 120us total 154.069ms
11-25 12:55:09.645 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:09.651 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:09.990 2061 10903 D OpenGLRenderer: endAllActiveAnimators on 0x76fa50d500 (RippleDrawable) with handle 0x76fa401b00
11-25 12:55:10.001 2061 2061 I QImsService: ImsSmsImpl : sendSms:: token:305 msgRef:0 format:3gpp isRetry:false
11-25 12:55:10.001 2061 2061 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:10.001 1597 11978 E InputDispatcher: Window handle Window{5f41493 u0 com.android.phone} has no registered input channel
11-25 12:55:10.002 2061 2061 I QImsService: ImsSenderRxr : [0560]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:10.017 1597 6463 E InputDispatcher: Window handle Window{5f41493 u0 com.android.phone} has no registered input channel
11-25 12:55:08.859 1597 1618 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
11-25 12:55:10.035 1597 1597 V SettingsProvider: Notifying for 0: content://settings/system/screen_brightness
11-25 12:55:10.244 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:10.244 2061 2219 I QImsService: ImsSenderRxr : [0560]< REQUEST_SEND_IMS_SMS { mMessageRef = 201, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:10.245 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:10.245 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:305 smsResponse:{ mMessageRef = 201, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:10.308 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:10.344 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:10.348 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:10.646 692 1781 D audio_hw_primary: out_standby: enter: stream (0xef7ec800) usecase(1: low-latency-playback)
11-25 12:55:10.648 5424 5515 D MediaProvider: Reading images for Pictures
11-25 12:55:10.686 692 1781 D audio_hw_primary: disable_audio_route: reset and update mixer path: low-latency-playback
11-25 12:55:10.688 692 1781 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 2, with Raise=0
11-25 12:55:10.688 692 1781 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:10.688 692 1781 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:55:10.688 692 1781 D hardware_info: hw_info_append_hw_type : device_name = speaker
11-25 12:55:10.688 692 1781 D audio_hw_primary: disable_snd_device: snd_device(2: speaker)
11-25 12:55:10.688 692 1781 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:10.688 692 1781 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 0, with Raise=0
11-25 12:55:10.688 692 1781 D audio_hw_primary: out_standby: exit
11-25 12:55:10.704 5424 5515 D MediaProvider: Reading images for Telegram
11-25 12:55:10.750 2061 10903 D OpenGLRenderer: endAllActiveAnimators on 0x76fa4aa600 (RippleDrawable) with handle 0x76fa401940
11-25 12:55:10.759 2061 2061 I QImsService: ImsSmsImpl : sendSms:: token:306 msgRef:0 format:3gpp isRetry:false
11-25 12:55:10.759 2061 2061 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:10.760 2061 2061 I QImsService: ImsSenderRxr : [0561]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:10.765 5424 5515 D MediaProvider: Reading images for DCIM
11-25 12:55:10.776 1597 6463 E InputDispatcher: Window handle Window{f048ff6 u0 com.android.phone} has no registered input channel
11-25 12:55:10.778 1597 6463 E InputDispatcher: Window handle Window{f048ff6 u0 com.android.phone} has no registered input channel
11-25 12:55:10.817 5424 5515 D MediaProvider: Reading images for OpenCamera
11-25 12:55:10.866 5424 5515 D MediaProvider: Reading images for WhatsApp Images
11-25 12:55:10.928 5424 5515 D MediaProvider: Reading images for Discord
11-25 12:55:10.980 5424 5515 D MediaProvider: Reading images for Download
11-25 12:55:11.002 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:11.003 2061 2219 I QImsService: ImsSenderRxr : [0561]< REQUEST_SEND_IMS_SMS { mMessageRef = 202, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:11.003 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:11.003 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:306 smsResponse:{ mMessageRef = 202, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:11.034 5424 5515 D MediaProvider: Reading images for Screenshots
11-25 12:55:11.068 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:11.100 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:11.104 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:11.118 5424 5515 V ArbitraryDataProvider: Updating arbitrary data with cloud id: global key: media_folders value: {"imageMediaFolders":["/storage/emulated/0/Pictures","/storage/emulated/0/Pictures/Telegram","/storage/46C6-1E05/DCIM","/storage/emulated/0/DCIM/OpenCamera","/storage/emulated/0/WhatsApp/Media/WhatsApp Images","/storage/emulated/0/Pictures/Discord","/storage/emulated/0/Download","/storage/emulated/0/Pictures/Screenshots"],"videoMediaFolders":[]}
11-25 12:55:11.152 5424 5490 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=d4337aae-04f5-421e-9dd0-11e71f95e3d8, tags={ com.nextcloud.client.jobs.MediaFoldersDetectionWork, timestamp:1606305310378, *, name:immediate_media_folder_detection } ]
11-25 12:55:11.460 2061 10903 D OpenGLRenderer: endAllActiveAnimators on 0x76fa4a9700 (RippleDrawable) with handle 0x76fa401700
11-25 12:55:11.467 1597 6463 E InputDispatcher: Window handle Window{f3ffc15 u0 com.android.phone} has no registered input channel
11-25 12:55:11.469 2061 2061 I QImsService: ImsSmsImpl : sendSms:: token:307 msgRef:0 format:3gpp isRetry:false
11-25 12:55:11.469 2061 2061 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:11.471 2061 2061 I QImsService: ImsSenderRxr : [0562]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:11.484 1597 1679 E InputDispatcher: Window handle Window{f3ffc15 u0 com.android.phone} has no registered input channel
11-25 12:55:11.526 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:55:11.528 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:55:11.659 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:11.659 2061 2219 I QImsService: ImsSenderRxr : [0562]< REQUEST_SEND_IMS_SMS { mMessageRef = 203, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:11.659 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:11.659 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:307 smsResponse:{ mMessageRef = 203, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:11.723 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:11.756 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:11.760 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:12.186 2061 10903 D OpenGLRenderer: endAllActiveAnimators on 0x76fa4a7e00 (RippleDrawable) with handle 0x76fa401620
11-25 12:55:12.195 1597 11978 E InputDispatcher: Window handle Window{9e2ba0 u0 com.android.phone} has no registered input channel
11-25 12:55:12.197 2061 2061 I QImsService: ImsSmsImpl : sendSms:: token:308 msgRef:0 format:3gpp isRetry:false
11-25 12:55:12.197 2061 2061 I QImsService: ImsSenderRxr : sendSms over IImsRadio with format:3gpp
11-25 12:55:12.199 2061 2061 I QImsService: ImsSenderRxr : [0563]> REQUEST_SEND_IMS_SMS [SUB0]
11-25 12:55:12.210 1597 1679 E InputDispatcher: Window handle Window{9e2ba0 u0 com.android.phone} has no registered input channel
11-25 12:55:12.473 2061 2219 I QImsService: ImsRadioResponse : Ims sms response received
11-25 12:55:12.473 2061 2219 I QImsService: ImsSenderRxr : [0563]< REQUEST_SEND_IMS_SMS { mMessageRef = 204, mSendSmsResult = 1, mSendSmsReason = 0}[SUB0]
11-25 12:55:12.473 2061 2466 I QImsService: ImsSmsHandler : Message received: what = 1
11-25 12:55:12.474 2061 2466 I QImsService: ImsSmsImpl : onSendSmsResult:: token:308 smsResponse:{ mMessageRef = 204, mSendSmsResult = 1, mSendSmsReason = 0}
11-25 12:55:12.475 2061 2466 D MmsService: getAutoPersisting
11-25 12:55:12.536 5875 5875 I OCSMSOwnCloudClient: onChange SmsObserver
11-25 12:55:12.568 5875 5905 I ASyncSMSSync: Starting background sync
11-25 12:55:12.573 5875 5905 I ASyncSMSSync: Stopping background sync
11-25 12:55:14.574 1597 1679 I ActivityTaskManager: START u0 {flg=0x10000000 cmp=foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity (has extras)} from uid 10114
11-25 12:55:14.603 8532 8532 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@624e1fd
11-25 12:55:14.608 1838 1838 W HeadsUpManagerPhone: onHeadsUpPinnedModeChanged
11-25 12:55:14.635 8532 8532 D skia : --- Failed to create image decoder with message 'unimplemented'
11-25 12:55:14.799 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:14.800 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:15.106 1838 1838 D StatusBar: disable<e i a s b h r c s > disable2<q i n >
11-25 12:55:15.979 1838 1838 I KeyButtonView: Back button event: ACTION_DOWN
11-25 12:55:15.984 1597 1701 V InputDispatcher: Asynchronous input event injection succeeded.
11-25 12:55:16.029 1838 1838 I KeyButtonView: Back button event: ACTION_UP
11-25 12:55:16.031 1597 1617 D AutofillManagerService: onBackKeyPressed()
11-25 12:55:16.031 1597 1701 V InputDispatcher: Asynchronous input event injection succeeded.
11-25 12:55:16.203 1838 1851 I ndroid.systemu: NativeAlloc concurrent copying GC freed 35636(1447KB) AllocSpace objects, 5(316KB) LOS objects, 49% free, 12MB/24MB, paused 102us total 137.438ms
11-25 12:55:16.366 1597 1610 I system_server: NativeAlloc concurrent copying GC freed 533202(19MB) AllocSpace objects, 27(1284KB) LOS objects, 49% free, 23MB/46MB, paused 142us total 292.523ms
11-25 12:55:16.401 1597 1618 I DropBoxManagerService: add tag=system_server_strictmode isTagEnabled=true flags=0x2
11-25 12:55:17.714 2294 2333 I QcrilOemhookMsgTunnel: [0]processOemHookIndication length=21
11-25 12:55:17.715 2294 2294 D QcrilMsgTunnelIfaceManager: handleMessage what = 0
11-25 12:55:17.799 2061 2061 D ServiceStateProvider: subId=1
11-25 12:55:17.801 2044 2620 D QCNEJ/WwanInfoRelay: onServiceStateChanged: dataState: 2 DDS:1 Notify service state update
11-25 12:55:17.803 1597 3169 D AlarmManagerService: Kernel timezone updated to -60 minutes west of GMT
11-25 12:55:17.811 26400 26400 D CellBroadcastReceiver: onReceive Intent { act=android.intent.action.SERVICE_STATE flg=0x1000010 cmp=com.android.cellbroadcastreceiver/.CellBroadcastReceiver (has extras) }
11-25 12:55:16.417 1597 1618 I DropBoxManagerService: add tag=system_server_strictmode isTagEnabled=true flags=0x2
11-25 12:55:18.185 1597 3117 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
11-25 12:55:19.077 1597 3169 I ActivityTaskManager: START u0 {flg=0x10000000 cmp=foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity (has extras)} from uid 10114
11-25 12:55:19.104 8532 8532 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@fdea13
11-25 12:55:19.128 8532 8532 D skia : --- Failed to create image decoder with message 'unimplemented'
11-25 12:55:19.223 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:20.760 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:55:19.223 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:20.770 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:55:22.728 1597 3117 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
11-25 12:55:25.210 692 1781 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
11-25 12:55:25.210 692 1781 D audio_hw_extn: audio_extn_set_anc_parameters: anc_enabled:0
11-25 12:55:25.211 692 1781 D audio_hw_spkr_prot: audio_extn_fbsp_set_parameters: Speaker protection disabled
11-25 12:55:25.215 692 4013 D audio_hw_primary: start_output_stream: enter: stream(0xef7ec800)usecase(1: low-latency-playback) devices(0x2)
11-25 12:55:25.216 692 4013 D audio_hw_primary: select_devices for use case (low-latency-playback)
11-25 12:55:25.217 692 4013 D audio_hw_primary: select_devices: out_snd_device(2: speaker) in_snd_device(0: )
11-25 12:55:25.217 692 4013 I msm8916_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
11-25 12:55:25.217 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
11-25 12:55:25.217 692 4013 I msm8916_platform: platform_check_and_set_codec_backend_cfg: becf: new_snd_devices[0] is speaker
11-25 12:55:25.217 692 4013 I msm8916_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 current bit width: 16 sample rate: 48000 channels: 2 usecase 1 device (speaker)
11-25 12:55:25.217 692 4013 D msm8916_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
11-25 12:55:25.217 692 4013 I msm8916_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 16 sample rate: 48000 channels: 2
11-25 12:55:25.217 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
11-25 12:55:25.217 692 4013 E msm8916_platform: platform_check_backends_match: Invalid snd_device =
11-25 12:55:25.217 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: (65) check_usecases curr device: speaker, usecase device: backends match 0
11-25 12:55:25.217 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
11-25 12:55:25.217 692 4013 D hardware_info: hw_info_append_hw_type : device_name = speaker
11-25 12:55:25.217 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:25.217 692 4013 D audio_hw_primary: enable_snd_device: snd_device(2: speaker)
11-25 12:55:25.217 692 4013 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 1, with Raise=0
11-25 12:55:25.217 692 4013 D audio_route: Apply path: speaker
11-25 12:55:25.217 692 4013 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 3, with Raise=0
11-25 12:55:25.217 692 4013 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device speaker
11-25 12:55:25.217 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:25.218 692 4013 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
11-25 12:55:25.218 692 4013 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69937, acdb_dev_id 14, sample_rate 48000, snd_device_be_idx 2
11-25 12:55:25.219 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
11-25 12:55:25.219 692 4013 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 14, path = 0, app id = 0x11131, sample rate = 48000, afe_sample_rate = 48000
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_asm_topology
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_adm_topology
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_audtable
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE_SIZE
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[14] app_type[69937]
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_audvoltable
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE_SIZE
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE, vol index 0
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_SIZE
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_audstrmtable
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_V2
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 16
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_afe_topology
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 14, Topology Id 1025e
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_afe_cal
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE_SIZE
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[16] acdb_id[14]
11-25 12:55:25.219 692 4013 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 14 path = 0
11-25 12:55:25.220 692 4013 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
11-25 12:55:25.220 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:25.220 692 4013 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:55:25.220 692 4013 D audio_hw_primary: enable_audio_route: apply mixer and update path: low-latency-playback
11-25 12:55:25.220 692 4013 D audio_route: Apply path: low-latency-playback
11-25 12:55:25.222 692 4013 D audio_hw_primary: select_devices: done
11-25 12:55:25.226 692 4013 D msm8916_platform: platform_set_channel_map mixer_ctl_name:Playback Channel Map12
11-25 12:55:25.227 692 4013 D msm8916_platform: platform_set_channel_map: set mapping(1 2 0 0 0 0 0 0) for channel:2
11-25 12:55:25.262 692 4013 D audio_hw_primary: start_output_stream: exit
11-25 12:55:25.262 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:25.262 692 4013 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:55:26.608 6240 6271 E BufferQueueProducer: [unnamed-6240-4] setMaxDequeuedBufferCount: 2 dequeued buffers would exceed the maxBufferCount (2) (maxAcquired 1 async 0 mDequeuedBufferCannotBlock 0)
11-25 12:55:26.608 6240 6271 E Surface : IGraphicBufferProducer::setBufferCount(3) returned Invalid argument
11-25 12:55:26.633 6240 6271 E BufferQueueProducer: [unnamed-6240-5] setMaxDequeuedBufferCount: 2 dequeued buffers would exceed the maxBufferCount (2) (maxAcquired 1 async 0 mDequeuedBufferCannotBlock 0)
11-25 12:55:26.633 6240 6271 E Surface : IGraphicBufferProducer::setBufferCount(3) returned Invalid argument
11-25 12:55:26.762 6240 6276 I GlobalScreenshot: Screenshot Intelligence not enabled, returning empty list.
11-25 12:55:26.826 1597 1618 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
11-25 12:55:26.889 1838 1838 W HeadsUpManagerPhone: onHeadsUpPinnedModeChanged
11-25 12:55:26.893 1838 1838 D StatusBar: disable<e i a s b h r c s > disable2<q i n >
11-25 12:55:26.914 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:27.446 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:55:28.600 5424 5518 D MediaProvider: Reading images for Pictures
11-25 12:55:28.640 5424 5518 D MediaProvider: Reading images for Telegram
11-25 12:55:28.678 5424 5518 D MediaProvider: Reading images for DCIM
11-25 12:55:28.686 692 1781 D audio_hw_primary: out_standby: enter: stream (0xef7ec800) usecase(1: low-latency-playback)
11-25 12:55:28.722 5424 5518 D MediaProvider: Reading images for OpenCamera
11-25 12:55:28.730 692 1781 D audio_hw_primary: disable_audio_route: reset and update mixer path: low-latency-playback
11-25 12:55:28.733 692 1781 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 2, with Raise=0
11-25 12:55:28.733 692 1781 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:28.733 692 1781 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:55:28.734 692 1781 D hardware_info: hw_info_append_hw_type : device_name = speaker
11-25 12:55:28.734 692 1781 D audio_hw_primary: disable_snd_device: snd_device(2: speaker)
11-25 12:55:28.734 692 1781 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:55:28.734 692 1781 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 0, with Raise=0
11-25 12:55:28.734 692 1781 D audio_hw_primary: out_standby: exit
11-25 12:55:28.762 5424 5518 D MediaProvider: Reading images for WhatsApp Images
11-25 12:55:28.800 5424 5518 D MediaProvider: Reading images for Discord
11-25 12:55:28.840 5424 5518 D MediaProvider: Reading images for Download
11-25 12:55:28.873 5424 5518 D MediaProvider: Reading images for Screenshots
11-25 12:55:28.946 5424 5518 V ArbitraryDataProvider: Updating arbitrary data with cloud id: global key: media_folders value: {"imageMediaFolders":["/storage/emulated/0/Pictures","/storage/emulated/0/Pictures/Telegram","/storage/46C6-1E05/DCIM","/storage/emulated/0/DCIM/OpenCamera","/storage/emulated/0/WhatsApp/Media/WhatsApp Images","/storage/emulated/0/Pictures/Discord","/storage/emulated/0/Download","/storage/emulated/0/Pictures/Screenshots"],"videoMediaFolders":[]}
11-25 12:55:28.984 5424 5501 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=dc1bff9b-e934-453d-9db0-31fe46b8d673, tags={ com.nextcloud.client.jobs.MediaFoldersDetectionWork, timestamp:1606305328355, *, name:immediate_media_folder_detection } ]
11-25 12:55:28.993 1838 1838 I KeyButtonView: Back button event: ACTION_DOWN
11-25 12:55:28.999 1597 1701 V InputDispatcher: Asynchronous input event injection succeeded.
11-25 12:55:29.022 1838 1838 I KeyButtonView: Back button event: ACTION_UP
11-25 12:55:26.850 1597 1618 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
11-25 12:55:29.023 1597 1617 D AutofillManagerService: onBackKeyPressed()
11-25 12:55:29.024 1597 1701 V InputDispatcher: Asynchronous input event injection succeeded.
11-25 12:55:29.225 1838 1851 I ndroid.systemu: NativeAlloc concurrent copying GC freed 29272(1406KB) AllocSpace objects, 9(612KB) LOS objects, 49% free, 12MB/24MB, paused 123us total 166.565ms
11-25 12:55:31.646 1838 1838 W HeadsUpManagerPhone: onHeadsUpPinnedModeChanged
11-25 12:55:31.699 3407 3407 D NotificationRepository: updateNotification() called with: list = [21]
11-25 12:55:31.834 1597 1629 E KernelCpuSpeedReader: Failed to read cpu-freq: /sys/devices/system/cpu/cpu4/cpufreq/stats/time_in_state: open failed: ENOENT (No such file or directory)
11-25 12:55:31.834 1597 1629 E KernelCpuSpeedReader: Failed to read cpu-freq: /sys/devices/system/cpu/cpu0/cpufreq/stats/time_in_state: open failed: ENOENT (No such file or directory)
11-25 12:55:32.127 1838 1838 D StatusBar: disable<e i a s b h r c s > disable2<q i n >
11-25 12:55:32.704 1597 3117 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
11-25 12:55:32.858 1597 7103 I ActivityTaskManager: START u0 {flg=0x10000000 cmp=foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity (has extras)} from uid 10114
11-25 12:55:32.885 8532 8532 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@e3a21a6
11-25 12:55:32.910 8532 8532 D skia : --- Failed to create image decoder with message 'unimplemented'
11-25 12:55:33.002 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:33.002 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:36.395 1838 1851 I ndroid.systemu: NativeAlloc concurrent copying GC freed 13994(629KB) AllocSpace objects, 3(264KB) LOS objects, 49% free, 12MB/24MB, paused 131us total 134.627ms
11-25 12:55:36.532 1597 3117 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
11-25 12:55:37.297 1597 17716 I ActivityTaskManager: START u0 {flg=0x10000000 cmp=foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity (has extras)} from uid 10114
11-25 12:55:37.322 8532 8532 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@f9a7493
11-25 12:55:37.341 8532 8532 D skia : --- Failed to create image decoder with message 'unimplemented'
11-25 12:55:37.429 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:37.429 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:38.759 7528 7528 E Sonos: found_product_manager: Scans running actively: None
11-25 12:55:38.759 7528 7528 E Sonos: found_product_manager: Active LAN: App is backgrounded
11-25 12:55:38.759 7528 7528 E Sonos: found_product_manager: Scans running passively: None
11-25 12:55:38.759 7528 7528 E Sonos: found_product_manager: Passive LAN: App is backgrounded
11-25 12:55:39.516 1838 1851 I ndroid.systemu: NativeAlloc concurrent copying GC freed 3620(202KB) AllocSpace objects, 0(0B) LOS objects, 49% free, 12MB/24MB, paused 122us total 118.043ms
11-25 12:55:39.527 1597 6511 W ActivityTaskManager: Duplicate finish request for ActivityRecord{e08ebf u0 foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity t731 f}
11-25 12:55:40.483 1597 7103 I ActivityTaskManager: START u0 {flg=0x10000000 cmp=foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity (has extras)} from uid 10114
11-25 12:55:40.511 8532 8532 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@370d6a4
11-25 12:55:40.531 8532 8532 D skia : --- Failed to create image decoder with message 'unimplemented'
11-25 12:55:40.630 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:40.630 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:40.885 8532 8545 I ation.e.messag: Background young concurrent copying GC freed 419323(17MB) AllocSpace objects, 0(0B) LOS objects, 10% free, 137MB/153MB, paused 119us total 263.064ms
11-25 12:55:40.933 8532 8547 W System : A resource failed to call close.
11-25 12:55:41.060 1597 3117 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
11-25 12:55:41.212 8532 8547 I chatty : uid=10114(foundation.e.message) FinalizerDaemon identical 154 lines
11-25 12:55:41.214 8532 8547 W System : A resource failed to call close.
11-25 12:55:43.530 1838 1851 I ndroid.systemu: NativeAlloc concurrent copying GC freed 3299(177KB) AllocSpace objects, 0(0B) LOS objects, 49% free, 12MB/24MB, paused 114us total 120.860ms
11-25 12:55:44.990 1597 17716 I ActivityTaskManager: START u0 {flg=0x10000000 cmp=foundation.e.message/com.moez.QKSMS.feature.compose.ComposeActivity (has extras)} from uid 10114
11-25 12:55:45.017 8532 8532 W ActivityThread: handleWindowVisibility: no activity for token android.os.BinderProxy@a5f0935
11-25 12:55:45.039 8532 8532 D skia : --- Failed to create image decoder with message 'unimplemented'
11-25 12:55:45.137 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:45.137 8532 8532 E RecyclerView: No adapter attached; skipping layout
11-25 12:55:46.880 30458 4342 D WebSocketConnection: Sending keep alive...
11-25 12:55:46.891 30458 4343 D WebSocketConnection: Sending keep alive...
11-25 12:55:46.899 30458 4342 W AlarmSleepTimer: Setting alarm to wake up in 55000ms.
11-25 12:55:46.900 30458 30458 W AlarmSleepTimer: Waking up.
11-25 12:55:46.902 30458 30458 W AlarmSleepTimer: Waking up.
11-25 12:55:46.902 30458 4343 W AlarmSleepTimer: Setting alarm to wake up in 55000ms.
11-25 12:55:47.425 1838 1838 D StatusBar: disable<e i a s b h r c s > disable2<q i n >
11-25 12:55:47.649 1597 3117 E TaskPersister: File error accessing recents directory (directory doesn't exist?).
11-25 12:55:47.463 1838 1838 D StatusBar: disable<e i a s b h r c s > disable2<q i n >
11-25 12:55:54.069 1597 17716 D WificondControl: Scan result ready event
11-25 12:55:54.076 1019 2210 I LOWI-8.6.0.75: [LOWI-Scan] lowi_close_record:Scan done in 400974852ms, 6 APs in scan results
11-25 12:55:57.818 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:55:57.825 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:55:59.010 1597 1597 V SettingsProvider: Notifying for 0: content://settings/system/screen_brightness
11-25 12:56:00.013 1838 1838 D KeyguardClockSwitch: Updating clock: 12:56
11-25 12:56:02.672 692 1781 D audio_hw_primary: out_set_parameters: enter: usecase(1: low-latency-playback) kvpairs: routing=2
11-25 12:56:02.672 692 1781 D audio_hw_extn: audio_extn_set_anc_parameters: anc_enabled:0
11-25 12:56:02.672 692 1781 D audio_hw_spkr_prot: audio_extn_fbsp_set_parameters: Speaker protection disabled
11-25 12:56:02.681 692 4013 D audio_hw_primary: start_output_stream: enter: stream(0xef7ec800)usecase(1: low-latency-playback) devices(0x2)
11-25 12:56:02.682 692 4013 D audio_hw_primary: select_devices for use case (low-latency-playback)
11-25 12:56:02.682 692 4013 D audio_hw_primary: select_devices: out_snd_device(2: speaker) in_snd_device(0: )
11-25 12:56:02.682 692 4013 I msm8916_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 16, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
11-25 12:56:02.682 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
11-25 12:56:02.682 692 4013 I msm8916_platform: platform_check_and_set_codec_backend_cfg: becf: new_snd_devices[0] is speaker
11-25 12:56:02.682 692 4013 I msm8916_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 current bit width: 16 sample rate: 48000 channels: 2 usecase 1 device (speaker)
11-25 12:56:02.682 692 4013 D msm8916_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
11-25 12:56:02.682 692 4013 I msm8916_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 16 sample rate: 48000 channels: 2
11-25 12:56:02.682 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
11-25 12:56:02.682 692 4013 E msm8916_platform: platform_check_backends_match: Invalid snd_device =
11-25 12:56:02.682 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: (65) check_usecases curr device: speaker, usecase device: backends match 0
11-25 12:56:02.682 692 4013 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
11-25 12:56:02.682 692 4013 D hardware_info: hw_info_append_hw_type : device_name = speaker
11-25 12:56:02.682 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:56:02.682 692 4013 D audio_hw_primary: enable_snd_device: snd_device(2: speaker)
11-25 12:56:02.682 692 4013 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 1, with Raise=0
11-25 12:56:02.682 692 4013 D audio_route: Apply path: speaker
11-25 12:56:02.682 692 4013 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 3, with Raise=0
11-25 12:56:02.682 692 4013 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device speaker
11-25 12:56:02.682 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:56:02.683 692 4013 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
11-25 12:56:02.683 692 4013 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69937, acdb_dev_id 14, sample_rate 48000, snd_device_be_idx 2
11-25 12:56:02.683 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(1) new_snd_devices(0)
11-25 12:56:02.683 692 4013 D audio_hw_utils: audio_extn_btsco_get_sample_rate:Not a BT SCO device, need not update sampling rate
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 14, path = 0, app id = 0x11131, sample rate = 48000, afe_sample_rate = 48000
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_asm_topology
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_adm_topology
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_audtable
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE_SIZE
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[14] app_type[69937]
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_audvoltable
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE_SIZE
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE, vol index 0
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_SIZE
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_audstrmtable
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_V2
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 16
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_afe_topology
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 14, Topology Id 1025e
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_afe_cal
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE_SIZE
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[16] acdb_id[14]
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 14 path = 0
11-25 12:56:02.684 692 4013 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
11-25 12:56:02.684 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:56:02.684 692 4013 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:56:02.684 692 4013 D audio_hw_primary: enable_audio_route: apply mixer and update path: low-latency-playback
11-25 12:56:02.684 692 4013 D audio_route: Apply path: low-latency-playback
11-25 12:56:02.686 692 4013 D audio_hw_primary: select_devices: done
11-25 12:56:02.690 692 4013 D msm8916_platform: platform_set_channel_map mixer_ctl_name:Playback Channel Map12
11-25 12:56:02.690 692 4013 D msm8916_platform: platform_set_channel_map: set mapping(1 2 0 0 0 0 0 0) for channel:2
11-25 12:56:02.725 692 4013 D audio_hw_primary: start_output_stream: exit
11-25 12:56:02.725 692 4013 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:56:02.725 692 4013 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:56:03.998 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:56:04.009 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:56:04.076 6240 6271 E BufferQueueProducer: [unnamed-6240-6] setMaxDequeuedBufferCount: 2 dequeued buffers would exceed the maxBufferCount (2) (maxAcquired 1 async 0 mDequeuedBufferCannotBlock 0)
11-25 12:56:04.076 6240 6271 E Surface : IGraphicBufferProducer::setBufferCount(3) returned Invalid argument
11-25 12:56:04.109 6240 6271 E BufferQueueProducer: [unnamed-6240-7] setMaxDequeuedBufferCount: 2 dequeued buffers would exceed the maxBufferCount (2) (maxAcquired 1 async 0 mDequeuedBufferCannotBlock 0)
11-25 12:56:04.109 6240 6271 E Surface : IGraphicBufferProducer::setBufferCount(3) returned Invalid argument
11-25 12:56:04.232 6240 6276 I GlobalScreenshot: Screenshot Intelligence not enabled, returning empty list.
11-25 12:56:04.278 1597 1618 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
11-25 12:56:04.383 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:56:05.024 3407 3407 D NotificationRepository: updateNotification() called with: list = [22]
11-25 12:56:05.840 610 991 I netd : firewallSetUidRule(2, 10157, 1) <0.23ms>
11-25 12:56:05.905 5176 5223 I Optly.shared: Processing schueduled service
11-25 12:56:05.932 5176 5176 I Optly.datafileHandler: Refreshing data file
11-25 12:56:05.939 610 991 I netd : firewallSetUidRule(2, 10157, 2) <0.11ms>
11-25 12:56:05.943 5176 6574 I Optly.datafileHandler: Requesting data file from https://cdn.optimizely.com/datafiles/BcZjGj5QwPvaugyLkb9Uwt.json
11-25 12:56:06.002 610 6575 E ResolverController: No valid NAT64 prefix (132, <unspecified>/0)
11-25 12:56:06.113 5424 5515 D MediaProvider: Reading images for Pictures
11-25 12:56:06.146 692 1781 D audio_hw_primary: out_standby: enter: stream (0xef7ec800) usecase(1: low-latency-playback)
11-25 12:56:06.159 5424 5515 D MediaProvider: Reading images for Telegram
11-25 12:56:06.188 692 1781 D audio_hw_primary: disable_audio_route: reset and update mixer path: low-latency-playback
11-25 12:56:06.191 692 1781 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 1 of type 0 for Event 2, with Raise=0
11-25 12:56:06.191 692 1781 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:56:06.191 692 1781 I msm8916_platform: platform_get_custom_mtmx_params: no matching param with id 0 ip_ch 2 op_ch 1 uc_id 1 snd_dev 2
11-25 12:56:06.191 692 1781 D hardware_info: hw_info_append_hw_type : device_name = speaker
11-25 12:56:06.191 692 1781 D audio_hw_primary: disable_snd_device: snd_device(2: speaker)
11-25 12:56:06.191 692 1781 D msm8916_platform: platform_split_snd_device: snd_device(2) num devices(0) new_snd_devices(0)
11-25 12:56:06.191 692 1781 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 0, with Raise=0
11-25 12:56:06.191 692 1781 D audio_hw_primary: out_standby: exit
11-25 12:56:06.195 5424 5515 D MediaProvider: Reading images for DCIM
11-25 12:56:06.228 5424 5515 D MediaProvider: Reading images for OpenCamera
11-25 12:56:06.272 5424 5515 D MediaProvider: Reading images for WhatsApp Images
11-25 12:56:06.326 5424 5515 D MediaProvider: Reading images for Discord
11-25 12:56:06.383 5424 5515 D MediaProvider: Reading images for Download
11-25 12:56:06.436 5424 5515 D MediaProvider: Reading images for Screenshots
11-25 12:56:06.490 5424 5515 V ArbitraryDataProvider: Updating arbitrary data with cloud id: global key: media_folders value: {"imageMediaFolders":["/storage/emulated/0/Pictures","/storage/emulated/0/Pictures/Telegram","/storage/46C6-1E05/DCIM","/storage/emulated/0/DCIM/OpenCamera","/storage/emulated/0/WhatsApp/Media/WhatsApp Images","/storage/emulated/0/Pictures/Discord","/storage/emulated/0/Download","/storage/emulated/0/Pictures/Screenshots"],"videoMediaFolders":[]}
11-25 12:56:06.524 5424 5490 I WM-WorkerWrapper: Worker result SUCCESS for Work [ id=05fb83a4-532c-454b-affd-5f8ac86cbebf, tags={ com.nextcloud.client.jobs.MediaFoldersDetectionWork, timestamp:1606305365915, *, name:immediate_media_folder_detection } ]
11-25 12:56:04.306 1597 1618 I DropBoxManagerService: add tag=system_app_strictmode isTagEnabled=true flags=0x2
11-25 12:56:07.108 1597 1770 D ConnectivityService: maybeHandleNetworkMonitorMessage: 528386
11-25 12:56:07.121 2044 2620 D QCNEJ/WlanStaInfoRelay: Received action: android.net.wifi.RSSI_CHANGED
11-25 12:56:08.334 30458 30525 W IncomingMessageObserver: Application level read timeout...
11-25 12:56:08.339 30458 30525 D IncomingMessageObserver: Network: true, Foreground: false, FCM: false, Censored: false, Registered: true, Websocket Registered: true
11-25 12:56:08.340 30458 30525 D IncomingMessageObserver: Reading message...
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: Error making request
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: java.net.SocketTimeoutException: failed to connect to cdn.optimizely.com/2.20.88.180 (port 443) from /192.168.1.195 (port 37244) after 5000ms
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at libcore.io.IoBridge.connectErrno(IoBridge.java:191)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at libcore.io.IoBridge.connect(IoBridge.java:135)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.net.PlainSocketImpl.socketConnect(PlainSocketImpl.java:142)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:390)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:230)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:212)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:436)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.net.Socket.connect(Socket.java:621)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.Platform.connectSocket(Platform.java:182)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.io.RealConnection.connectSocket(RealConnection.java:145)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.io.RealConnection.connect(RealConnection.java:116)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.http.StreamAllocation.findConnection(StreamAllocation.java:186)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.http.StreamAllocation.findHealthyConnection(StreamAllocation.java:128)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.http.StreamAllocation.newStream(StreamAllocation.java:97)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.http.HttpEngine.connect(HttpEngine.java:289)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.http.HttpEngine.sendRequest(HttpEngine.java:232)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.huc.HttpURLConnectionImpl.execute(HttpURLConnectionImpl.java:465)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.huc.HttpURLConnectionImpl.connect(HttpURLConnectionImpl.java:131)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.huc.DelegatingHttpsURLConnection.connect(DelegatingHttpsURLConnection.java:90)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.android.okhttp.internal.huc.HttpsURLConnectionImpl.connect(HttpsURLConnectionImpl.java:30)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.optimizely.ab.android.datafile_handler.DatafileClient$1.execute(DatafileClient.java:82)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.optimizely.ab.android.datafile_handler.DatafileClient$1.execute(DatafileClient.java:66)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.optimizely.ab.android.shared.Client.execute(Client.java:143)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.optimizely.ab.android.datafile_handler.DatafileClient.request(DatafileClient.java:111)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.optimizely.ab.android.datafile_handler.DatafileLoader$RequestDatafileFromClientTask.doInBackground(DatafileLoader.java:113)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at com.optimizely.ab.android.datafile_handler.DatafileLoader$RequestDatafileFromClientTask.doInBackground(DatafileLoader.java:85)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at android.os.AsyncTask$3.call(AsyncTask.java:378)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.util.concurrent.FutureTask.run(FutureTask.java:266)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
11-25 12:56:11.064 5176 6574 E Optly.datafileHandler: at java.lang.Thread.run(Thread.java:919)
11-25 12:56:11.065 5176 6574 I Optly.shared: Request failed, waiting 2 seconds to try again
11-25 12:56:11.547 1597 1632 E LightsService: Light requested not available on this device. 2
Relevant screenshots
Solutions
Workaround send the message separately to each recipient. wait 1 minute between each recipient (it may be possible to wait less than 1 minute)
Possible fixes