--------- beginning of system 04-12 07:41:58.860 1509: 2707 I/PackageManager: START DELETE PACKAGE: observer{127851381} pkg{com.appadvisory.drawclimber}, user{0}, caller{2000} flags{2} 04-12 07:41:58.860 1509: 1546 D/PackageSettings: ++ writeStateForUserSyncLPr(0) 04-12 07:41:58.860 1509: 1546 W/PackageSettings: -- writeStateForUserSyncLPr(0) --------- beginning of main 04-12 07:41:58.861 1509: 1590 D/ApplicationPolicy: getApplicationUninstallationEnabled 04-12 07:41:58.861 1509: 1590 D/ApplicationPolicy: getApplicationUninstallationEnabled : enabled true 04-12 07:41:58.875 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:58.875 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:41:58.880 1509: 1590 W/PackageManager: Not removing non-existent package com.appadvisory.drawclimber 04-12 07:41:58.880 1509: 1590 I/PackageManager: result of delete: -1{127851381} 04-12 07:41:58.909 13061:13061 I/abb: StartCommandInProcess(73657474696e67730067657400656e61 settings.get.ena [truncated]) 04-12 07:41:58.920 1943: 2321 I/AODCommonSettingsUtils: addLogText 04-12 07:41:58.922 13061:13061 I/abb: StartCommandInProcess(7061636b61676500696e7374616c6c00 package.install. [truncated]) 04-12 07:41:58.926 1509: 2707 I/PersonaServiceHelper: isCallerApprovedToInstall(uid:2000 userHandle:0) 04-12 07:41:58.926 1509: 2707 I/PersonaServiceHelper: DO is not enabled. no Knox app install enforcement 04-12 07:41:58.926 1509: 2707 I/PackageInstaller: getting through the check android.content.pm.PackageInstaller$SessionParams@53edef3 user id 0 04-12 07:41:58.926 1509: 2707 I/PackageInstaller: UserManager.DISALLOW_NON_MARKET_APP_BY_KNOX : false 04-12 07:41:58.939 2420:13069 I/HoneySpace.InstallSessionSourceImpl: onCreated 1452981204 04-12 07:41:58.948 3379: 4485 I/SDHMS:C: SIOP:: AP:434 BAT:358 USB:355 CHG:421 PA:419 WIFI:409 BLK:0 SUBBAT:0 SKIN:386 SKINF:380 SKINB:386 LRP:386 LRP2:386 LRF2:380 LRB2:386 AP2:386 CHG2:369 MEM2:386 WIFI2:386 SPK2:350 VAP05:441 04-12 07:41:58.956 593: 593 D/io_stats: !@ 8,32 r 32554730 675602592 w 9621945 304893740 d 585345 337974524 f 0 774252 iot 20024028 0 th 0 0 0 pt 0 inp 0 1 138453.597 04-12 07:41:59.036 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:59.036 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:41:59.198 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:59.198 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:41:59.204 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:41:59.325 892:26259 I/HYPER-HAL: [RequestManager.cpp]releaseLocked(): Released ID : 5778320 04-12 07:41:59.358 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:59.359 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:41:59.516 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:59.516 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:41:59.568 26113:26193 I/RunestoneSDK: [1.3.11]Called module : V15RunestoneStateModule -> getRunestoneState(Unknown Source:19) 04-12 07:41:59.574 26260:26270 I/Rubin: [122] com.samsung.android.rubin.controller.provider.RubinStateProvider.call(Unknown Source) : RubinStateProvider : method = getRubinState 04-12 07:41:59.576 26260:26270 I/Rubin: [122] com.samsung.android.rubin.controller.provider.RubinStateProvider.call(Unknown Source) : RubinStateProvider : watch state = -2 04-12 07:41:59.576 26260:26270 I/Rubin: 122] q8.c.a(Unknown Source) : active permissions : [NEARBY_DEVICES, CALL_LOG, CONTACTS, STORAGE, SMS, CALENDAR, PHYSICAL_ACTIVITY, LOCATION: 04-12 07:41:59.578 26260:26270 I/Rubin: [122] com.samsung.android.rubin.controller.provider.RubinStateProvider.h(Unknown Source) : Is alternative Agreement : false, is Rubin ID exist : false 04-12 07:41:59.579 26260:26270 I/Rubin: [122] aa.i.b(Unknown Source) : checkForUI = false isGdprAffected = false isCMSFeatureSupported = true 04-12 07:41:59.580 26260:26270 I/Rubin: [122] aa.i.b(Unknown Source) : checkForUI = false isGdprAffected = false isCMSFeatureSupported = true 04-12 07:41:59.580 26260:26270 I/Rubin: [122] aa.i.b(Unknown Source) : checkForUI = false isGdprAffected = false isCMSFeatureSupported = true 04-12 07:41:59.580 26260:26270 I/Rubin: [122] aa.i.b(Unknown Source) : checkForUI = false isGdprAffected = false isCMSFeatureSupported = true 04-12 07:41:59.584 26113:26193 I/[WEATHER: {[6E099A6F08D647829A2B7E3CFA1CA20DA12453F944A27016475E0EE04A44106509DAF675C05010A848D46C221F5FAA800D21494CC1E071305AA45C987AC367AC44AD7E8C185ADCFD2511976FA5F6538BA1660E1D0C5856CE51B06799352B24A3]} 04-12 07:41:59.593 26113:26193 I/RunestoneSDK: [1.3.11]Called module : V30ContextFenceInformation -> getRegisteredContextFenceList(Unknown Source:17) 04-12 07:41:59.598 26260:26270 I/Rubin: [122] ha.f.call(Unknown Source) : Method : get_registered_context_fences, Calling Package - com.sec.android.daemonapp 04-12 07:41:59.599 26260:26260 E/Rubin: [2] ha.f.l(Unknown Source) : runestone modules are not started, so start runestone modules 04-12 07:41:59.600 26260:26260 I/Rubin: [2] aa.w.y(Unknown Source) : Enabling rubin service 04-12 07:41:59.603 26260:26270 I/AccessController: isAllowedPackage - com.sec.android.daemonapp is allowed to access 04-12 07:41:59.605 26260:26260 I/Rubin: [2] aa.w.y(Unknown Source) : SA is not signed-in 04-12 07:41:59.605 26260:26270 W/Rubin: [122] ha.f.k(Unknown Source) : Rubin is disabled 04-12 07:41:59.606 26260:26270 I/Rubin: 122] q8.c.a(Unknown Source) : active permissions : [NEARBY_DEVICES, CALL_LOG, CONTACTS, STORAGE, SMS, CALENDAR, PHYSICAL_ACTIVITY, LOCATION: 04-12 07:41:59.608 26113:26193 I/[WEATHER: {[6E099A6F08D647829A2B7E3CFA1CA20DDA7C0F82C2703992423C816CF7CABA38573A6D1D928DAF910F5B2CAB7DEE94B9CD8B5DCDE87C35A32373C7B4A0F912E8824672A6FABAC01C62178FAF48BF6E04]} 04-12 07:41:59.609 26113:26193 I/[WEATHER: {[0FDE58F2E1A3F1959748F125626307701143D32C4154EF86197F109530082CDA]} 04-12 07:41:59.675 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:59.675 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:41:59.817 14785:14852 I/Finsky: [142] lob.run(53): AIM: AppInfoManager-Perf > Destroying AppInfoManager ... 04-12 07:41:59.824 26113:26204 I/WM-WorkerWrapper: Worker result SUCCESS for Work [ id=47b1a24d-3524-4835-a9bd-6ffa435902e9, tags={ com.samsung.android.weather.interworking.rubin.worker.RubinInitWorker } ] 04-12 07:41:59.834 1509: 4520 I/ActivityManager: Changes in 10195 8 to 10, 8 to 0 04-12 07:41:59.837 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10195[I] 04-12 07:41:59.837 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10195[I] 04-12 07:41:59.837 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10096[I] 04-12 07:41:59.837 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10096[I] 04-12 07:41:59.838 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:59.839 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:41:59.840 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10195[I] 04-12 07:41:59.840 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10195[I] 04-12 07:41:59.841 1509: 2149 I/ActivityManager: Killing 24746:com.samsung.android.app.routines/u0a60 (adj 999): empty #21 04-12 07:41:59.844 1509: 2149 I/ActivityManager: Killing 24881:com.sec.android.app.clockpackage/u0a290 (adj 999): empty #22 04-12 07:41:59.847 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10096[I] 04-12 07:41:59.847 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10096[I] 04-12 07:41:59.850 1509: 1549 I/libprocessgroup: Successfully killed process cgroup uid 10060 pid 24746 in 5ms 04-12 07:41:59.877 865: 865 I/Zygote: Process 24881 exited due to signal 9 (Killed) 04-12 07:41:59.878 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10290[I] 04-12 07:41:59.879 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10290[I] 04-12 07:41:59.880 1509: 1509 I/WALLPAPER_SVC:SemWallpaperManagerService: isHomeActivityVisible : true 04-12 07:41:59.880 1509: 1509 D/WALLPAPER_SVC:WallpaperManagerService: dispatchHomeVisibilityChanged: visible = true, connection = com.android.server.wallpaper.WallpaperManagerService$WallpaperConnection@bb1d85e, systemWallpaper = WallpaperData@e962583, id: 3, which: 5, file mod: 0, info: null, engine(s): Proxy@ac7a80d, type = 0, userId = 0, uri= null, allowBackup= true, wallpaperComponent = ComponentInfo{com.android.systemui/com.android.systemui.wallpapers.ImageWallpaper}, nextWallpaperComponent = ComponentInfo{com.android.systemui/com.android.systemui.wallpapers.ImageWallpaper} 04-12 07:41:59.881 865: 865 I/Zygote: Process 24746 exited due to signal 9 (Killed) 04-12 07:41:59.883 1509: 1539 D/DisplayManagerService: Drop pending events for gone uid 10290 04-12 07:41:59.884 1509: 1549 I/libprocessgroup: Successfully killed process cgroup uid 10290 pid 24881 in 0ms 04-12 07:41:59.964 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43288, isSameBssidAndFreq true 04-12 07:41:59.966 1943: 1943 D/StatusBarIconController: ignoring old pipeline callback because the new wifi icon is enabled 04-12 07:41:59.966 1943: 2242 D/Tile.WifiTile: handleUpdateState isTransient=false transientEnabling =false cb.isTransient=false state.state = 2 mStateBeforeClick.value =false enabled =true 04-12 07:41:59.968 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:41:59.969 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:41:59.979 1943: 2246 I/gralloc4: @set_metadata: update dataspace from GM (0x00000000 -> 0x08010000) 04-12 07:41:59.980 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:41:59.980 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 90 04-12 07:41:59.991 948: 948 I/BufferQueueProducer: [StatusBar$_1943#88](this:0xb40000776697bba0,id:-1,api:0,p:-1,c:948) queueBuffer: fps=0.49 dur=6164.13 max=5952.88 min=77.57 04-12 07:41:59.991 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:41:59.992 948: 948 D/SurfaceFlinger: GPIS:: requestGPISForClientComposition 04-12 07:41:59.995 879: 879 I/hwcomposer: [HWCDisplay] [Display_0 (type:1)] fps:0.745490,dur:4024.20,max:3950.13,min:5.59 04-12 07:41:59.995 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:41:59.995 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:00.006 1943: 2599 I/DateTimeView: updateAll - getTimeFormat 04-12 07:42:00.006 1509: 1509 I/EyeComfortSolutionService: action : android.intent.action.TIME_TICK 04-12 07:42:00.007 1943: 2599 D/QSClockBellTower: onReceive(android.intent.action.TIME_TICK) mTimeZoneString:Europe/Paris 04-12 07:42:00.010 1943: 1943 D/FaceWidgetPagesController: onTimeChanged() 04-12 07:42:00.016 1943: 1943 D/QSClockBellTower: He is ready to ring the bell. (((QSClockBellSound - TimeText:07:42, TimeContentDescription:07:42, DateText:sam. 12 avril, ShortDateText:sam. 12 avr., Demo:false, QuickStar-Second(false|12:34:56), QuickStar-DateText:sam. 12 avr.))) 04-12 07:42:00.017 1943: 1943 D/QSClock: StatusBar clock=07:42 notifyTimeChanged(QSClockBellSound - TimeText:07:42, TimeContentDescription:07:42, DateText:sam. 12 avril, ShortDateText:sam. 12 avr., Demo:false, QuickStar-Second(false|12:34:56), QuickStar-DateText:sam. 12 avr.) clockVisibleByPolicy=true, clockVisibleByUser=true, visible=true, parent=android.widget.LinearLayout{62c63fd V.E...... ......ID 0,0-98,72 #7f0a0591 app:id/left_clock_container} 04-12 07:42:00.017 1943: 1943 D/QSClockBellTower: Everyone heard the bell. run(currentTime:1744436520015, getTime():Sat Apr 12 07:42:00 GMT+02:00 2025, getTimeZone():libcore.util.ZoneInfo[mDstSavings=3600000,mUseDst=true,mDelegate=[id="Europe/Paris",mRawOffset=3600000,mEarliestRawOffset=561000,transitions=308]]) 04-12 07:42:00.033 1943: 1943 D/QsExpandAnimator: mIsDateButtonOverlapped = false >> false, (389.0 + 375) = 764.0 : 984 04-12 07:42:00.036 1943: 1943 W/View: requestLayout() improperly called by android.widget.FrameLayout{1c34cde V.E...... ......ID 0,142-1080,2205 #7f0a0846 app:id/qs_frame} during layout: running second layout pass 04-12 07:42:00.044 1943: 2246 I/gralloc4: @set_metadata: update dataspace from GM (0x00000000 -> 0x08010000) 04-12 07:42:00.067 1300: 1300 D/connsyslogger: Open FIFO for close 04-12 07:42:00.111 879: 1114 I/hwcomposer: HWC] (0)fire a callback of refresh to SF[4: 04-12 07:42:00.120 902: 926 I/mtkpower@impl: [setMode] type:6, enabled:1 04-12 07:42:00.121 902: 926 E/mtkpower@impl: [setMode] unknown type 04-12 07:42:00.124 948: 948 I/BufferQueueProducer: [FramebufferSurface](this:0xb4000077668856d0,id:-1,api:1,p:948,c:948) queueBuffer: fps=0.25 dur=4079.47 max=4079.47 min=4079.47 04-12 07:42:00.155 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:00.155 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:00.192 902: 926 I/mtkpower@impl: [setMode] type:6, enabled:0 04-12 07:42:00.192 902: 926 E/mtkpower@impl: [setMode] unknown type 04-12 07:42:00.210 880: 913 E/BatteryDump: !@new_battery_dump : 4332,-2,700,1500,100,357,354,420,0,0,383,420,0,Full,NO_CHARGING,None,Good,USB_CDP,2,Normal,0,0,5394,0x8000,0x10010000,0x0,0,0,0000,0000,00000000,0,0,0,0,10,4330,10000,981,0, 04-12 07:42:00.216 880: 880 I/android.hardware.health@2.1-service-samsung: updateLrpSysfs: write: 386 04-12 07:42:00.296 892:26280 I/HYPER-HAL: [RequestManager.cpp]releaseLocked(): Released ID : 1178906 04-12 07:42:00.317 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:00.318 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:00.444 958: 965 D/ccci_mdinit: (1):monitor_time_update_thread round:4612 ######## 04-12 07:42:00.477 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:00.478 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:00.480 1509: 1797 D/UsbStatsMonitor: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 04-12 07:42:00.490 1509: 1524 I/system_server: Background concurrent mark compact GC freed 21MB AllocSpace bytes, 570(11MB) LOS objects, 16% free, 125MB/149MB, paused 2.015ms,9.064ms total 579.470ms 04-12 07:42:00.637 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:00.637 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:00.795 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:00.795 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:00.919 1509: 1573 D/PowerManagerService: UserActivityStateListenerState: 0 04-12 07:42:00.956 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:00.956 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:00.963 593: 593 D/io_stats: !@ 8,32 r 32554766 675603200 w 9622022 304894168 d 585353 337986308 f 0 774256 iot 20024120 0 th 0 0 0 pt 0 inp 0 0 138455.603 04-12 07:42:00.965 593: 593 D/io_stats: !@ Read_top(KB): droid.rubin.app(26260) 31348 ng.android.lool(26325) 11640 rivacydashboard(26324) 5020 04-12 07:42:00.965 593: 593 D/io_stats: !@ Write_top(KB): -(0) 8156 system_server(1509) 3940 kworker/u16:5(17334) 1136 04-12 07:42:01.003 2420:21743 I/HoneySpace.LiveIconSupplier: time tick - 66, CLOCK, 07:42 - 07:41, 200285657 04-12 07:42:01.009 2420:21743 I/LauncherActivityInfo: Trying to load live icon for com.sec.android.app.clockpackage 04-12 07:42:01.048 2420:21743 I/LiveIconUtil: getLiveIcon was called in ClockPackage 04-12 07:42:01.049 2420:21743 I/LiveIconUtil: getLiveIcon res = com.sec.android.app.clockpackage 04-12 07:42:01.057 2420:21743 I/LiveIconUtil: stdIconSize : 135 , targetIconSize : 163 04-12 07:42:01.057 2420:21743 I/LiveIconUtil: iconDpi : 640 , mTargetIconDpi : 450 04-12 07:42:01.113 2420:21743 I/AppIconSolution: load= live icon for com.sec.android.app.clockpackage, from overlay = false 04-12 07:42:01.115 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:01.115 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:01.117 2420:21743 I/LauncherActivityInfo: packageName: com.sec.android.app.clockpackage, useThemeIcon: false, height: 288, width: 288, density: 640 04-12 07:42:01.120 2420:21743 I/HoneySpace.LiveIconSupplier: updateIcon - 66, CLOCK, true - 07:42, 70342397 04-12 07:42:01.121 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:01.123 1509: 2752 D/CompatibilityChangeReporter: Compat change id reported: 261072174; UID 10220; state: ENABLED 04-12 07:42:01.125 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:01.134 1509: 2752 I/ActivityManager: Killing 24847:com.samsung.android.app.routines:RoutineUIProcess/u0a60 (adj 999): empty #21 04-12 07:42:01.136 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:01.136 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 90 04-12 07:42:01.143 1509: 1549 I/libprocessgroup: Successfully killed process cgroup uid 10060 pid 24847 in 5ms 04-12 07:42:01.144 2420: 3560 I/gralloc4: @set_metadata: update dataspace from GM (0x00000000 -> 0x08010000) 04-12 07:42:01.147 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:01.147 948: 948 I/BufferQueueProducer: [com.sec.android.app.launcher/com.sec.android.app.launcher.activities.LauncherActivity$_2420#125949](this:0xb40000772ed98ba0,id:-1,api:0,p:-1,c:948) queueBuffer: fps=0.15 dur=6532.79 max=6532.79 min=6532.79 04-12 07:42:01.148 948: 948 D/SurfaceFlinger: GPIS:: requestGPISForClientComposition 04-12 07:42:01.150 879: 879 I/hwcomposer: [HWCDisplay] [Display_0 (type:1)] fps:2.596174,dur:1155.55,max:1026.32,min:58.09 04-12 07:42:01.172 865: 865 I/Zygote: Process 24847 exited due to signal 9 (Killed) 04-12 07:42:01.193 1509: 4523 D/CompatibilityChangeReporter: Compat change id reported: 261072174; UID 10219; state: ENABLED 04-12 07:42:01.268 879: 1114 I/hwcomposer: HWC] (0)fire a callback of refresh to SF[4: 04-12 07:42:01.276 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:01.276 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:01.282 948: 948 I/BufferQueueProducer: [FramebufferSurface](this:0xb4000077668856d0,id:-1,api:1,p:948,c:948) queueBuffer: fps=0.86 dur=1158.96 max=1158.96 min=1158.96 04-12 07:42:01.436 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:01.437 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:01.506 26156:26233 I/RcsAvailabilityCache: Cached availability not found for simId: redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:01.519 2784: 2784 D/BoundBrokerSvc: onRebind: Intent { act=com.google.android.gms.time.trustedtime.service.START dat=chimera-action:/... cmp=com.google.android.gms/.chimera.PersistentApiService } 04-12 07:42:01.552 26156:26389 V/ClearcutMetricXmitter: Transmission is done. 04-12 07:42:01.554 26156:26389 V/ClearcutMetricXmitter: Transmission is done. 04-12 07:42:01.567 2784: 2784 D/BoundBrokerSvc: onBind: Intent { act=com.google.android.gms.time.trustedtime.singleuserapi.service.START dat=chimera-action:/... cmp=com.google.android.gms/.chimera.PersistentSingleUserInternalApiService } 04-12 07:42:01.567 2784: 2784 D/BoundBrokerSvc: Loading bound service for intent: Intent { act=com.google.android.gms.time.trustedtime.singleuserapi.service.START dat=chimera-action:/... cmp=com.google.android.gms/.chimera.PersistentSingleUserInternalApiService } 04-12 07:42:01.596 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:01.597 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:01.685 1509: 4523 D/SGM:GameManager: identifyForegroundApp. com.sec.android.app.launcher, mCurrentUserId: 0, callerUserId: 0 04-12 07:42:01.685 1509: 4523 D/SGM:PkgDataHelper: getGamePkgData(). com.sec.android.app.launcher 04-12 07:42:01.686 16077:16166 I/PolicyManager: [#CMH#] Is foreground game app: false 04-12 07:42:01.756 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:01.756 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:01.763 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:01.857 1509: 1858 D/WifiConnectivityMonitor: Stop WCM Poll. cnt : 5 04-12 07:42:01.858 1509: 1858 I/WifiConnectivityMonitor: LinkQualityMonitorCallback was not registered yet 04-12 07:42:01.916 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:01.917 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:02.076 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:02.077 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:02.218 1188: 1188 D/AALLightSensor: oldLux=2 [SA:2 LA:2] newLux=2 (oriLux: 2) 04-12 07:42:02.236 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:02.236 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:02.397 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:02.397 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:02.556 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:02.557 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:02.717 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:02.718 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:02.877 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:02.877 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:02.967 593: 593 D/io_stats: !@ 8,32 r 32554918 675606112 w 9622062 304910844 d 585353 337986308 f 0 774256 iot 20024384 0 th 0 0 0 pt 0 inp 0 0 138457.607 04-12 07:42:02.988 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43289, isSameBssidAndFreq true 04-12 07:42:03.035 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:03.036 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:03.044 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:03.196 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:03.196 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:03.356 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:03.357 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:03.517 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:03.517 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:03.631 25395:25395 D/CompatibilityChangeReporter: Compat change id reported: 150939131; UID 10300; state: ENABLED 04-12 07:42:03.676 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:03.676 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:03.750 2784:21768 I/NearbyPresence: (REDACTED) %s verified [==] new request %s equals to the old request 04-12 07:42:03.765 1509: 1860 D/WifiConnectivityMonitor.NetworkStatsAnalyzer: Backhaul result - RSSI:-43, CE:7, PE:8, TI:13, PTI:14, TW:11, PTW:11, Tx:4, Rx:10, TxS:4, RxS:6, RESULT:true, IC:0, ICT:5, WC:0, WCT:5, R:0, RC:0, IE:0, EC:0 04-12 07:42:03.793 3379: 3479 I/R0: limitCPUFreq:: freq = 2100000 04-12 07:42:03.794 3379: 3479 I/SemDvfsHyPerManager: acquire hyper - SIOP_ARM_MAX/3379@2, type = 301993986 04-12 07:42:03.796 892: 922 I/HYPER-HAL: RequestManager.cpp]acquire(): Acquired ID : 5717273 [3379 / 2] HINT : list : [CPUMaxFreq / 2100000: 04-12 07:42:03.837 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:03.838 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:03.999 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:04.000 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:04.014 3379: 3379 I/SDHMS:LOAD: type: LoadsFreqs, value: 0:0:0:1179499:2200000:0:979999:2000000:0:8:415:0 04-12 07:42:04.156 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:04.156 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:04.232 874: 6340 D/[BT: mtk_bt_op: BT_VND_OP_LPM_WAKE_SET_STATE 04-12 07:42:04.239 3228: 3476 I/AiAiAutofill: Disconnected AiAiAugmentedAutofillService. 04-12 07:42:04.316 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:04.316 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:04.318 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:04.479 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:04.479 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:04.560 1509: 1546 I/ActivityManager: Changes in 10093 5 to 15, 56 to 0 04-12 07:42:04.563 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10093[I] 04-12 07:42:04.565 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10093[I] 04-12 07:42:04.636 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:04.636 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:04.716 8850: 8850 D/BoundBrokerSvc: onUnbind: Intent { act=com.google.android.gms.feedback.internal.IFeedbackService dat=chimera-action:/... cmp=com.google.android.gms/.chimera.GmsBoundBrokerService } 04-12 07:42:04.796 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:04.797 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:04.960 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:04.961 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:04.974 593: 593 D/io_stats: !@ 8,32 r 32554954 675606516 w 9622173 304927740 d 585353 337986308 f 0 774266 iot 20024612 0 th 0 0 0 pt 0 inp 0 0 138459.614 04-12 07:42:04.977 593: 593 D/io_stats: !@ Read_top(KB): id.app.launcher(2420) 1784 .gms.persistent(2784) 1184 ogle.android.as(3228) 144 04-12 07:42:04.977 593: 593 D/io_stats: !@ Write_top(KB): kworker/u16:3(5382) 33072 -(0) 14112 f2fs_ckpt-254:5(669) 148 04-12 07:42:05.067 1300: 1300 D/connsyslogger: Open FIFO for close 04-12 07:42:05.120 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:05.121 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:05.276 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:05.276 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:05.436 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:05.436 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:05.600 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:05.600 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:05.606 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:05.757 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:05.757 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:05.828 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10254[I] 04-12 07:42:05.829 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10254[I] 04-12 07:42:05.829 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10254[I] 04-12 07:42:05.830 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10254[I] 04-12 07:42:05.830 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:05.836 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:05.847 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:05.847 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 90 04-12 07:42:05.858 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:05.869 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:05.877 10796:10802 W/ssioncontroller: ApkAssets: Deleting an ApkAssets object ' and /data/app/~~HBMZARgJMzUIf5lbwqqStg==/com.google.android.googlequicksearchbox-mhicODXXH09RFVldHJPnlQ==/base.apk' with 1 weak references 04-12 07:42:05.879 10796:10802 W/ssioncontroller: ApkAssets: Deleting an ApkAssets object ' and /data/app/~~HBMZARgJMzUIf5lbwqqStg==/com.google.android.googlequicksearchbox-mhicODXXH09RFVldHJPnlQ==/split_config.xxhdpi.apk' with 1 weak references 04-12 07:42:05.880 10796:10802 W/ssioncontroller: ApkAssets: Deleting an ApkAssets object ' and /data/app/~~HBMZARgJMzUIf5lbwqqStg==/com.google.android.googlequicksearchbox-mhicODXXH09RFVldHJPnlQ==/split_lens_ondevice_engine_play_ml_module.apk' with 1 weak references 04-12 07:42:05.881 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:05.892 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:05.916 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:05.916 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:06.014 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43290, isSameBssidAndFreq true 04-12 07:42:06.017 1943: 1943 D/StatusBarIconController: ignoring old pipeline callback because the new wifi icon is enabled 04-12 07:42:06.018 1943: 2242 D/Tile.WifiTile: handleUpdateState isTransient=false transientEnabling =false cb.isTransient=false state.state = 2 mStateBeforeClick.value =false enabled =true 04-12 07:42:06.042 1943: 2246 I/gralloc4: @set_metadata: update dataspace from GM (0x00000000 -> 0x08010000) 04-12 07:42:06.048 948: 948 I/BufferQueueProducer: [StatusBar$_1943#88](this:0xb40000776697bba0,id:-1,api:0,p:-1,c:948) queueBuffer: fps=0.33 dur=6056.89 max=5995.75 min=61.14 04-12 07:42:06.050 948: 948 D/SurfaceFlinger: GPIS:: requestGPISForClientComposition 04-12 07:42:06.055 879: 879 I/hwcomposer: [HWCDisplay] [Display_0 (type:1)] fps:0.407788,dur:4904.51,max:4771.71,min:132.81 04-12 07:42:06.076 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:06.077 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:06.116 879: 1114 I/hwcomposer: HWC] (0)fire a callback of refresh to SF[4: 04-12 07:42:06.134 948: 948 I/BufferQueueProducer: [FramebufferSurface](this:0xb4000077668856d0,id:-1,api:1,p:948,c:948) queueBuffer: fps=0.21 dur=4851.16 max=4851.16 min=4851.16 04-12 07:42:06.156 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 91 04-12 07:42:06.237 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:06.237 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:06.382 1188: 1188 D/AALLightSensor: oldLux=2 [SA:2 LA:2] newLux=2 (oriLux: 2) 04-12 07:42:06.398 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:06.398 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:06.428 1906: 1906 I/wpa_supplicant: Heartbeat 13833 04-12 07:42:06.557 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:06.558 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:06.716 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:06.717 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:06.743 1509: 1662 D/ActivityManager: Received BROADCAST intent 0xe195bc4 Key{broadcastIntent pkg=android intent=act=com.android.server.audio.action.CHECK_MUSIC_ACTIVE flags=0x4000000 u=0} requestCode=1 sent=0 from uid 1000 04-12 07:42:06.876 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:06.876 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:06.885 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:06.981 593: 593 D/io_stats: !@ 8,32 r 32554954 675606516 w 9622202 304955400 d 585353 337986308 f 0 774266 iot 20024868 0 th 0 0 0 pt 0 inp 0 6 138461.621 04-12 07:42:07.040 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:07.041 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:07.197 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:07.198 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:07.357 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:07.357 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:07.516 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:07.516 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:07.634 1509: 1546 I/ActivityManager: Killing 25209:com.google.android.webview:webview_service/u0a231 (adj 999): empty #21 04-12 07:42:07.643 1509: 1549 I/libprocessgroup: Successfully killed process cgroup uid 10231 pid 25209 in 6ms 04-12 07:42:07.679 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:07.679 865: 865 I/Zygote: Process 25209 exited due to signal 9 (Killed) 04-12 07:42:07.680 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:07.682 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10231[I] 04-12 07:42:07.683 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10231[I] 04-12 07:42:07.689 1509: 1539 D/DisplayManagerService: Drop pending events for gone uid 10231 04-12 07:42:07.835 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:07.836 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:07.996 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:07.996 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:08.156 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:08.156 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:08.166 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:08.316 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:08.318 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:08.477 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:08.477 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:08.630 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:08.636 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:08.636 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:08.637 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:08.647 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:08.648 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 90 04-12 07:42:08.658 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:08.670 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:08.681 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:08.692 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:08.795 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:08.796 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:08.948 3379: 4485 I/SDHMS:C: SIOP:: AP:411 BAT:357 USB:354 CHG:411 PA:410 WIFI:403 BLK:0 SUBBAT:0 SKIN:381 SKINF:375 SKINB:381 LRP:381 LRP2:381 LRF2:375 LRB2:381 AP2:381 CHG2:365 MEM2:381 WIFI2:381 SPK2:345 VAP05:426 04-12 07:42:08.957 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:08.957 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:08.984 593: 593 D/io_stats: !@ 8,32 r 32554980 675606956 w 9622347 304977580 d 585353 337986308 f 0 774281 iot 20025128 0 th 0 0 0 pt 0 inp 0 0 138463.624 04-12 07:42:08.985 593: 593 D/io_stats: !@ Read_top(KB): system_server(1509) 432 kworker/1:2H(24618) 4 f2fs_ckpt-254:5(669) 4 04-12 07:42:08.985 593: 593 D/io_stats: !@ Write_top(KB): kworker/u16:4(19605) 32784 -(0) 24292 kworker/u16:3(5382) 16384 04-12 07:42:09.026 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43291, isSameBssidAndFreq true 04-12 07:42:09.029 1943: 1943 D/StatusBarIconController: ignoring old pipeline callback because the new wifi icon is enabled 04-12 07:42:09.030 1943: 2242 D/Tile.WifiTile: handleUpdateState isTransient=false transientEnabling =false cb.isTransient=false state.state = 2 mStateBeforeClick.value =false enabled =true 04-12 07:42:09.045 1943: 2246 I/gralloc4: @set_metadata: update dataspace from GM (0x00000000 -> 0x08010000) 04-12 07:42:09.048 948: 948 I/BufferQueueProducer: [StatusBar$_1943#88](this:0xb40000776697bba0,id:-1,api:0,p:-1,c:948) queueBuffer: fps=0.33 dur=2999.49 max=2999.49 min=2999.49 04-12 07:42:09.049 948: 948 D/SurfaceFlinger: GPIS:: requestGPISForClientComposition 04-12 07:42:09.053 879: 879 I/hwcomposer: [HWCDisplay] [Display_0 (type:1)] fps:0.667141,dur:2997.87,max:2918.21,min:79.66 04-12 07:42:09.063 641:25802 I/keystore2: system/security/keystore2/src/watchdog.rs:319 - Watchdog thread idle -> terminating. Have a great day. 04-12 07:42:09.080 1509: 1818 I/ChimeraAggressivePolicyHandler: executePolicy() - triggerSource: TRIGGER_SOURCE_LMKD 04-12 07:42:09.082 1509: 1818 I/ChimeraAggressivePolicyHandler: available memory: 1149000, free memory target: 696320, quit chimera 04-12 07:42:09.112 879: 1114 I/hwcomposer: HWC] (0)fire a callback of refresh to SF[4: 04-12 07:42:09.116 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:09.116 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:09.123 948: 948 I/BufferQueueProducer: [FramebufferSurface](this:0xb4000077668856d0,id:-1,api:1,p:948,c:948) queueBuffer: fps=0.33 dur=2988.98 max=2988.98 min=2988.98 04-12 07:42:09.141 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 89 04-12 07:42:09.164 1509: 4523 W/ProcessStats: Tracking association SourceState{422a4e8 com.google.android.gms.persistent/10220 BTop #1188547} whose proc state 2 is better than process ProcessState{500fd93 com.google.android.gms/10220 pkg=com.google.android.gms} proc state 14 (388 skipped) 04-12 07:42:09.187 8850: 8850 D/BoundBrokerSvc: onUnbind: Intent { act=com.google.android.gms.pay.service.BIND dat=chimera-action:/... cmp=com.google.android.gms/.chimera.GmsApiService } 04-12 07:42:09.195 1509: 4523 I/ActivityManager: Changes in 99934 3 to 8, 56 to 0 04-12 07:42:09.276 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:09.276 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:09.436 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:09.438 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:09.444 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:09.514 26156:26228 I/Bugle: BugleStartup: Registering SIM change receiver... 04-12 07:42:09.517 26156:26228 I/Bugle: BugleStartup: Updating app config... 04-12 07:42:09.520 1509: 3361 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.shared.receiver.SmsReceiver newState = 2 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.522 1509: 3361 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.shared.receiver.TelephonyChangeReceiver newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.523 1509: 3361 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.524 1509: 3361 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.526 1509: 3361 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.shared.receiver.DefaultSmsPackageChangedReceiver newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.527 1509: 3361 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.528 1509: 3361 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.529 1509: 3361 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.shared.receiver.RestoreReceiver newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.530 1509: 3361 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.530 1509: 3361 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.533 1509: 3361 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.shared.receiver.SmsRejectedReceiver newState = 2 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.536 1509: 3361 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.ui.conversationlist.VideoShareIntentActivity newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.537 1509: 3361 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.538 1509: 3361 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.540 26156:26228 I/Bugle: BugleStartup: Done with SIM change receiver & app config. 04-12 07:42:09.541 26156:26228 I/Bugle: BugleStartup: Handling shared prefs upgrade & Load MMS Configuration... 04-12 07:42:09.562 26156:26242 I/BugleRcsEngine: Unexpected action: android.intent.action.SIM_STATE_CHANGED [CONTEXT log_prefix="(Sim)" thread_id=155 ] 04-12 07:42:09.567 1509: 4523 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.shared.simstatetracker.AsyncTelephonySimStateReceiver newState = 2 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.571 26156:26395 I/BugleRcsEngine: do not delay first event [CONTEXT thread_id=160 ] 04-12 07:42:09.572 26156:26228 I/BugleDataModel: Scheduling country code detector action, because a subscription changed its state. 04-12 07:42:09.578 26156:26227 I/Bugle: BugleStartup: Initializing RCS availability... 04-12 07:42:09.579 26156:26395 I/BugleRcsEngine: Processing an intent [CONTEXT log_prefix="(Sim)" thread_id=160 ] 04-12 07:42:09.580 26156:26237 I/BugleSimStateTracker: Updating PhoneSimState 04-12 07:42:09.580 26156:26239 I/AsyncTelephonySimStateR: Received intent action: android.intent.action.SIM_STATE_CHANGED with extra SIM_STATE: ABSENT 04-12 07:42:09.581 26156:26227 I/Bugle: BugleStartup: Done with RCS availability. 04-12 07:42:09.581 26156:26239 I/AsyncTelephonySimStateR: Start sim removal verification due to ABSENT. 04-12 07:42:09.582 26156:26227 I/Bugle: BugleStartup: Done initializing with enabled individual init failures. 04-12 07:42:09.583 26156:26239 I/SimStateSchedulerImpl: Scheduling WORK_TYPE_VERIFY_SIM_REMOVAL using PWQ. Delay Seconds: 90, UpdateTrigger: 7 04-12 07:42:09.595 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:09.595 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:09.605 26156:26220 D/CompatibilityChangeReporter: Compat change id reported: 289878283; UID 10219; state: ENABLED 04-12 07:42:09.607 26156:26395 I/BugleRcsEngine: SIM state LOADED [CONTEXT log_prefix="(Sim)" thread_id=160 ] 04-12 07:42:09.609 26156:26220 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_CountryCodeDetectorAction 04-12 07:42:09.610 26156:26237 I/BugleSimStateTracker: Update trigger: 1 04-12 07:42:09.610 26156:26224 I/BugleDataModel: ExecuteActionRunnable: running action CountryCodeDetectorAction 04-12 07:42:09.617 26156:26228 I/BugleDataModel: Scheduling self participants refresh action, because a subscription changed its state. 04-12 07:42:09.622 26156:26224 I/BugleDataModel: ActionExecutorImpl: ACTION_BACKGROUND_QUEUED_CountryCodeDetectorAction 04-12 07:42:09.627 26156:26226 I/Bugle: CountryCodeDetector: updateSmsNetworkCountry from default subscription network country. detected country: fr 04-12 07:42:09.630 26156:26226 I/BugleDataModel: ActionExecutorImpl: ACTION_RESPONSE_QUEUED_CountryCodeDetectorAction 04-12 07:42:09.639 26156:26395 I/BugleRcsEngine: SIM changed: false. current id: redacted-pii:sim_id[chars:20,last3:690]; stored id: redacted-pii:sim_id[chars:20,last3:690]; isFiDevice: false; subId: 2; slotIndex: 0 [CONTEXT log_prefix="(Sim)" thread_id=160 ] 04-12 07:42:09.641 26156:26237 I/BugleSimStateTracker: Looking up Fi through package names. 04-12 07:42:09.643 1509: 4520 I/ActivityManager: Changes in 99934 8 to 8, 0 to 8 04-12 07:42:09.646 26156:26178 I/.apps.messaging: Background concurrent mark compact GC freed 8850KB AllocSpace bytes, 32(1144KB) LOS objects, 49% free, 7689KB/15MB, paused 3.446ms,8.747ms total 144.177ms 04-12 07:42:09.655 26156:26237 I/BugleSimStateTracker: default call SIM: redacted-pii:sim_id[chars:20,last3:690], default sms SIM redacted-pii:sim_id[chars:20,last3:690]. default data SIM redacted-pii:sim_id[chars:20,last3:690]. 04-12 07:42:09.666 26156:26227 W/Bugle: BuglePhoneNumberUtils: canonicalizeMccMnc: invalid mccmnc. mcc: null, mnc: null 04-12 07:42:09.669 26156:26239 I/Bugle: BroadcastReceiverAsyncWorkTracker: Acknowledging broadcast of com.google.android.apps.messaging.shared.simstatetracker.AsyncTelephonySimStateReceiver@1bb9e56 04-12 07:42:09.680 26156:26237 I/BugleSimStateTracker: Looking up Fi through package names. 04-12 07:42:09.696 26156:26237 I/Bugle: CountryCodeDetector: updateSmsNetworkCountry from default subscription network country. detected country: fr 04-12 07:42:09.712 26156:26397 I/Phlogger: Shared storage file not found for com.google.android.libraries.consentverifier#com.google.android.apps.messaging 04-12 07:42:09.716 26156:26237 I/BugleSimStateTracker: allNewlyBuiltSimSubscriptionInfos (simId, loggableGuid): [(redacted-pii:sim_id[chars:20,last3:690], 1c3d8d11-f6ca-40fe-bd38-c2b266ec2198)] 04-12 07:42:09.718 26156:26239 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:09.718 26156:26239 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:09.718 26156:26239 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:09.718 26156:26239 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:09.718 26156:26237 I/BugleSimStateTracker: Storing updatedSimSubscriptionInfos: [(redacted-pii:sim_id[chars:20,last3:690], 1c3d8d11-f6ca-40fe-bd38-c2b266ec2198)] 04-12 07:42:09.722 26156:26237 I/BugleSimStateTracker: Handling SIM loaded event for all SIMs on first update: [(redacted-pii[20-chars], 1c3d8d11-f6ca-40fe-bd38-c2b266ec2198)] 04-12 07:42:09.729 26156:26395 I/BugleRcsEngine: Skipping writing subId because this is main bugle process. [CONTEXT log_prefix="(Sim)" thread_id=160 ] 04-12 07:42:09.736 26156:26395 I/BugleRcsEngine: Updated SIM info: currentSimId: redacted-pii:sim_id[chars:20,last3:690]; imsi: redacted-pii:imsi[chars:15]; rawMsisdn: redacted-pii:phone_number[chars:12,last2:50]; formattedMsisdn: redacted-pii:phone_number[chars:12,last2:50]; mccmnc: redacted-pii:sim_operator[chars:5]; gid1: redacted-pii:sim_gid[chars:8]; isFiDevice: false; subId: 2; slotIndex: 0 [CONTEXT log_prefix="(Sim)" thread_id=160 ] 04-12 07:42:09.744 26156:26395 I/BugleRcsEngine: Handling SIM_LOADED in PhoneSimsStateUpdater. [CONTEXT log_prefix="(Sim)" thread_id=160 ] 04-12 07:42:09.746 26156:26398 I/BugleJobs: Starts to observe table change. 04-12 07:42:09.752 26156:26407 I/GnpSdk: set is []. 04-12 07:42:09.755 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:09.756 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:09.757 26156:26397 I/BugleDataModel: SubscriptionsTracker#refreshSelfParticipantList([2]) 04-12 07:42:09.763 1509: 4523 D/CompatibilityChangeReporter: Compat change id reported: 161252188; UID 10220; state: DISABLED 04-12 07:42:09.766 1509: 4523 I/ActivityManager: Changes in 99934 8 to 8, 8 to 0 04-12 07:42:09.771 8850: 8850 D/BoundBrokerSvc: onBind: Intent { act=com.google.android.gms.notifications.capping.api.NotificationsCappingApiService.START dat=chimera-action:/... cmp=com.google.android.gms/.chimera.GmsApiService } 04-12 07:42:09.771 8850: 8850 D/BoundBrokerSvc: Loading bound service for intent: Intent { act=com.google.android.gms.notifications.capping.api.NotificationsCappingApiService.START dat=chimera-action:/... cmp=com.google.android.gms/.chimera.GmsApiService } 04-12 07:42:09.781 26156:26403 I/Forking: Starting analysis. 04-12 07:42:09.781 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:09.782 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:09.782 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:09.782 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:09.785 26156:26403 I/Misthreading: Starting analysis. 04-12 07:42:09.810 26156:26407 D/CompatibilityChangeReporter: Compat change id reported: 183155436; UID 10219; state: ENABLED 04-12 07:42:09.815 26156:26407 I/FirebaseApp: Device unlocked: initializing all Firebase APIs for app [DEFAULT] 04-12 07:42:09.823 2784:11034 W/BpBinder: Large outgoing transaction of 374844 bytes, interface descriptor , code 4 04-12 07:42:09.826 26156:26398 I/BugleNetwork: FirebaseRegistrationStartupTask: Enabling Firebase component 04-12 07:42:09.828 1509: 2752 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.shared.fcm.impl.BugleFirebaseMessagingService newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.828 1509: 2752 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.829 1509: 2752 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.837 26156:26397 I/BugleSelfIdentity: Phone number for MyIdentity bd01e789-1a72-4be8-a370-f213881833a1 does not change [CONTEXT sub_id=2 icc_id="89330124364015206690" messaging_identity="redacted-pii[12-chars]" rcs_provisioning_id="redacted-pii[0-chars]" ] 04-12 07:42:09.851 26156:26226 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:09.851 26156:26226 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:09.852 26156:26226 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:09.852 26156:26226 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:09.854 1509: 2752 I/ActivityManager: Changes in 99934 8 to 8, 0 to 8 04-12 07:42:09.866 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:09.867 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:09.867 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:09.867 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:09.872 26156:26228 I/BugleRcsProvisioning: BugleSystemBindingManager: onBuglePhenotypeFlagChanged 04-12 07:42:09.875 1509: 2752 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.ims.binding.SystemBindingService newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.875 26156:26228 I/BugleTransport: Not kicking off update transport registration because RCS provisioning change has not been received. 04-12 07:42:09.875 1509: 2752 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.876 26156:26227 I/BugleRcsEngine: getConfigServerUrl without simId [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=142 ] 04-12 07:42:09.876 26156:26398 D/nativeloader: Load /data/app/~~3e47DpGzmVZ9Y9f2pdWAaQ==/com.google.android.apps.messaging-9I7ADIApl9q8Ha_LLf4-Yw==/split_config.arm64_v8a.apk!/lib/arm64-v8a/libscytale_v2_jni.so using ns clns-5 from class loader (caller=/data/app/~~3e47DpGzmVZ9Y9f2pdWAaQ==/com.google.android.apps.messaging-9I7ADIApl9q8Ha_LLf4-Yw==/base.apk!classes3.dex): ok 04-12 07:42:09.876 1509: 2752 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.885 26156:26233 I/BugleRcsEngine: SystemBinding enabled: true [CONTEXT log_prefix="SystemBindingManager" thread_id=147 ] 04-12 07:42:09.887 26156:26397 I/BugleDataModel: SubscriptionsTracker bindToTrackingMap bound participants: [ParticipantId=1 subId=-1, ParticipantId=2 subId=1, ParticipantId=3 subId=2, ParticipantId=8 subId=3] 04-12 07:42:09.887 26156:26233 I/BugleRcsEngine: System Binding updated [CONTEXT thread_id=147 ] 04-12 07:42:09.889 26156:26397 I/BugleDataModel: set orderedRowIdAndTokenPairs: [rowId=3 subId= 2 token=bd01e789-1a72-4be8-a370-f213881833a1, rowId=1 subId= -1 token=56724516-5b1e-47fd-aefd-28ae6ddb4679, rowId=8 subId= 3 token=9e5f0bdd-5dc6-40d0-8d48-e33bf37660d1, rowId=2 subId= 1 token=45ff5ed2-5948-45fb-a712-9f1371f77d95] 04-12 07:42:09.890 26156:26220 I/BugleRcsEngine: getConfigServerUrl without simId [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=135 ] 04-12 07:42:09.890 26156:26227 I/BugleRcsEngine: Using config server URL from djwg [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=142 ] 04-12 07:42:09.895 1509: 2752 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.apps.messaging.auto.MessagingTemplateScreenServiceModule newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:09.895 1509: 2752 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.896 1509: 2752 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:09.909 26156:26220 I/BugleRcsEngine: Using config server URL from djwg [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=135 ] 04-12 07:42:09.914 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:09.915 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:09.922 26156:26398 W/BugleRcs: getAvailableProvisioningIds: accessing uninitialized provisioning identities. [CONTEXT ratelimit_period="1 MINUTES" ] epeg: FULL at dlcd.t(PG:60) at dlkf.q(PG:15) at cnet.q(PG:3) at csoa.a(PG:28) at csnz.a(PG:23) at csnp.e(PG:15) at cahs.g(PG:21) at cahq.run(PG:27) at emsa.run(PG:21) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:487) at etfq.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:09.922 26156:26397 I/BugleConnectivity: Connection state change: SIM loaded, data connection: UNKNOWN, manual connection eligibility: false, ntn roaming: false 04-12 07:42:09.923 26156:26398 I/RcsProvisioningManager: Calculating availability 04-12 07:42:09.924 26156:26397 I/BugleSatellite: Attempting to register registerForCarrierRoamingNtnModeChanged listener 04-12 07:42:09.925 26156:26398 I/RcsProvisioningManager: Computing availability for all sims. 04-12 07:42:09.926 26156:26398 I/RcsProvisioningManager: qualifiedProvisioningEngineAdapter is present: true 04-12 07:42:09.928 26156:26398 I/RcsAvailabilityCache: Cached availability not found for simId: redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:09.930 26156:26398 I/RcsAvailabilityCache: Cached availability not found for simId: redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:09.935 26156:26403 I/Bugle: RcsAvailabilityUtilForProvisioningEngineV2: updateAvailabilityForAllSimsAsync, hint: NO_HINT 04-12 07:42:09.936 26156:26403 I/BugleRcsProvisioning: updateAvailabilityForAllSimsAsync: scheduling updateAvailabilityForRcsProvisioningId call. Hint: NO_HINT, enableWelcomePopupWithoutGoogleTos: false, reshowSuccessPopup: false 04-12 07:42:09.953 26156:26224 I/BugleRcsProvisioning: updateRcsAvailabilityForMultipleSims: hint: NO_HINT, canReshowWelcomeMessage: false 04-12 07:42:09.955 26156:26224 I/RcsAvailabilityCache: Cached availability not found for simId: redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:09.963 26156:26228 I/BugleSatellite: Processing Phenotype flag changes. 04-12 07:42:09.969 26156:26227 I/BugleSatellite: Reporting to Telephony: SMS supported = true 04-12 07:42:09.973 26156:26397 I/BugleRcsEngine: getConfigServerUrl without simId [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=163 ] 04-12 07:42:09.976 1509: 4523 D/SecContentProvider2: query(), uri = 18 selection = isRCSEnabled 04-12 07:42:09.976 1509: 4523 I/PhoneRestrictionPolicy: isRCSEnabledInternal(), showMsg: false, columnName: enableRCS 04-12 07:42:09.977 1509: 4523 E/PhoneRestrictionPolicy: getEmergencyCall >>false 04-12 07:42:09.978 1509: 4523 I/PhoneRestrictionPolicy: isRCSEnabledInternal(), showMsg: false, columnName: enableRCSForSimSlot1 04-12 07:42:09.978 1509: 4523 E/PhoneRestrictionPolicy: getEmergencyCall >>false 04-12 07:42:09.986 1509: 4523 D/SecContentProvider2: query(), uri = 18 selection = isRCSEnabled 04-12 07:42:09.986 1509: 4523 I/PhoneRestrictionPolicy: isRCSEnabledInternal(), showMsg: false, columnName: enableRCS 04-12 07:42:09.987 1509: 4523 E/PhoneRestrictionPolicy: getEmergencyCall >>false 04-12 07:42:09.987 1509: 4523 I/PhoneRestrictionPolicy: isRCSEnabledInternal(), showMsg: false, columnName: enableRCSForSimSlot1 04-12 07:42:09.988 1509: 4523 E/PhoneRestrictionPolicy: getEmergencyCall >>false 04-12 07:42:09.990 26156:26397 I/BugleRcsEngine: Using config server URL from djwg [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=163 ] 04-12 07:42:09.991 26156:26240 I/BugleDataModel: 3 not running because already up to date, upgradeCommand: EXECUTE_UPGRADE, version: 2 04-12 07:42:10.004 26156:26403 I/BugleDataModel: 2 not running because already up to date, upgradeCommand: EXECUTE_UPGRADE, version: 2 04-12 07:42:10.014 864: 994 W/Netd: No subsystem found in netlink event 04-12 07:42:10.016 26156:26398 W/Bugle: MobileConfigurationRetriever: Cannot access SSOT for the same mobileConfigurationDataId that currrently being accessed by another thread epeg: FULL at chxw.f(PG:195) at chxw.c(PG:55) at cloj.v(PG:94) at cloj.i(PG:2) at cloj.k(PG:18) at cloq.w(PG:3) at dljr.apply(PG:15) at j$.util.Optional.map(SourceFile:17) at dlkf.B(PG:67) at dlkf.C(PG:203) at dlkf.q(PG:25) at cnet.q(PG:3) at csoa.a(PG:28) at csnz.a(PG:23) at csnp.e(PG:15) at cahs.g(PG:21) at cahq.run(PG:27) at emsa.run(PG:21) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:487) at etfq.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.018 2144: 2144 I/EPDG -- SIM0 [EpdgIntfCont: Not Mobile Interface. Ignoring Event 04-12 07:42:10.018 2144: 2144 I/EPDG -- SIM1 [EpdgIntfCont: Not Mobile Interface. Ignoring Event 04-12 07:42:10.018 2144: 2785 I/EPDG -- SIM0 [EpdgNetworkMgmtObserver: EpdgAddressUpdated: address: Suppressed iface: SuppressedmFqdnRetryCount : 0 04-12 07:42:10.019 26156:26195 D/CompatibilityChangeReporter: Compat change id reported: 150939131; UID 10219; state: ENABLED 04-12 07:42:10.021 2144: 2144 I/EPDG -- SIM0 [EpdgIntfCont: Not Mobile Interface. Ignoring Event 04-12 07:42:10.021 2144: 2144 I/EPDG -- SIM1 [EpdgIntfCont: Not Mobile Interface. Ignoring Event 04-12 07:42:10.021 2144: 2144 I/EPDG -- SIM1 [EpdgIntfCont: Not Mobile Interface. Ignoring Event 04-12 07:42:10.021 2144: 2144 I/EPDG -- SIM0 [EpdgIntfCont: Not Mobile Interface. Ignoring Event 04-12 07:42:10.021 2144: 2785 I/EPDG -- SIM0 [EpdgNetworkMgmtObserver: EpdgAddressUpdated: address: Suppressed iface: SuppressedmFqdnRetryCount : 0 04-12 07:42:10.021 2144: 2785 I/EPDG -- SIM0 [EpdgNetworkMgmtObserver: EpdgAddressUpdated: address: Suppressed iface: SuppressedmFqdnRetryCount : 0 04-12 07:42:10.037 26156:26214 I/Bugle: RcsAvailabilityUtilForProvisioningEngineV2: onCsLibPhenotypeUpdated 04-12 07:42:10.038 26156:26410 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.038 26156:26410 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.038 26156:26410 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.038 26156:26410 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.038 26156:26410 D/WM-GreedyScheduler: Starting work for ed6fa347-feb5-450c-8cfa-891ea539dd92 04-12 07:42:10.039 26156:26396 I/BugleRcsEngine: getConfigServerUrl without simId [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=161 ] 04-12 07:42:10.040 1509: 4523 D/PackageManager: setEnabledSetting : userId = 0 packageName = com.google.android.apps.messaging cmp = com.google.android.ims.binding.SystemBindingService newState = 1 callingPackage = com.google.android.apps.messaging 04-12 07:42:10.040 1509: 4523 D/ApplicationPolicy: getApplicationStateEnabled : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:10.041 1509: 4523 D/ApplicationPolicy: getApplicationComponentState : pkg = com.google.android.apps.messaging userId : 0 04-12 07:42:10.043 26156:26214 I/BugleRcsEngine: SystemBinding enabled: true [CONTEXT log_prefix="SystemBindingManager" thread_id=130 ] 04-12 07:42:10.046 26156:26410 I/BugleRcsEngine: getConfigServerUrl without simId [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=172 ] 04-12 07:42:10.055 26156:26239 I/MobileConfigurationApi: registerParameters successfully stored 4 parameters 04-12 07:42:10.057 26156:26239 I/SyncScheduler: scheduling sync for 0 seconds later, policy = KEEP 04-12 07:42:10.059 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.059 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.059 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.059 26156:26407 I/BugleRcsEngine: System Binding updated [CONTEXT thread_id=171 ] 04-12 07:42:10.059 26156:26227 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.068 1300: 1300 D/connsyslogger: Open FIFO for close 04-12 07:42:10.069 26156:26227 D/WM-Processor: ptq: processing WorkGenerationalId(workSpecId=ed6fa347-feb5-450c-8cfa-891ea539dd92, generation=0) 04-12 07:42:10.070 26156:26396 I/BugleRcsEngine: Using config server URL from djwg [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=161 ] 04-12 07:42:10.074 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:10.075 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:10.078 26156:26227 D/MddListenableWorkerFactory: createWorker for class: com.google.android.apps.messaging.shared.datamodel.workqueue.WorkQueueWorkerShim 04-12 07:42:10.084 26156:26156 D/WM-WorkerWrapper: Starting work for com.google.android.apps.messaging.shared.datamodel.workqueue.WorkQueueWorkerShim 04-12 07:42:10.109 26156:26177 W/.apps.messaging: Missing inline cache for int fadm.a(java.lang.Object) 04-12 07:42:10.136 26156:26224 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=139: 04-12 07:42:10.137 26156:26410 I/BugleRcsEngine: Using config server URL from djwg [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=172 ] 04-12 07:42:10.142 26156:26397 I/WM-WorkerWrapper: Worker result SUCCESS for Work [ id=ed6fa347-feb5-450c-8cfa-891ea539dd92, tags={ com.google.android.apps.messaging.shared.datamodel.workqueue.WorkQueueWorkerShim,data_upgrade- } ] 04-12 07:42:10.152 26156:26156 D/WM-Processor: ptq ed6fa347-feb5-450c-8cfa-891ea539dd92 executed; reschedule = false 04-12 07:42:10.154 26156:26178 I/.apps.messaging: Background concurrent mark compact GC freed 6496KB AllocSpace bytes, 26(964KB) LOS objects, 49% free, 9222KB/18MB, paused 9.560ms,9.246ms total 156.048ms 04-12 07:42:10.155 26156:26398 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=162: 04-12 07:42:10.165 26156:26398 I/BugleRcsProvisioning: RcsAvailability configuration availability and enabled status: simId: redacted-pii:sim_id[chars:20,last3:690], SipConnectionType: DUAL_REG, isConfigurationAvailableAndEnabled: true 04-12 07:42:10.165 26156:26224 I/BugleRcsProvisioning: RcsAvailability configuration availability and enabled status: simId: redacted-pii:sim_id[chars:20,last3:690], SipConnectionType: DUAL_REG, isConfigurationAvailableAndEnabled: true 04-12 07:42:10.165 26156:26397 D/WM-GreedyScheduler: Cancelling work ID ed6fa347-feb5-450c-8cfa-891ea539dd92 04-12 07:42:10.173 26156:26224 I/BugleRcsProvisioning: Checking isConfigServerUrlAvailable with simId: redacted-pii:sim_id[chars:20,last3:690], 04-12 07:42:10.175 26156:26224 I/BugleRcsEngine: getConfigServerUrl with simId: redacted-pii:sim_id[chars:20,last3:690] [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=139 ] 04-12 07:42:10.175 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.175 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.175 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.175 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.176 26156:26398 I/BugleRcsProvisioning: Checking isConfigServerUrlAvailable with simId: redacted-pii:sim_id[chars:20,last3:690], 04-12 07:42:10.176 26156:26224 I/BugleRcsEngine: Using config server URL from chxw [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=139 ] 04-12 07:42:10.177 26156:26398 I/BugleRcsEngine: getConfigServerUrl with simId: redacted-pii:sim_id[chars:20,last3:690] [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=162 ] 04-12 07:42:10.178 26156:26398 I/BugleRcsEngine: Using config server URL from chxw [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=162 ] 04-12 07:42:10.190 26156:26224 I/BugleRcsProvisioning: RcsAvailability: Subscription Id: 2, simId: redacted-pii:sim_id[chars:20,last3:690], sipConnectionType: DUAL_REG, isRcsAvailable: true 04-12 07:42:10.191 26156:26398 I/BugleRcsProvisioning: RcsAvailability: Subscription Id: 2, simId: redacted-pii:sim_id[chars:20,last3:690], sipConnectionType: DUAL_REG, isRcsAvailable: true 04-12 07:42:10.193 26156:26398 I/BugleRcsProvisioning: updateAvailabilityForRcsProvisioningId. SimId: redacted-pii:sim_id[chars:20,last3:690], currentAvailability: 1, newAvailability: 7, hint: NO_HINT 04-12 07:42:10.193 26156:26224 I/BugleRcsProvisioning: updateAvailabilityForRcsProvisioningId. SimId: redacted-pii:sim_id[chars:20,last3:690], currentAvailability: 1, newAvailability: 7, hint: NO_HINT 04-12 07:42:10.196 26156:26398 I/RcsProvisioningManager: Receive onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = RcsAvailability{mAvailability=AVAILABLE (RCS is setup)} 04-12 07:42:10.196 26156:26224 I/RcsProvisioningManager: Receive onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = RcsAvailability{mAvailability=AVAILABLE (RCS is setup)} 04-12 07:42:10.205 26156:26224 I/RcsProvisioningManager: Configuration is empty: false for simId: redacted-pii:sim_id[chars:35,last3:90)] 04-12 07:42:10.207 26156:26398 I/RcsProvisioningManager: Configuration is empty: false for simId: redacted-pii:sim_id[chars:35,last3:90)] 04-12 07:42:10.217 26156:26396 I/RcsProvisioningManager: AvailabilityObserver.onUpdate : Notify RcsAvailabilityListener csnp@2fd4ee2 onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = 7 04-12 07:42:10.219 26156:26239 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener cifv@f8ede7d onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.225 26156:26224 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener dfuu@4672cd4 onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.225 26156:26410 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener dfuu@4672cd4 onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.226 26156:26396 I/BugleTransport: Retrieved RCS available simIds: [redacted-pii[20-chars]] 04-12 07:42:10.227 26156:26220 I/RcsProvisioningManager: AvailabilityObserver.onUpdate : Notify RcsAvailabilityListener csnp@2fd4ee2 onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = 7 04-12 07:42:10.229 26156:26398 I/RcsProvisioningManager: getAvailabilityForRcsProvisioningIdSync: RcsAvailability{mAvailability=AVAILABLE (RCS is setup)} 04-12 07:42:10.230 26156:26398 I/RcsProvisioningManager: Receive onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = RcsAvailability{mAvailability=AVAILABLE (RCS is setup)} 04-12 07:42:10.233 26156:26237 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener cifv@f8ede7d onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.235 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:10.235 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:10.239 26156:26398 I/RcsProvisioningManager: Configuration is empty: false for simId: redacted-pii:sim_id[chars:35,last3:90)] 04-12 07:42:10.246 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: EventService 04-12 07:42:10.247 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: ContactsService 04-12 07:42:10.248 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: EventService 04-12 07:42:10.248 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: FileTransferService 04-12 07:42:10.249 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: ContactsService 04-12 07:42:10.249 26156:26398 I/BugleTransport: Retrieved RCS available simIds: [redacted-pii[20-chars]] 04-12 07:42:10.253 26156:26220 I/RcsProvisioningManager: AvailabilityObserver.onUpdate : Notify RcsAvailabilityListener csnp@2fd4ee2 onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = 7 04-12 07:42:10.254 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: FileTransferService 04-12 07:42:10.255 26156:26397 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener cifv@f8ede7d onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.255 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: LocationSharingService 04-12 07:42:10.256 26156:26423 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener dfuu@4672cd4 onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.257 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: ImsConnectionTrackerService 04-12 07:42:10.258 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsProfileService 04-12 07:42:10.259 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsMessagingService 04-12 07:42:10.259 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: LocationSharingService 04-12 07:42:10.261 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: ImsConnectionTrackerService 04-12 07:42:10.263 26156:26396 I/BugleTransport: Enabled chat transport for SIM = redacted-pii[20-chars] is TACHYGRAM 04-12 07:42:10.263 26156:26424 I/BugleRcs: connecting to 7 Rcs Services 04-12 07:42:10.265 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsProfileService 04-12 07:42:10.266 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsMessagingService 04-12 07:42:10.269 26156:26226 I/BugleRcs: connecting to 7 Rcs Services 04-12 07:42:10.292 26156:26398 I/BugleTransport: Enabled chat transport for SIM = redacted-pii[20-chars] is TACHYGRAM 04-12 07:42:10.294 26156:26398 I/BugleE2eeEtouffee: EtouffeeStateMachine: Ensuring state machine consistency 04-12 07:42:10.295 26156:26424 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [2] from chat transport: TACHYGRAM. 04-12 07:42:10.295 26156:26423 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: SINGLE_REGISTRATION. 04-12 07:42:10.295 26156:26422 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: DUAL_REGISTRATION. 04-12 07:42:10.299 26156:26398 I/RcsProvisioningManager: Identity mapping not empty. Backfill not required. 04-12 07:42:10.304 26156:26396 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.307 26156:26241 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.309 26156:26396 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.312 26156:26241 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.315 26156:26398 I/BugleTransport: Register SIM with subId: 2 on chat transport: TACHYGRAM. 04-12 07:42:10.316 26156:26402 I/BugleE2eeEtouffee: EtouffeeStateMachine: onRegistrationUpdate from Tachyon, previousState: REGISTERED_WITH_PREKEYS, newState: REGISTERED_WITH_PREKEYS, reason: STARTUP_ENSURE_CONSISTENCY 04-12 07:42:10.322 1509: 2752 I/ActivityManager: Changes in 99934 8 to 8, 8 to 0 04-12 07:42:10.325 26156:26397 I/BugleE2eeEtouffee: EtouffeeStateMachine: E2EE provisioning state update, Previous Etouffee status: PROVISIONED, New Etouffee status: PROVISIONED 04-12 07:42:10.326 8850: 8850 D/BoundBrokerSvc: onBind: Intent { act=com.google.android.mobstore.service.START pkg=com.google.android.gms } 04-12 07:42:10.326 8850: 8850 D/BoundBrokerSvc: Loading bound service for intent: Intent { act=com.google.android.mobstore.service.START pkg=com.google.android.gms } 04-12 07:42:10.326 26156:26396 I/BugleTransport: Retrieved RCS available simIds: [redacted-pii[20-chars]] 04-12 07:42:10.330 26156:26396 I/BugleTransport: Enabled chat transport for SIM = redacted-pii[20-chars] is TACHYGRAM 04-12 07:42:10.336 26156:26422 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [2] from chat transport: TACHYGRAM. 04-12 07:42:10.336 26156:26239 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: DUAL_REGISTRATION. 04-12 07:42:10.337 26156:26226 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: SINGLE_REGISTRATION. 04-12 07:42:10.343 26156:26423 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.343 1509: 2752 I/ActivityManager: Changes in 99934 8 to 8, 0 to 8 04-12 07:42:10.348 26156:26398 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.350 26156:26241 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.353 26156:26240 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.355 26156:26396 I/native: I0000 00:00:1744436530.355374 26396 db_store.cc:105] Loading an existing database with version 16 04-12 07:42:10.356 26156:26396 I/native: I0000 00:00:1744436530.355961 26396 db_store.cc:517] Checking presence of tables, run_sqlite_master_schema_validation=true, run_per_table_schema_validation=true 04-12 07:42:10.357 26156:26424 I/BugleTransport: Register SIM with subId: 2 on chat transport: TACHYGRAM. 04-12 07:42:10.361 26156:26396 I/native: I0000 00:00:1744436530.361027 26396 db_store.cc:428] Database schema, prefix=scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_ 04-12 07:42:10.363 26156:26396 I/native: I0000 00:00:1744436530.363041 26396 db_store.cc:449] Database schema=CREATE TABLE scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_db_configuration(single_row INTEGER NOT NULL DEFAULT 1,schema_version INTEGER NOT NULL,PRIMARY KEY(single_row) CHECK(single_row = 1)) 04-12 07:42:10.363 26156:26396 I/native: I0000 00:00:1744436530.363256 26396 db_store.cc:449] Database schema=CREATE TABLE scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_identity_keys(device_id TEXT NOT NULL,identity_key BLOB NOT NULL,revision_timestamp_millis LONG NOT NULL DEFAULT(0),PRIMARY KEY(device_id) ) 04-12 07:42:10.363 26156:26396 I/native: I0000 00:00:1744436530.363389 26396 db_store.cc:449] Database schema=CREATE TABLE scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_message_otks(message_id TEXT NOT NULL,device_id TEXT NOT NULL,otk BLOB NOT NULL,insert_timestamp_millis LONG NOT NULL DEFAULT(0),PRIMARY KEY(message_id, device_id) ) 04-12 07:42:10.363 26156:26396 I/native: I0000 00:00:1744436530.363487 26396 db_store.cc:449] Database schema=CREATE TABLE scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_prekeys(key_id INTEGER NOT NULL,key_type INTEGER NOT NULL DEFAULT(0),prekey BLOB ,timestamp_millis LONG ,PRIMARY KEY(key_id) ) 04-12 07:42:10.363 26156:26396 I/native: I0000 00:00:1744436530.363560 26396 db_store.cc:449] Database schema=CREATE TABLE scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_received_message_state(message_id TEXT NOT NULL,message_state INTEGER NOT NULL DEFAULT(0),insert_timestamp_millis LONG NOT NULL DEFAULT(0),PRIMARY KEY(message_id) ) 04-12 07:42:10.363 26156:26396 I/native: I0000 00:00:1744436530.363633 26396 db_store.cc:449] Database schema=CREATE TABLE scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_sent_message_digests(message_id TEXT NOT NULL,device_id TEXT NOT NULL,message_digest BLOB NOT NULL,insert_timestamp_millis LONG NOT NULL DEFAULT(0),PRIMARY KEY(message_id, device_id) ) 04-12 07:42:10.363 26156:26396 I/native: I0000 00:00:1744436530.363710 26396 db_store.cc:449] Database schema=CREATE TABLE scytale_05304f55237a240d9cf2f3a0ffc3afc0a0d076e9c303d2b2c7903152f196c46f0b_sessions(device_id TEXT NOT NULL DEFAULT(0),session BLOB ,PRIMARY KEY(device_id) ) 04-12 07:42:10.365 26156:26396 I/BugleE2eeEtouffee: CryptoV2Provider: Base crypto created 04-12 07:42:10.370 2784: 2784 D/WearableService: Creating wearable service asynchronously. 04-12 07:42:10.372 26156:26226 I/BugleTransport: Retrieved RCS available simIds: [redacted-pii[20-chars]] 04-12 07:42:10.378 26156:26226 I/BugleTransport: Enabled chat transport for SIM = redacted-pii[20-chars] is TACHYGRAM 04-12 07:42:10.380 26156:26423 I/BugleE2eeEtouffee: PendingFtdMessageProcessor: Removed old pending messages. count: 0 04-12 07:42:10.381 2784: 7973 D/WearableService: onGetService: waiting for onCreate to be completed. 04-12 07:42:10.383 26156:26424 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: SINGLE_REGISTRATION. 04-12 07:42:10.384 26156:26396 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [2] from chat transport: TACHYGRAM. 04-12 07:42:10.385 26156:26239 I/BugleMDD: MddBackgroundStartupTask: Scheduled MDD periodic tasks. 04-12 07:42:10.386 26156:26397 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: DUAL_REGISTRATION. 04-12 07:42:10.387 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.390 26156:26239 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.391 26156:26401 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.394 26156:26401 I/BugleE2eeEtouffee: EtouffeeStateMachine: Deleting old data if any. 04-12 07:42:10.394 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:10.394 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:10.396 26156:26402 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.397 26156:26401 D/StrictMode: StrictMode policy violation: android.os.strictmode.DiskReadViolation at android.os.StrictMode$AndroidBlockGuardPolicy.onReadFromDisk(StrictMode.java:1666) at libcore.io.BlockGuardOs.open(BlockGuardOs.java:269) at libcore.io.ForwardingOs.open(ForwardingOs.java:563) at android.app.ActivityThread$AndroidOs.open(ActivityThread.java:8782) at libcore.io.IoUtils.canOpenReadOnly(IoUtils.java:331) at dalvik.system.DexPathList$NativeLibraryElement.findNativeLibrary(DexPathList.java:889) at dalvik.system.DexPathList.findLibrary(DexPathList.java:594) at dalvik.system.BaseDexClassLoader.findLibrary(BaseDexClassLoader.java:371) at java.lang.Runtime.loadLibrary0(Runtime.java:1055) at java.lang.Runtime.loadLibrary0(Runtime.java:1003) at java.lang.System.loadLibrary(System.java:1765) at ctsr.b(PG:1) at caqd.(PG:6) at akpn.k(PG:2634) at akpn.b(PG:2387) at fcql.d(PG:10) at fcql.b(PG:7) at caii.b(PG:10) at casu.l(PG:224) at caso.b(PG:13) at fhdo.w(PG:12) at fhoz.run(PG:107) at elgf.run(PG:3) at emru.run(PG:13) at dvag.run(PG:7) at epsb.run(PG:44) at dvcy.run(PG:18) at duzo.run(PG:8) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.400 26156:26397 I/BugleTransport: Register SIM with subId: 2 on chat transport: TACHYGRAM. 04-12 07:42:10.403 2784: 2880 I/Wear_Controller: Wearable module requires a companion app to be installed. 04-12 07:42:10.403 2784: 2880 I/WearableService: onCreate: Wearable Services not starting. Wear is not available on this device. 04-12 07:42:10.404 26156:26403 I/BugleE2eeEtouffee: Removed OTK count: 0 04-12 07:42:10.404 2784: 7973 W/WearableService: onGetService: Wear is not available on this device. 04-12 07:42:10.431 25904:25909 W/mo.apktesterapp: Cleared Reference was only reachable from finalizer (only reported once) 04-12 07:42:10.433 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.433 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.433 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.433 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.433 26156:26398 D/WM-GreedyScheduler: Starting work for 390316fb-c7fa-4e53-8136-26f739a2d7b0 04-12 07:42:10.442 26156:26397 D/WM-GreedyScheduler: Cancelling work ID b8192eac-5a9a-4065-84df-541490d79e75 04-12 07:42:10.460 26156:26239 D/ProfileInstaller: Skipping profile installation for com.google.android.apps.messaging 04-12 07:42:10.467 26156:26239 I/BugleRcsProvisioning: RcsProvisioningTrigger: Schedule provisioning on app startup 04-12 07:42:10.467 26156:26397 D/WM-SystemJobScheduler: Scheduling work ID b8192eac-5a9a-4065-84df-541490d79e75Job ID 2285 04-12 07:42:10.468 26156:26239 I/BugleRcsProvisioning: RcsProvisioningTrigger: updateAvailabilityForAllSimsAsync : hint = NO_HINT logTriggerEvent = false 04-12 07:42:10.469 26156:26239 I/Bugle: RcsAvailabilityUtilForProvisioningEngineV2: updateAvailabilityForAllSimsAsync, hint: NO_HINT 04-12 07:42:10.470 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.470 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.470 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.470 26156:26397 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.470 26156:26239 I/BugleRcsProvisioning: updateAvailabilityForAllSimsAsync: scheduling updateAvailabilityForRcsProvisioningId call. Hint: NO_HINT, enableWelcomePopupWithoutGoogleTos: false, reshowSuccessPopup: false 04-12 07:42:10.473 26156:26396 I/BugleNetwork: Startup: registering tachyon. 04-12 07:42:10.473 26156:26397 I/BugleRcsProvisioning: updateRcsAvailabilityForMultipleSims: hint: NO_HINT, canReshowWelcomeMessage: false 04-12 07:42:10.479 26156:26398 D/WM-GreedyScheduler: Cancelling work ID 6522944a-6952-4eb3-8c62-c661a764560f 04-12 07:42:10.479 1509: 4165 D/SecContentProvider2: query(), uri = 18 selection = isRCSEnabled 04-12 07:42:10.479 26156:26396 I/BugleNetwork: Startup: registering tachyon for phone. 04-12 07:42:10.480 1509: 4165 I/PhoneRestrictionPolicy: isRCSEnabledInternal(), showMsg: false, columnName: enableRCS 04-12 07:42:10.480 1509: 4165 E/PhoneRestrictionPolicy: getEmergencyCall >>false 04-12 07:42:10.481 1509: 4165 I/PhoneRestrictionPolicy: isRCSEnabledInternal(), showMsg: false, columnName: enableRCSForSimSlot1 04-12 07:42:10.481 26156:26396 I/RcsProvisioningManager: Identity mapping not empty. Backfill not required. 04-12 07:42:10.481 1509: 4165 E/PhoneRestrictionPolicy: getEmergencyCall >>false 04-12 07:42:10.486 26156:26233 I/BugleNetwork: TachyonPhoneRegistration: Ensuring Tachyon phone registration 04-12 07:42:10.487 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10221[I] 04-12 07:42:10.487 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10221[I] 04-12 07:42:10.492 26156:26396 I/Bugle: VerifiedSmsEnabledCheckerImpl: VSMS is disabled via Phenotype flag. 04-12 07:42:10.493 14785:14785 I/Finsky: [2] ahre.onStartJob(126): SCH: job service start with id 9820. 04-12 07:42:10.497 26156:26398 D/WM-SystemJobScheduler: Scheduling work ID 6522944a-6952-4eb3-8c62-c661a764560fJob ID 2286 04-12 07:42:10.500 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.500 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.500 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.500 26156:26398 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.501 26156:26233 I/Bugle: VerifiedSmsStartupTask: Checking if Verified SMS tasks should be enqueued. feature supported: false, feature enabled: false, eligible / has registered key: false, C11N: false 04-12 07:42:10.502 26156:26233 I/Bugle: VerifiedSmsStartupTask: Not enqueuing VSMS periodic task, VSMS is disabled or not supported. 04-12 07:42:10.502 26156:26397 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=163: 04-12 07:42:10.504 14785:24104 I/Finsky: [3732] ncw.a(187): SCH: Satisfied jobs for 9820 are: 12-1 04-12 07:42:10.504 26156:26236 I/Bugle: VerifiedSmsStartupTask: Not calling C11N to get phone numbers. 04-12 07:42:10.504 14785:26425 I/Finsky: [3767] ahpl.accept(108): SCH: Job 12-1 starting 04-12 07:42:10.505 14785:14785 I/Finsky: [2] ahpm.o(77): WM::SCH: Logging work start for 12-1 04-12 07:42:10.505 14785:14785 I/Finsky: [2] ContentSyncJob.i(9): [ContentSync] job started 04-12 07:42:10.509 26156:26423 D/WM-GreedyScheduler: Cancelling work ID 9aa7b012-7af4-4dab-9d33-1d0361df2b93 04-12 07:42:10.510 26156:26397 I/BugleRcsProvisioning: RcsAvailability configuration availability and enabled status: simId: redacted-pii:sim_id[chars:20,last3:690], SipConnectionType: DUAL_REG, isConfigurationAvailableAndEnabled: true 04-12 07:42:10.512 26156:26397 I/BugleRcsProvisioning: Checking isConfigServerUrlAvailable with simId: redacted-pii:sim_id[chars:20,last3:690], 04-12 07:42:10.513 26156:26397 I/BugleRcsEngine: getConfigServerUrl with simId: redacted-pii:sim_id[chars:20,last3:690] [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=163 ] 04-12 07:42:10.515 26156:26397 I/BugleRcsEngine: Using config server URL from chxw [CONTEXT log_prefix="ProvisioningServerUtil" thread_id=163 ] 04-12 07:42:10.525 26156:26423 D/WM-SystemJobScheduler: Scheduling work ID 9aa7b012-7af4-4dab-9d33-1d0361df2b93Job ID 2287 04-12 07:42:10.526 26156:26397 I/BugleRcsProvisioning: RcsAvailability: Subscription Id: 2, simId: redacted-pii:sim_id[chars:20,last3:690], sipConnectionType: DUAL_REG, isRcsAvailable: true 04-12 07:42:10.528 26156:26397 I/BugleRcsProvisioning: updateAvailabilityForRcsProvisioningId. SimId: redacted-pii:sim_id[chars:20,last3:690], currentAvailability: 7, newAvailability: 7, hint: NO_HINT 04-12 07:42:10.530 26156:26396 I/BugleRcsProvisioning: scheduleProvisioningForEligibleSims 04-12 07:42:10.531 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: EventService 04-12 07:42:10.532 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: ContactsService 04-12 07:42:10.533 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: FileTransferService 04-12 07:42:10.534 26156:26239 I/BugleRcsProvisioning: RcsProvisioningTrigger: onRcsAvailabilityUpdate : availability is updated to RCS is setup, lastAvailabilityLocal is null, simId hash = 3158398560911444515, simId = redacted-pii:sim_id[chars:20,last3:690], isPev3Enabled = true 04-12 07:42:10.537 26156:26398 I/cnwf: scheduleProvisioningForEligibleSims: operationTrigger: 5 bugle trigger event: 4 04-12 07:42:10.538 26156:26398 I/cnwf: scheduleProvisioningForAllEligibleSims: operationTrigger: 5 bugle trigger event: 4 04-12 07:42:10.539 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: LocationSharingService 04-12 07:42:10.540 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: ImsConnectionTrackerService 04-12 07:42:10.541 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsProfileService 04-12 07:42:10.542 26156:26226 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsMessagingService 04-12 07:42:10.543 26156:26226 I/BugleRcs: connecting to 7 Rcs Services 04-12 07:42:10.545 26156:26422 I/cnwf: scheduleProvisioningForRcsProvisioningId: rcsProvisioningId: redacted-pii:sim_id[chars:20,last3:690] operationTrigger: 5 bugle trigger event: 4 04-12 07:42:10.547 26156:26423 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.547 26156:26423 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.547 26156:26423 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.547 26156:26422 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=182: 04-12 07:42:10.548 26156:26422 I/cnwf: RcsProvisioningTrigger: DR is active, initializing DR provisioning. DUAL_REG 04-12 07:42:10.550 26156:26423 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.551 26156:26424 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=184: 04-12 07:42:10.552 26156:26239 I/BugleRcsEngine: getRcsProvisioningGoogleTosConfiguration # cnna@5d5fcd, consentState = 0, ServerUpdateTime = 0 [CONTEXT log_prefix="ProvisioningEngineDataRetriever" thread_id=153 ] 04-12 07:42:10.555 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:10.555 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:10.561 26156:26424 I/BugleRcsEngine: Skipping full provisioning scheduling since we already have valid and updated RCS configuration [CONTEXT log_prefix="provisioning" thread_id=184 ] 04-12 07:42:10.570 26156:26422 D/WM-GreedyScheduler: Cancelling work ID f888a2e4-8a1c-4e09-968b-e68893c88d1c 04-12 07:42:10.579 26156:26239 I/RcsProvisioningManager: Receive onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = RcsAvailability{mAvailability=AVAILABLE (RCS is setup)} 04-12 07:42:10.586 26156:26239 I/RcsProvisioningManager: Configuration is empty: false for simId: redacted-pii:sim_id[chars:35,last3:90)] 04-12 07:42:10.587 26156:26398 I/BugleRcsProvisioning: RcsProvisioningTrigger: Should not schedule Revoke Google Consent Task because availability=7, isGoogleTos=true, isToggleStateUserDisabled=false 04-12 07:42:10.589 26156:26422 D/WM-SystemJobScheduler: Scheduling work ID f888a2e4-8a1c-4e09-968b-e68893c88d1cJob ID 2288 04-12 07:42:10.589 26156:26423 I/BugleRcsProvisioning: RcsProvisioningTrigger: Did not schedule RevokeGoogleConsentTask 04-12 07:42:10.596 26156:26239 I/BugleRcsProvisioning: RcsProvisioningTrigger: onRcsAvailabilityUpdate : isPreviousDisabled = true, isCurrentDisabled = false, config[simId:redacted-pii:sim_id[chars:20,last3:690]] = [Type: 1, Version: 21, Validity: 364567, Last updated: 1744345612, Remaining validity: 273649, Reconfiguration requested: false, Messaging technology: CPM, rcsVolteSingleRegistration: falseInvalid configreason: INVALID_CONFIG_REASON_UNSPECIFIED], hasToken: true, isValidAndUpdated: true 04-12 07:42:10.597 26156:26396 I/RcsProvisioningManager: AvailabilityObserver.onUpdate : Notify RcsAvailabilityListener csnp@2fd4ee2 onRcsAvailabilityUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], availability = 7 04-12 07:42:10.598 26156:26239 I/RcsProvisioningManager: Receive onRcsConfigurationUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], configuration = Type: 1, Version: 21, Validity: 364567, Last updated: 1744345612, Remaining validity: 273649, Reconfiguration requested: false, Messaging technology: CPM, rcsVolteSingleRegistration: falseInvalid configreason: INVALID_CONFIG_REASON_UNSPECIFIED 04-12 07:42:10.598 26156:26398 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener cifv@f8ede7d onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.598 26156:26422 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.598 26156:26422 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.598 26156:26422 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.599 26156:26422 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.599 26156:26239 I/RcsProvisioningManager: Configuration is empty: false for simId: redacted-pii:sim_id[chars:35,last3:90)] 04-12 07:42:10.604 26156:26226 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener dfuu@4672cd4 onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.605 26156:26410 D/WM-Processor: ptq: processing WorkGenerationalId(workSpecId=390316fb-c7fa-4e53-8136-26f739a2d7b0, generation=0) 04-12 07:42:10.606 26156:26237 I/RcsProvisioningManager: combineConfigurationWithAvailability, simId = redacted-pii:sim_id[chars:20,last3:690], hasConfig = true 04-12 07:42:10.610 26156:26424 I/RcsProvisioningManager: combineConfigurationWithAvailability, simId = redacted-pii:sim_id[chars:20,last3:690], hasConfig = true 04-12 07:42:10.612 26156:26423 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener cifv@f8ede7d onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.612 26156:26239 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=153: 04-12 07:42:10.612 26156:26422 I/BugleTransport: Retrieved RCS available simIds: [redacted-pii[20-chars]] 04-12 07:42:10.613 26156:26224 I/RcsProvisioningManager: combineConfigurationWithAvailability, simId = redacted-pii:sim_id[chars:20,last3:690], hasConfig = true 04-12 07:42:10.613 26156:26239 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=153: 04-12 07:42:10.614 26156:26398 I/RcsProvisioningManager: combineConfigurationWithAvailability, simId = redacted-pii:sim_id[chars:20,last3:690], hasConfig = true 04-12 07:42:10.614 26156:26423 I/BugleE2eeMls: MLS not enabled, skip MLS listener 04-12 07:42:10.614 26156:26224 I/RcsProvisioningManager: Notify RcsConfigurationListener cgth@e2dfce6 onRcsConfigurationUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], hasConfiguration = true 04-12 07:42:10.614 26156:26398 I/RcsProvisioningManager: Notify RcsConfigurationListener LruCache[maxSize=2,hits=3,misses=2,hitRate=60%] onRcsConfigurationUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], hasConfiguration = true 04-12 07:42:10.616 26156:26237 I/Bugle: BusinessRcsConfigurationListener: Attempting to add vsmsToken, token available: false, imsi available: true, msisdn available: true 04-12 07:42:10.616 26156:26396 I/RcsProvisioningManager: CommonRcsProvisioningChangeListenerHandler.notifyListener : Notify RcsProvisioningChangeListener dfuu@4672cd4 onRcsProvisioningChange, SIM = redacted-pii:sim_id[chars:35,last3:90)], available rcs provisioning ids = redacted-pii:sim_id[chars:20,last3:690] 04-12 07:42:10.616 26156:26237 I/Bugle: BusinessRcsConfigurationListener: Skipping storage of Verified SMS token 04-12 07:42:10.617 26156:26226 I/RcsProvisioningManager: combineConfigurationWithAvailability, simId = redacted-pii:sim_id[chars:20,last3:690], hasConfig = true 04-12 07:42:10.617 26156:26237 I/RcsProvisioningManager: Notify RcsConfigurationListener avqu@1f98f41 onRcsConfigurationUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], hasConfiguration = true 04-12 07:42:10.617 26156:26424 I/RcsProvisioningManager: Notify RcsConfigurationListener cifv@c86f227 onRcsConfigurationUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], hasConfiguration = true 04-12 07:42:10.619 26156:26239 I/BugleRcsEngine: Scheduled config refresh with 237193 seconds delay, false appendIfExists [CONTEXT thread_id=153 ] 04-12 07:42:10.620 26156:26239 I/BugleRcsProvisioning: RcsProvisioningTrigger: Schedule refresh for valid configuration : refreshDelay = 237193 04-12 07:42:10.621 26156:26422 I/BugleTransport: Enabled chat transport for SIM = redacted-pii[20-chars] is TACHYGRAM 04-12 07:42:10.621 26156:26237 I/BugleRcsEngine: SR]: Single Registration is disabled. Skipping Single Registration capability check for subId: 2, OS.isAtLeastS:[true], enableSingleRegistrationProvisioning:[false] [CONTEXT thread_id=150: 04-12 07:42:10.622 26156:26226 I/RcsProvisioningManager: Notify RcsConfigurationListener csnp@2fd4ee2 onRcsConfigurationUpdate, SIM = redacted-pii:sim_id[chars:20,last3:690], hasConfiguration = true 04-12 07:42:10.624 26156:26398 D/MddListenableWorkerFactory: createWorker for class: com.google.android.apps.messaging.shared.datamodel.workqueue.WorkQueueWorkerShim 04-12 07:42:10.626 26156:26410 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [2] from chat transport: TACHYGRAM. 04-12 07:42:10.628 26156:26239 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: DUAL_REGISTRATION. 04-12 07:42:10.629 26156:26156 D/WM-WorkerWrapper: Starting work for com.google.android.apps.messaging.shared.datamodel.workqueue.WorkQueueWorkerShim 04-12 07:42:10.629 26156:26396 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: SINGLE_REGISTRATION. 04-12 07:42:10.632 26156:26422 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.633 26156:26424 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.635 26156:26236 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.640 26156:26401 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.644 26156:26237 I/BugleRcsEngine: Scheduled provisioning task with 237193 seconds delay, KEEP policy, trigger is UNDEFINED_TRIGGER_EVENT, workerId is 33e451e8-b7d1-4b55-9ffd-ecc25cdaf30f, simId is redacted-pii:sim_id[chars:20,last3:690] [CONTEXT log_prefix="provisioning" thread_id=150 ] 04-12 07:42:10.645 26156:26398 I/BugleTransport: Register SIM with subId: 2 on chat transport: TACHYGRAM. 04-12 07:42:10.651 26156:26410 I/WM-WorkerWrapper: Worker result SUCCESS for Work [ id=390316fb-c7fa-4e53-8136-26f739a2d7b0, tags={ com.google.android.apps.messaging.shared.datamodel.workqueue.WorkQueueWorkerShim,ftd_data_clean_up_work- } ] 04-12 07:42:10.652 26156:26422 I/BugleTransport: Retrieved RCS available simIds: [redacted-pii[20-chars]] 04-12 07:42:10.653 26156:26156 D/WM-Processor: ptq 390316fb-c7fa-4e53-8136-26f739a2d7b0 executed; reschedule = false 04-12 07:42:10.655 26156:26422 I/BugleTransport: Enabled chat transport for SIM = redacted-pii[20-chars] is TACHYGRAM 04-12 07:42:10.657 26156:26239 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: DUAL_REGISTRATION. 04-12 07:42:10.658 26156:26410 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [] from chat transport: SINGLE_REGISTRATION. 04-12 07:42:10.658 26156:26220 D/WM-GreedyScheduler: Cancelling work ID 390316fb-c7fa-4e53-8136-26f739a2d7b0 04-12 07:42:10.660 26156:26237 I/BugleTransport: Deregister all SIMs except for SIMs with subIds: [2] from chat transport: TACHYGRAM. 04-12 07:42:10.661 26156:26422 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.663 26156:26398 W/RcsClientLib: Service is deprecated skipping connection attempt: RcsEngineLifecycleServiceV2 04-12 07:42:10.664 26156:26236 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.666 26156:26241 E/BugleRcs: RcsEngineLifecycleManagerV2: RcsServiceConnectionException was raised while waiting to connect to RcsEngineLifecycleServiceV2 cvia: RcsServiceConnectionException:com.google.android.rcs.client.lifecycle.RcsEngineLifecycleServiceV2:UNKNOWN at cvhh.a(PG:54) at khv.a(PG:19) at cvhi.a(PG:14) at emrr.a(PG:13) at etfp.a(PG:3) at eten.run(PG:19) at etfr.run(PG:5) at dvag.run(PG:7) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644) at duzn.run(PG:6) at java.lang.Thread.run(Thread.java:1012) at dvbh.run(PG:61) 04-12 07:42:10.669 26156:26220 D/WM-GreedyScheduler: Ignoring {WorkSpec: b8192eac-5a9a-4065-84df-541490d79e75}. Requires device idle. 04-12 07:42:10.669 26156:26220 D/WM-GreedyScheduler: Ignoring {WorkSpec: d078747f-e50b-4003-9a99-2abadc45a20f}. Requires ContentUri triggers. 04-12 07:42:10.669 26156:26398 I/BugleTransport: Register SIM with subId: 2 on chat transport: TACHYGRAM. 04-12 07:42:10.669 26156:26220 D/WM-GreedyScheduler: Ignoring {WorkSpec: fa413810-2a85-4efb-a6cd-8fdda6e754eb}. Requires ContentUri triggers. 04-12 07:42:10.670 26156:26220 D/WM-GreedyScheduler: Ignoring {WorkSpec: 5c52b460-d7bb-41b2-b594-2e2c38c32170}. Requires ContentUri triggers. 04-12 07:42:10.716 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:10.716 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:10.717 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:10.848 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.mainline.primary.libs' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:10.858 1188: 1188 D/AALLightSensor: oldLux=2 [SA:2 LA:2] newLux=2 (oriLux: 3) 04-12 07:42:10.865 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.wifi' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:10.876 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:10.876 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:10.880 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.samsung.android.camera.unihal' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:10.933 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.samsung.android.shell' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:10.987 593: 593 D/io_stats: !@ 8,32 r 32555611 675613056 w 9622476 304995172 d 585353 337986308 f 0 774284 iot 20025912 0 th 0 0 0 pt 0 inp 0 0 138465.628 04-12 07:42:11.038 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:11.038 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:11.094 1509:26429 D/WifiConnectivityMonitor.DnsThread: |207: 04-12 07:42:11.096 1509: 1860 D/WifiConnectivityMonitor.NetworkStatsAnalyzer: DNS resultType : 0, responseTime : 207 04-12 07:42:11.096 1509: 1858 D/OpenNetworkQos[4.00: updateBssidLatestDnsResultType - result: 0 04-12 07:42:11.096 1509: 1858 D/OpenNetworkQos[4.00: updateBssidNoInternet: mBssidNoInternet = false 04-12 07:42:11.096 1509: 1858 D/OpenNetworkQos[4.00: getOpenNetworkQosNoInternetStatus: false 04-12 07:42:11.096 1509: 1858 D/OpenNetworkQos[4.00: getOpenNetworkQosScores: 26 0 0 04-12 07:42:11.098 1509: 1858 D/KNOX_MDM_SettingsProvider: isChangeAllowed() : name = wifi_wcm_qos_sharing_score_summary 04-12 07:42:11.099 1509: 1858 I/WifiProfileShare: network QoS data was changed (internet), updateQoSData networkType: true, qosData: false 04-12 07:42:11.100 1509: 3005 V/WifiProfileShare.Caster: update wips network, size: 0 04-12 07:42:11.101 1509: 3005 D/WifiProfileShare: nearby scanning settings run 04-12 07:42:11.102 1509: 3005 D/WifiProfileShare: network score provider settings enabled 04-12 07:42:11.102 1509: 3005 D/OpenNetworkQos[4.00: getOpenNetworkQosScores: 26 0 0 04-12 07:42:11.102 1509: 3005 D/OpenNetworkQos[4.00: getOpenNetworkQosNoInternetStatus: false 04-12 07:42:11.103 1509: 3005 I/WifiProfileShare.Caster: current network type: 0, score: [26, 0, 0] 04-12 07:42:11.105 1509: 3005 V/WifiProfileShare.Cache: update network score 68:3f:7d:**:**:85 04-12 07:42:11.105 1509: 3005 D/WifiProfileShare.ScanMatcher: getMcfDataList size:2 04-12 07:42:11.106 1509: 3005 I/WifiProfileShare.Caster: qos data was updated , before:type:QOS, pBssid:d1:29:ed, qosData:64 after:type:QOS, pBssid:d1:29:ed, qosData:64 04-12 07:42:11.107 1509: 3005 I/[MCFSDK_android_1.2.13040]_4_McfCasterImpl: isNetworkEnabled - type : 1 ret : true 04-12 07:42:11.107 1509: 3005 D/WifiProfileShare.McfCast: -ME--- mIsNetworkEnabled :true 04-12 07:42:11.107 1509: 3005 D/WifiProfileShare.McfCast: updateQoSData ignored, same contents 04-12 07:42:11.107 1509: 3005 D/WifiProfileShare.MCF: success update QosData ! 04-12 07:42:11.108 1509: 3005 I/[MCFSDK_android_1.2.13040]_4_McfCasterImpl: isNetworkEnabled - type : 1 ret : true 04-12 07:42:11.108 1509: 3005 D/WifiProfileShare.McfCast: -ME--- mIsNetworkEnabled :true 04-12 07:42:11.108 1509: 3005 D/WifiProfileShare.McfCast: -ME--- updatePasswordDate pwdData size:2 04-12 07:42:11.192 1509: 1524 I/system_server: Background concurrent mark compact GC freed 13MB AllocSpace bytes, 608(11MB) LOS objects, 15% free, 126MB/150MB, paused 2.262ms,9.450ms total 572.349ms 04-12 07:42:11.192 1509: 1525 W/JavaBinder: BinderProxy is being destroyed but the application did not call unlinkToDeath to unlink all of its death recipients beforehand. Releasing leaked death recipient: com.android.server.art.ArtdRefCache$CacheDeathRecipient 04-12 07:42:11.192 1509: 1525 I/BpBinder: onLastStrongRef automatically unlinking death recipients: 04-12 07:42:11.195 1509: 1526 W/System: A resource failed to call close. 04-12 07:42:11.195 1509: 1526 W/System: A resource failed to call close. 04-12 07:42:11.195 1509: 1526 W/System: A resource failed to call close. 04-12 07:42:11.197 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:11.197 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:11.243 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.apex.cts.shim' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.357 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:11.358 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:11.358 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.appsearch' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.374 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.art' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.502 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.mediaprovider' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.515 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:11.516 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:11.548 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.virt' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.553 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.btservices' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.590 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.resolv' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.631 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.configinfrastructure' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.632 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.media' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.675 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:11.676 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:11.835 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:11.835 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:11.837 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.vndk.v31' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.845 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.vndk.v34' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.976 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.sdkext' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:11.995 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:11.996 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:11.998 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:12.012 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.samsung.android.biometrics.face' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.024 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.adservices' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.044 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43292, isSameBssidAndFreq true 04-12 07:42:12.047 1943: 1943 D/StatusBarIconController: ignoring old pipeline callback because the new wifi icon is enabled 04-12 07:42:12.047 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:12.047 1943: 2242 D/Tile.WifiTile: handleUpdateState isTransient=false transientEnabling =false cb.isTransient=false state.state = 2 mStateBeforeClick.value =false enabled =true 04-12 07:42:12.048 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.tethering' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.059 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:12.064 1943: 2246 I/gralloc4: @set_metadata: update dataspace from GM (0x00000000 -> 0x08010000) 04-12 07:42:12.069 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:12.069 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 90 04-12 07:42:12.074 948: 948 I/BufferQueueProducer: [StatusBar$_1943#88](this:0xb40000776697bba0,id:-1,api:0,p:-1,c:948) queueBuffer: fps=0.33 dur=3026.79 max=3026.79 min=3026.79 04-12 07:42:12.076 948: 948 D/SurfaceFlinger: GPIS:: requestGPISForClientComposition 04-12 07:42:12.080 879: 879 I/hwcomposer: [HWCDisplay] [Display_0 (type:1)] fps:0.660648,dur:3027.33,max:2956.57,min:70.76 04-12 07:42:12.080 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:12.155 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:12.155 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:12.200 879: 1114 I/hwcomposer: HWC] (0)fire a callback of refresh to SF[4: 04-12 07:42:12.211 948: 948 I/BufferQueueProducer: [FramebufferSurface](this:0xb4000077668856d0,id:-1,api:1,p:948,c:948) queueBuffer: fps=0.32 dur=3087.94 max=3087.94 min=3087.94 04-12 07:42:12.213 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.runtime' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.320 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:12.320 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:12.322 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.cellbroadcast' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.475 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:12.475 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:12.608 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.tzdata5' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.640 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:12.640 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:12.643 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.permission' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.718 1509: 2707 I/PackageInstallerSession: START COMMIT SESSION: id{1452981204} 04-12 07:42:12.798 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:12.799 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:12.827 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.samsung.android.biometrics.fingerprint' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:12.957 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:12.957 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:12.989 593: 593 D/io_stats: !@ 8,32 r 32559686 675630284 w 9622507 305012448 d 585353 337986308 f 0 774285 iot 20027296 0 th 0 0 0 pt 0 inp 0 7 138467.630 04-12 07:42:12.990 593: 593 D/io_stats: !@ Read_top(KB): binder:1111_2(1111) 18168 .apps.messaging(26156) 3200 gle.android.gms(8850) 1192 04-12 07:42:12.990 593: 593 D/io_stats: !@ Write_top(KB): kworker/u16:4(19605) 16652 kworker/u16:3(5382) 16592 -(0) 4300 04-12 07:42:13.114 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:13.115 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:13.276 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:13.276 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:13.276 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:13.439 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:13.439 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:13.594 1509: 1509 D/PocketProximityManager: setStateOut() 04-12 07:42:13.594 1509: 1509 D/PocketModeEvent: OutPocket prox 2 04-12 07:42:13.595 1509: 1732 D/PocketModeEvent: MSG_TYPE_HOVER_RECHECK_DISABLE 04-12 07:42:13.595 1509: 1732 E/PocketModeEvent: MSG_TYPE_STOP_SENSING 04-12 07:42:13.595 1509: 1732 E/PocketModeEvent: unregisterSensor L : -1 P : 0 04-12 07:42:13.596 882: 882 I/SensorsHub: activate: handle 34 enable 0 04-12 07:42:13.599 882: 882 I/SensorsHub: type : 34, enable : 0 04-12 07:42:13.601 1509: 1732 D/SensorManager: unregisterListener :: com.samsung.android.gesture.PocketModeEvent$2@b428579 04-12 07:42:13.605 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.media.swcodec' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.770 1509: 1860 D/WifiConnectivityMonitor.NetworkStatsAnalyzer: Backhaul result - RSSI:-43, CE:7, PE:7, TI:13, PTI:13, TW:6, PTW:11, Tx:3, Rx:9, TxS:0, RxS:0, RESULT:true, IC:0, ICT:5, WC:0, WCT:5, R:0, RC:0, IE:0, EC:0 04-12 07:42:13.790 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.adbd' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.817 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.i18n' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.822 1509: 1590 I/KnoxMUMContainerPolicy: getPackagesFromInstallWhiteList is called... 04-12 07:42:13.825 1509: 1590 D/ApplicationPolicy: getApplicationStateList: Enforce DOPO permission 04-12 07:42:13.825 1509: 1590 D/ApplicationPolicy: getApplicationStateList : empty 04-12 07:42:13.825 1509: 1590 I/PackageManager: isVerificationEnabled :: approvedInstaller : .* 04-12 07:42:13.825 1509: 1590 I/PackageManager: isVerificationEnabled :: installer policy contains *. 04-12 07:42:13.827 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.samsung.android.spqr' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.829 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.conscrypt' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.840 3379: 3479 I/R0: limitCPUFreq:: freq = -1 04-12 07:42:13.840 1509: 1590 D/PackageManager: Sending PACKAGE_NEEDS_VERIFICATION to com.android.vending, vid: 1652, sid: 1452981204 04-12 07:42:13.841 892: 922 I/HYPER-HAL: [RequestManager.cpp]releaseLocked(): Released ID : 5717273 04-12 07:42:13.852 1509: 1590 D/PackageManager: Sending PACKAGE_NEEDS_VERIFICATION to com.samsung.android.sm.devicesecurity, vid: 1652, sid: 1452981204 04-12 07:42:13.853 1509: 1590 D/PackageManager: sendBroadcastAsUser. PACKAGE_INSTALL_STARTED 04-12 07:42:13.853 1509: 1590 I/PackageManager: Integrity check passed for file:///data/app/vmdl1452981204.tmp 04-12 07:42:13.863 18832:18850 I/GOS:GameServiceReceiver: Task.doInBackground(), action : com.samsung.android.intent.action.PACKAGE_INSTALL_STARTED 04-12 07:42:13.864 14785:14785 I/Finsky: [2] aqwc.b(85): VerifyApps: Install-time verification requested for package com.appadvisory.drawclimber, PackageManager id = 1652, Verifier id = b289698b-cc4f-4060-b1d2-eca7a605f703 04-12 07:42:13.864 1509: 4520 D/PackageManager: verifyPendingInstall vid: 1652, vcode: 1, callingUid: 10124 04-12 07:42:13.864 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10124[I] 04-12 07:42:13.865 18832:18850 I/GOS:GameServiceReceiver: PkgInstallStarted for com.appadvisory.drawclimber UserID : 0 04-12 07:42:13.865 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10124[I] 04-12 07:42:13.870 14785:14824 I/Finsky: [121] mhk.g(167): RECEIVER_PACKAGE_VERIFICATION#logWorkEndAndFinishGoAsync: SUCCESS 04-12 07:42:13.873 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10124[I] 04-12 07:42:13.873 18832:26431 I/GOS:GameIntentService: onHandleIntent. GameIntentService. type: 15, pkgName: null 04-12 07:42:13.873 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10124[I] 04-12 07:42:13.884 14785:24704 I/Finsky: [3749] VerifyAppsInstallTask.mg(52): VerifyApps: Anti-malware verification task started for package=com.appadvisory.drawclimber 04-12 07:42:13.889 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.neuralnetworks' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.889 14785:24704 I/Finsky: [3749] VerifyAppsInstallTask.mg(278): VerifyApps: Skipping verification. Disabled by user setting 04-12 07:42:13.889 14785:24704 I/Finsky: [3749] VerifyAppsInstallTask.mg(944): VerifyApps: Skipping anti malware verification (preconditions not met). package=com.appadvisory.drawclimber 04-12 07:42:13.893 14785:24704 I/Finsky: [3749] VerifyAdvancedProtectionInstallTask.mg(9): VerifyApps AdvancedProtection: Verify AP install started 04-12 07:42:13.894 14785:24704 I/Finsky: [3749] VerifyAdvancedProtectionInstallTask.mg(43): VerifyApps AdvancedProtection: Allowing install because there are no Advanced Protection users 04-12 07:42:13.895 14785:14785 I/Finsky: [2] VerifyAdvancedProtectionInstallTask.mf(29): VerifyApps AdvancedProtection: Reported Advanced Protection verification result: ALLOW 04-12 07:42:13.898 14785:24704 I/Finsky: [3749] VerifyPerSourceInstallationConsentInstallTask.mg(318): Skipping logging for attempted installation. The source is a system package. 04-12 07:42:13.900 14785:24704 I/Finsky: [3749] VerifyInstallTask.j(17): VerifyApps: Returning package verification result id=1652, result=ALLOW 04-12 07:42:13.902 1509: 4520 D/PackageManager: verifyPendingInstall vid: 1652, vcode: 1, callingUid: 10221 04-12 07:42:13.902 1509: 1590 I/PackageManager: Continuing with installation of file:///data/app/vmdl1452981204.tmp 04-12 07:42:13.902 1509: 1591 I/PackageManager: START INSTALL PACKAGE: observer{1364476} stagedDir{/data/app/vmdl1452981204.tmp} pkg{com.appadvisory.drawclimber} versionCode{333} Request from{null} 04-12 07:42:13.908 14785:14785 I/Finsky: [2] VerifyInstallTask.mf(75): VerifyApps: Install-time verification complete: id=1652, package_name=com.appadvisory.drawclimber 04-12 07:42:13.916 18832:26431 W/GOS:PackageUtil: isPackageInstalledAsUser(). Exception: android.content.pm.PackageManager$NameNotFoundException: com.appadvisory.drawclimber 04-12 07:42:13.916 18832:26431 I/GOS:GameIntentService: onPackageChanged(). extras: Bundle[{changeType=2, userId=0, type=15, packageName=com.appadvisory.drawclimber}] 04-12 07:42:13.916 18832:26431 I/GOS:GameIntentService: onPackageChanged(). changeType(INSTALL_STARTED), pkgName(com.appadvisory.drawclimber), UserHandle(0), userId(0), Installed(false) 04-12 07:42:13.917 18832:26431 W/GOS:PackageUtil: isVrApp(). PackageManager.NameNotFoundException: com.appadvisory.drawclimber 04-12 07:42:13.917 14785:14816 I/android.vending: Waiting for a blocking GC ProfileSaver 04-12 07:42:13.919 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.ipsec' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.919 18832:26431 I/GOS:SystemEventReactor: addPkgDataFromServer(), use pre category: game 04-12 07:42:13.921 1509: 1590 W/PackageManager: verifying app can be installed or not 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking PKG WL - false 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking PKG BL - true 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking PERM BL - true 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking SIG BL - true 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking PKG WL - false 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking PKG BL - true 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking PERM BL - true 04-12 07:42:13.921 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : Checking SIG BL - true 04-12 07:42:13.922 1509: 1590 D/ApplicationPolicy: isApplicationInstallationEnabled : enabled true 04-12 07:42:13.922 1509: 1590 I/AASA_ASKSManager: ASKS_VERSION: 8.4 ::20240926 04-12 07:42:13.922 1509: 1590 I/AASA_ASKSManager: initiating = com.android.shell, installer = null 04-12 07:42:13.925 1509: 1590 D/RestrictionPolicy: isNewAdminInstallationEnabledInternal : false 04-12 07:42:13.933 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.devicelock' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.962 1509: 1885 D/NetdEventListenerService: DNS Requested by 110, 10073, 27 04-12 07:42:13.962 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.ondevicepersonalization' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:13.994 1509: 1590 I/PermissionManager: Permission ownership changed. Updating all permissions. 04-12 07:42:14.053 14785:14790 I/android.vending: Background concurrent mark compact GC freed 11MB AllocSpace bytes, 4(144KB) LOS objects, 49% free, 12MB/24MB, paused 1.534ms,5.147ms total 149.632ms 04-12 07:42:14.053 14785:14816 I/android.vending: WaitForGcToComplete blocked ProfileSaver on Background for 135.760ms 04-12 07:42:14.127 1509: 1590 D/PackageSettings: ++ writeStateForUserSyncLPr(0) 04-12 07:42:14.149 3379: 3379 I/SDHMS:LOAD: type: LoadsFreqs, value: 0:0:0:956000:2200000:725000:1026000:2000000:500000:8:415:0 04-12 07:42:14.185 1509: 1590 W/PackageSettings: -- writeStateForUserSyncLPr(0) 04-12 07:42:14.186 1509: 1590 W/EnterpriseLicenseService: updateAdminPermissions() :com.teamviewer.host.market 04-12 07:42:14.186 1509: 1590 I/PackageManager: setLicensePermissions 04-12 07:42:14.186 1509: 1590 I/PermissionManager: setLicensePermissions : packageName = com.teamviewer.host.market 04-12 07:42:14.186 1509: 1590 D/EnterpriseLicenseService: getPermissions() - deserializeObject 04-12 07:42:14.256 1509: 2171 W/system_server: Long monitor contention with owner PackageManager (1590) at void com.android.server.pm.permission.LegacyPermissionSettings.replacePermissions(java.util.List)(LegacyPermissionSettings.java:90) waiters=0 in com.android.server.pm.Computer com.android.server.pm.PackageManagerService.snapshotComputer(boolean) for 282ms 04-12 07:42:14.258 1509: 4165 W/system_server: Long monitor contention with owner binder:1509_A (2171) at com.android.server.pm.Computer com.android.server.pm.PackageManagerService.snapshotComputer(boolean)(PackageManagerService.java:1404) waiters=0 in com.android.server.pm.Computer com.android.server.pm.PackageManagerService.snapshotComputer(boolean) for 219ms 04-12 07:42:14.260 1509: 1818 I/ChimeraAggressivePolicyHandler: executePolicy() - triggerSource: TRIGGER_SOURCE_LMKD 04-12 07:42:14.261 1509: 1818 I/ChimeraAggressivePolicyHandler: available memory: 1206088, free memory target: 696320, quit chimera 04-12 07:42:14.266 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.healthfitness' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.295 1509: 1590 D/AASA_ASKSManager_RESTRICTED: There is no restricted rule. 04-12 07:42:14.295 1509: 1590 W/PackageInformation: PackageInfo in info_list 04-12 07:42:14.295 1509: 1590 I/SPEG: Feature is disabled by high temperature 04-12 07:42:14.314 25792:25795 I/artd: Merge skipped because there are no existing profiles 04-12 07:42:14.315 1509: 1590 I/ArtService: Adjusting the compiler filter for 'com.appadvisory.drawclimber' from 'speed-profile' to 'verify' because there is no valid profile 04-12 07:42:14.364 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.uwb' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.366 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.extservices' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.366 25792:25795 I/artd: Dex parent of /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.apk is not writable: Permission denied 04-12 07:42:14.367 25792:25795 I/artd: GetBestInfo checking odex in dalvik-cache (/data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.dex) 04-12 07:42:14.367 25792:25795 I/artd: Loading /data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.dex with executable: 0 04-12 07:42:14.367 25792:25795 I/artd: OatFileAssistant test for existing oat file /data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.dex: File /data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.vdex does not exist. 04-12 07:42:14.367 25792:25795 I/artd: GetBestInfo checking odex next to the dex file (/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.odex) 04-12 07:42:14.367 25792:25795 I/artd: Loading /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.odex with executable: 0 04-12 07:42:14.367 25792:25795 I/artd: OatFileAssistant test for existing oat file /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.odex: File /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.vdex does not exist. 04-12 07:42:14.367 25792:25795 I/artd: GetBestInfo checking vdex in dalvik-cache (/data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.vdex) 04-12 07:42:14.367 25792:25795 I/artd: unable to open vdex file /data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.vdex: File /data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.vdex does not exist. 04-12 07:42:14.367 25792:25795 I/artd: OatFileAssistant test for existing oat file /data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.vdex: File /data/dalvik-cache/arm64/data@app@~~fD0DuKv6tf9aOEnSWXbDzQ==@com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==@base.apk@classes.vdex does not exist. 04-12 07:42:14.367 25792:25795 I/artd: GetBestInfo checking vdex next to the dex file (/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.vdex) 04-12 07:42:14.367 25792:25795 I/artd: unable to open vdex file /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.vdex: File /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.vdex does not exist. 04-12 07:42:14.367 25792:25795 I/artd: OatFileAssistant test for existing oat file /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.vdex: File /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.vdex does not exist. 04-12 07:42:14.367 25792:25795 I/artd: GetBestInfo checking dm (/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.dm) 04-12 07:42:14.367 25792:25795 W/ziparchive: Unable to open '/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.dm': No such file or directory 04-12 07:42:14.367 25792:25795 I/artd: OatFileAssistant test for existing oat file /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.dm: I/O error 04-12 07:42:14.367 25792:25795 I/artd: GetBestInfo checking dm (/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.dm) 04-12 07:42:14.367 25792:25795 W/ziparchive: Unable to open '/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.dm': No such file or directory 04-12 07:42:14.367 25792:25795 I/artd: OatFileAssistant test for existing oat file /data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.dm: I/O error 04-12 07:42:14.367 25792:25795 I/artd: GetBestInfo no usable artifacts 04-12 07:42:14.392 25792:25795 I/artd: Running dex2oat: /apex/com.android.art/bin/art_exec --drop-capabilities --set-task-profile=Dex2OatBootComplete --set-priority=background --keep-fds=7:8:9:10:11 -- /apex/com.android.art/bin/dex2oat32 --zip-fd=7 --zip-location=/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.apk --oat-fd=8 --oat-location=/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.odex --output-vdex-fd=9 --swap-fd=10 --class-loader-context-fds=11 --class-loader-context=PCL[]{PCL[/system/framework/org.apache.http.legacy.jar]} --classpath-dir=/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg== --instruction-set=arm64 --instruction-set-features=default --instruction-set-variant=cortex-a55 --compiler-filter=verify --compilation-reason=install --compact-dex-level=none --max-image-block-size=524288 --resolve-startup-const-strings=true --generate-mini-debug-info --runtime-arg -Xtarget-sdk-version:33 --runtime-arg -Xhidden-api-policy:enabled --cpu-set=0,1,2,3 -j4 --runtime-arg -Xms64m --runtime-arg -Xmx512m --comments=app-name:com.appadvisory.drawclimber,app-version-name:1.16.06,app-version-code:333,art-version:351410020 Opened FDs: 7:/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.apk 8:/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.odex.yHLjGB.tmp 9:/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.vdex.2YOwwh.tmp 10:/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/oat/arm64/base.odex.swap.7OUqVp.tmp 11:/system/framework/org.apache.http.legacy.jar 04-12 07:42:14.417 26442:26442 W/libprocessgroup: SetAttribute: unknown attribute: 04-12 07:42:14.417 26442:26442 W/libprocessgroup: SetAttribute: unknown attribute: 04-12 07:42:14.417 26442:26442 W/libprocessgroup: SetAttribute: unknown attribute: STunePreferIdle 04-12 07:42:14.417 26442:26442 W/libprocessgroup: SetAttribute: unknown attribute: STunePreferIdle 04-12 07:42:14.431 18832:26431 I/GOS:SystemEventReactor: addPkgDataFromServer(), A package was added : com.appadvisory.drawclimber as game 04-12 07:42:14.441 18832:26431 W/GOS:GmsGlobalPackageDataSetter: putToGameMap(), refreshGameMap is null. refreshGameMap=null 04-12 07:42:14.441 18832:26431 W/GOS:GmsGlobalPackageDataSetter: applySingleGame(), start 04-12 07:42:14.443 18832:26431 I/GOS:SiopModeFeature: getUpdatedConfig. global siopMode: 1 04-12 07:42:14.444 18832:26431 I/GOS:Dss: getDssValueForCurrentMode(). is multi resolution 04-12 07:42:14.446 18832:26431 I/GOS:DssFeature: dpi: 450, width: 1080, height: 2340 04-12 07:42:14.446 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.os.statsd' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.446 18832:26431 I/GOS:Dss: getDssValueForCurrentMode(). global target short side is available. 04-12 07:42:14.447 18832:26431 I/GOS:DssFeature: dpi: 450, width: 1080, height: 2340 04-12 07:42:14.447 18832:26431 I/GOS:DssFeature: dpi: 450, width: 1080, height: 2340 04-12 07:42:14.447 18832:26431 I/GOS:TssCore: getDssByShortSide(). displayShortSide : 1080, targetShortSide : 1080, tempDss : 100.0, resultDss : 100.0 04-12 07:42:14.447 18832:26431 I/GOS:TssCore: getMergedEachModeTss()-merged: [1080, 1080, 1080, 1080], com.appadvisory.drawclimber 04-12 07:42:14.447 18832:26431 I/GOS:DssFeature: dpi: 450, width: 1080, height: 2340 04-12 07:42:14.447 18832:26431 I/GOS:TssCore: getDssByShortSide(). displayShortSide : 1080, targetShortSide : 1080, tempDss : 100.0, resultDss : 100.0 04-12 07:42:14.447 18832:26431 I/GOS:Dss: getDssValueForCurrentMode(). mode level : 1, target short side is 1080, dss for other modes : 100.0 04-12 07:42:14.454 18832:26431 I/GOS:VrrFeature: requestVrr(), max(result for static)=0, min=60, pkgName=com.appadvisory.drawclimber 04-12 07:42:14.454 18832:26431 I/GOS:VrrFeature: requestVrr(), gamePackageNameListToBeRemoved=[com.appadvisory.drawclimber] 04-12 07:42:14.454 18832:26431 I/GOS:VrrFeature: requestRemoveVrr() - [com.appadvisory.drawclimber] 04-12 07:42:14.455 1509: 2171 D/SGM:GameManager: requestToRemoveRefreshRate(), jsonParam: {"package_name_list":"com.appadvisory.drawclimber"} 04-12 07:42:14.455 1509: 2171 D/SGM:GameManager: respondWithJson. command: request_to_remove_refresh_rate jsonParam : {"package_name_list":"com.appadvisory.drawclimber"} response : {"value_bool_1":true} 04-12 07:42:14.456 1509: 2171 D/SGM:GameManager: setPerformanceMode(), tunePerformanceMode: 1, callerPackageName: , mCurrentUserId: 0, callerUserId: 0 04-12 07:42:14.457 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), tag: SET_GLO 04-12 07:42:14.457 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), msg: setPerformanceMode(), SiopMode: 1 04-12 07:42:14.459 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:14.467 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), delete log data to avoid overflow, id: 9310 04-12 07:42:14.467 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), ret: 9810 04-12 07:42:14.468 1509: 2171 D/SGM:GameManager: setPackageConfigurations(). mCurrentUserId: 0, callerUserId: 0 04-12 07:42:14.468 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), tag: SET_PKG 04-12 07:42:14.468 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), msg: setPackageConfigurations() 0x0 0ppi 04-12 07:42:14.469 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:14.471 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), delete log data to avoid overflow, id: 9311 04-12 07:42:14.471 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), ret: 9811 04-12 07:42:14.471 1509: 2171 D/SGM:GameManager: setPkgDataWithConfigurationImpl(). configuration: packageName: com.appadvisory.drawclimber, performancePolicyForSsrm: {"cpu_level":2,"gpu_level":0,"siop_mode":1}, optimalAspectRatio: 1.7777778, dynamicSurfaceScaling: 1.0, category: 1, categoryByUser: 1, fillBlackSurfaceOnMargins: false, userId: 0 04-12 07:42:14.471 1509: 2171 D/SGM:GameManager: setPkgDataWithConfigurationImpl(). final csvUserId=0 04-12 07:42:14.472 1509: 2171 D/SGM:GameManager: setPkgDataWithConfigurationImpl(). userId=0 04-12 07:42:14.472 1509: 2171 D/SGM:PkgDataHelper: putPkgData(). com.appadvisory.drawclimber, userId = 0 04-12 07:42:14.472 1509: 2171 D/SGM:GameManager: setAOSPGameMode() pkgName : com.appadvisory.drawclimber, ASOP_gameMode : 2 04-12 07:42:14.476 1509: 2171 D/GameManagerService: No-op for attempt to set game mode for non-game app: com.appadvisory.drawclimber 04-12 07:42:14.476 1509: 2171 I/GameManagerService: Package Name: com.appadvisory.drawclimber FPS: 0 Scaling: 1.0 04-12 07:42:14.476 1509: 2171 D/GameManagerService: No-op for attempt to set game mode for non-game app: com.appadvisory.drawclimber 04-12 07:42:14.476 1509: 2171 D/DssController: Google Screen Compat off for package: com.appadvisory.drawclimber 04-12 07:42:14.476 1509: 2171 D/SGM:GameManager: setPkgDataWithConfigurationImpl(). dss=1.0 04-12 07:42:14.478 1509: 2171 D/SGM:DatabaseHelper: updateOrAddPkg(), insert packageName: com.appadvisory.drawclimber, userID: 0, result: 1 04-12 07:42:14.478 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), tag: SET_PKG 04-12 07:42:14.478 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), msg: [com.appadvisory.drawclimber] DSS OFF, GTC: 2/0/0, GameSDK: -1/-1/true 04-12 07:42:14.480 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:14.480 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 90 04-12 07:42:14.482 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), delete log data to avoid overflow, id: 9312 04-12 07:42:14.482 1509: 2171 D/SGM:DatabaseHelper: addActionLog(), ret: 9812 04-12 07:42:14.482 1509: 2171 V/SGM:Util: systemCountryIsoCode:FR 04-12 07:42:14.483 1509: 2171 D/SGM:GameManager: sendPackageDataToSdhms(). sending intent to SDHMS. 04-12 07:42:14.483 1509: 2171 V/SGM:GameManager: sendPackageDataToSdhms(). configArray=[packageName: com.appadvisory.drawclimber, performancePolicyForSsrm: {"cpu_level":2,"gpu_level":0,"siop_mode":1}, optimalAspectRatio: 1.7777778, dynamicSurfaceScaling: 1.0, category: 1, categoryByUser: 1, fillBlackSurfaceOnMargins: false, userId: 0] 04-12 07:42:14.483 18832:26431 I/GOS:GmsGlobalPackageDataSetter: setPkgData(), ret: true 04-12 07:42:14.491 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:14.503 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:14.506 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.samsung.android.authfw.ta' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.514 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:14.525 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:14.528 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.android.rkpd' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.536 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.google.android.scheduling' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.546 14785:14785 W/Finsky: [2] ajfv.b(131): STU: Failed to get storage stats for package 'com.samsung.android.lifeguard' (1601: Error getting stats: android.content.pm.PackageManager.NameNotFoundException) 04-12 07:42:14.550 1509: 1821 D/CompatibilityChangeReporter: Compat change id reported: 74210811; UID 1000; state: DISABLED 04-12 07:42:14.572 14785:14785 I/Finsky: [2] nlc.a(199): App states replicator found 43 unowned apps 04-12 07:42:14.586 14785:14785 I/Finsky: [2] nlh.b(18): Completed 0 account content syncs with 0 successful. 04-12 07:42:14.587 14785:14785 I/Finsky: [2] ContentSyncJob.a(12): [ContentSync] Installation state replication succeeded. 04-12 07:42:14.587 14785:14785 I/Finsky: [2] ahpm.q(56): SCH: jobFinished: 12-1. TimeElapsed: 4082ms. 04-12 07:42:14.588 14785:14785 I/Finsky: [2] aiyg.b(39): WM::SCH: Logging work end for 12-1 04-12 07:42:14.599 26442:26442 I/dex2oat32: MMAP_TRYLOCK is not supported in uffd addr:0xef99c000 page-size:4096 04-12 07:42:14.599 14785:14854 I/Finsky: 144] saj.accept(58): SCH: Scheduling phonesky job Id: 1-1337, CT: 1744409406278, Constraints: [{ L: 43117026, D: 86317026, C: CHARGING_NONE, I: IDLE_NONE, N: NET_ANY, B: BATTERY_ANY }: 04-12 07:42:14.600 14785:14854 I/Finsky: 144] saj.accept(58): SCH: Scheduling phonesky job Id: 34-407, CT: 1744409411509, Constraints: [{ L: 604800000, D: 2498346999, C: CHARGING_NONE, I: IDLE_NONE, N: NET_ANY, B: BATTERY_ANY }: 04-12 07:42:14.601 14785:14854 I/Finsky: 144] saj.accept(58): SCH: Scheduling phonesky job Id: 34-411, CT: 1744409411510, Constraints: [{ L: 604800000, D: 2580279494, C: CHARGING_NONE, I: IDLE_NONE, N: NET_ANY, B: BATTERY_ANY }: 04-12 07:42:14.602 14785:14854 I/Finsky: 144] saj.accept(58): SCH: Scheduling phonesky job Id: 34-416, CT: 1744409411508, Constraints: [{ L: 67479235, D: 1363479235, C: CHARGING_NONE, I: IDLE_NONE, N: NET_ANY, B: BATTERY_ANY }: 04-12 07:42:14.609 26442:26442 W/dex2oat32: Obsolete flag --compact-dex-level ignored 04-12 07:42:14.610 14785:14849 I/Finsky: [139] ncx.apply(251): SCH: Scheduling 1 system job(s) 04-12 07:42:14.611 26442:26442 W/dex2oat32: Mismatch between instruction set variant of device (ISA: Arm64 Feature string: -a53,crc,lse,fp16,dotprod,-sve) and features returned by the hardware (ISA: Arm64 Feature string: -a53,-crc,-lse,-fp16,-dotprod,-sve) 04-12 07:42:14.611 14785:14849 I/Finsky: [139] ahpi.b(244): SCH: Scheduling system job Id: 9825, L: 15988694, D: 59188694, C: false, I: false, N: 1 04-12 07:42:14.618 26442:26442 I/dex2oat32: /apex/com.android.art/bin/dex2oat32 --output-vdex-fd=9 --class-loader-context-fds=11 --class-loader-context=PCL[]{PCL[/system/framework/org.apache.http.legacy.jar]} --classpath-dir=/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg== --compiler-filter=verify --compilation-reason=install --compact-dex-level=none --max-image-block-size=524288 --resolve-startup-const-strings=true --generate-mini-debug-info --cpu-set=0,1,2,3 -j4 --comments=app-name:com.appadvisory.drawclimber,app-version-name:1.16.06,app-version-code:333,art-version:351410020 04-12 07:42:14.624 14785:26425 I/Finsky: [3767] ahre.a(24): SCH: job service finished with id 9820. 04-12 07:42:14.632 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10221[I] 04-12 07:42:14.632 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10221[I] 04-12 07:42:14.634 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10221[I] 04-12 07:42:14.635 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10221[I] 04-12 07:42:14.712 1509: 1524 I/system_server: Background concurrent mark compact GC freed 26MB AllocSpace bytes, 153(5312KB) LOS objects, 15% free, 127MB/151MB, paused 2.776ms,9.083ms total 582.956ms 04-12 07:42:14.713 1509: 1526 W/System: A resource failed to call close. 04-12 07:42:14.715 1509: 1526 W/System: A resource failed to call close. 04-12 07:42:14.869 1509: 2171 D/CompatibilityChangeReporter: Compat change id reported: 261072174; UID 1000; state: ENABLED 04-12 07:42:14.993 593: 593 D/io_stats: !@ 8,32 r 32563432 675663636 w 9623489 305116888 d 585353 337986308 f 0 774389 iot 20028704 0 th 0 0 0 pt 0 inp 0 0 138469.633 04-12 07:42:15.056 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43293, isSameBssidAndFreq true 04-12 07:42:15.057 1509: 1835 I/SemWifiLinkQualityMonitor: Link stat: 0 / 0 / 1,00 (14) / 433 / -43.0 || 100.0 : 433,00 / 0.5 : 1,00 / 0.55 : 0,30 / G (G) || 0,12 ms / 65,93 Mbps / D || 0 / N / 0 Y / 0 Y 04-12 07:42:15.068 1300: 1300 D/connsyslogger: Open FIFO for close 04-12 07:42:15.203 1509: 1546 D/PackageSettings: ++ writeStateForUserSyncLPr(0) 04-12 07:42:15.204 1509: 1546 W/PackageSettings: -- writeStateForUserSyncLPr(0) 04-12 07:42:15.260 1188: 1188 D/AALLightSensor: oldLux=2 [SA:2 LA:2] newLux=2 (oriLux: 2) 04-12 07:42:15.560 26156:26156 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_FixupMessageStatusOnStartupAction 04-12 07:42:15.561 26156:26220 I/BugleDataModel: ExecuteActionRunnable: running action FixupMessageStatusOnStartupAction 04-12 07:42:15.561 26156:26156 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_ProcessPendingMessagesAction 04-12 07:42:15.613 26156:26220 I/BugleDataModel: FixupMessageStatusOnStartupAction: sendFailedCnt: 0, downloadFailedCnt: 0, partsProcessingFailedCnt: 0 04-12 07:42:15.621 26156:26156 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_SelfParticipantsRefreshAction 04-12 07:42:15.637 1509: 4523 I/LocationAccessPolicy: checkLocationPermission - callingUid: 10219, callingPid: 26156, resultForFine: DENIED_HARD 04-12 07:42:15.638 1509: 4523 I/LocationAccessPolicy: checkLocationPermission - callingUid: 10219, callingPid: 26156, resultForCoarse: DENIED_HARD 04-12 07:42:15.652 26156:26398 I/Bugle: processRcsReadinessReason: Current ChatTransportType is: 2, ready: true 04-12 07:42:15.653 26156:26398 I/Bugle: kickOffPendingIfNowConnected: RCS is ready and it was off. Trigger scheduling: [scheduleProcessPendingMessagesActionForStartup, scheduleOnlyForCurrentProcess, maybeScheduleImmediately] 04-12 07:42:15.657 26156:26398 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_ProcessPendingMessagesAction 04-12 07:42:15.660 26156:26220 I/BugleDataModel: PendingMessagesProcessor process from FixupMessageStatusOnStartupAction due to process restarts throttled with delay 0s with queues smsMessagesToSend:0 mmsMessagesToSend:0 rcsMessagesToSend:0 rcsFTMessagesToSend:0 messagesToDownload:0 04-12 07:42:15.662 26156:26220 I/BugleDataModel: Cleared next retry time for channel: sms_send 04-12 07:42:15.663 26156:26220 I/BugleDataModel: Cleared next retry time for channel: mms_send 04-12 07:42:15.664 26156:26220 I/BugleDataModel: Cleared next retry time for channel: mms_download 04-12 07:42:15.665 26156:26220 I/BugleDataModel: Cleared next retry time for channel: rcs_send 04-12 07:42:15.665 26156:26220 I/BugleDataModel: Cleared next retry time for channel: rcs_ft_upload 04-12 07:42:15.669 26156:26220 I/BugleDataModel: Cleared next retry time for channel: rcs_ft_download 04-12 07:42:15.670 26156:26220 I/BugleDataModel: Cleared next retry time for channel: cloud_sync_send 04-12 07:42:15.670 26156:26220 I/BugleDataModel: Cleared next retry time for channel: cloud_sync_attachment_download 04-12 07:42:15.673 26156:26220 I/BugleDataModel: ExecuteActionRunnable: running action ProcessPendingMessagesAction 04-12 07:42:15.684 26156:26220 I/BugleDataModel: PendingMessagesProcessor process from ProcessPendingMessagesAction due to scheduled processing with delay 0s with queues smsMessagesToSend:0 mmsMessagesToSend:0 rcsMessagesToSend:0 rcsFTMessagesToSend:0 messagesToDownload:0 04-12 07:42:15.687 26156:26220 I/BugleDataModel: ExecuteActionRunnable: running action SelfParticipantsRefreshAction 04-12 07:42:15.689 26156:26220 I/BugleDataModel: ActionExecutorImpl: ACTION_BACKGROUND_QUEUED_SelfParticipantsRefreshAction 04-12 07:42:15.690 26156:26220 I/BugleDataModel: ExecuteActionRunnable: running action ProcessPendingMessagesAction 04-12 07:42:15.696 26156:26422 I/BugleDataModel: ParticipantRefresh: ContactContentObserver created 04-12 07:42:15.702 26156:26220 I/BugleDataModel: PendingMessagesProcessor process from ProcessPendingMessagesAction due to connectivity state changed with delay 0s with queues smsMessagesToSend:0 mmsMessagesToSend:0 rcsMessagesToSend:0 rcsFTMessagesToSend:0 messagesToDownload:0 04-12 07:42:15.704 26156:26220 I/BugleDataModel: Cleared next retry time for channel: sms_send 04-12 07:42:15.705 26156:26220 I/BugleDataModel: Cleared next retry time for channel: mms_send 04-12 07:42:15.705 26156:26422 I/BugleDataModel: ParticipantFullRefresh: Start participant refresh. refreshMode: SELF_ONLY 04-12 07:42:15.706 26156:26220 I/BugleDataModel: Cleared next retry time for channel: mms_download 04-12 07:42:15.706 26156:26220 I/BugleDataModel: Cleared next retry time for channel: rcs_send 04-12 07:42:15.707 26156:26220 I/BugleDataModel: Cleared next retry time for channel: rcs_ft_upload 04-12 07:42:15.708 26156:26220 I/BugleDataModel: Cleared next retry time for channel: rcs_ft_download 04-12 07:42:15.708 26156:26220 I/BugleDataModel: Cleared next retry time for channel: cloud_sync_send 04-12 07:42:15.709 26156:26220 I/BugleDataModel: Cleared next retry time for channel: cloud_sync_attachment_download 04-12 07:42:15.714 26156:26422 I/BugleDataModel: SubscriptionsTracker#refreshSelfParticipantList([2]) 04-12 07:42:15.716 26156:26156 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_SendReportAction 04-12 07:42:15.716 26156:26398 I/BugleDataModel: ProcessPendingRevocationsActionScheduler: scheduled next action. back off seconds: 0 04-12 07:42:15.717 26156:26156 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_ProcessPendingRevocationsAction 04-12 07:42:15.717 26156:26398 I/BugleGroupManagement: Skipping RCS group identifiers telephony batch migration. Disabled by phenotype. 04-12 07:42:15.720 26156:26220 I/BugleDataModel: ExecuteActionRunnable: running action SendReportAction 04-12 07:42:15.721 26156:26220 I/BugleDataModel: ActionExecutorImpl: ACTION_BACKGROUND_QUEUED_SendReportAction 04-12 07:42:15.723 26156:26220 I/BugleDataModel: ExecuteActionRunnable: running action ProcessPendingRevocationsAction 04-12 07:42:15.725 26156:26220 I/BugleDataModel: ActionExecutorImpl: ACTION_BACKGROUND_QUEUED_ProcessPendingRevocationsAction 04-12 07:42:15.753 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=2 ] 04-12 07:42:15.758 26156:26422 I/Bugle: SubscriptionUtils.getCanonicalForSelf: self=redacted-pii[12-chars], country=FR [CONTEXT sub_id=2 ] 04-12 07:42:15.762 26156:26156 I/BugleDataModel: ActionExecutorImpl: ACTION_EXECUTE_QUEUED_GenericWorkerQueueAction 04-12 07:42:15.764 26156:26220 I/BugleDataModel: ExecuteActionRunnable: running action GenericWorkerQueueAction 04-12 07:42:15.766 26156:26220 I/BugleDataModel: ActionExecutorImpl: ACTION_BACKGROUND_QUEUED_GenericWorkerQueueAction 04-12 07:42:15.784 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=2 ] 04-12 07:42:15.804 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=2 ] 04-12 07:42:15.808 26156:26422 I/Bugle: SubscriptionUtils.getCanonicalForSelf: self=redacted-pii[12-chars], country=FR [CONTEXT sub_id=2 ] 04-12 07:42:15.821 26156:26422 I/BugleSelfIdentity: Phone number for MyIdentity bd01e789-1a72-4be8-a370-f213881833a1 does not change [CONTEXT sub_id=2 icc_id="89330124364015206690" messaging_identity="redacted-pii[12-chars]" rcs_provisioning_id="redacted-pii[0-chars]" ] 04-12 07:42:15.837 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:15.864 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=2 ] 04-12 07:42:15.870 26156:26178 I/.apps.messaging: Background concurrent mark compact GC freed 9378KB AllocSpace bytes, 0(0B) LOS objects, 49% free, 9015KB/17MB, paused 2.143ms,8.692ms total 142.181ms 04-12 07:42:15.891 26156:26422 I/BugleDataModel: SubscriptionsTracker bindToTrackingMap bound participants: [ParticipantId=1 subId=-1, ParticipantId=2 subId=1, ParticipantId=3 subId=2, ParticipantId=8 subId=3] 04-12 07:42:15.892 26156:26422 I/BugleDataModel: set orderedRowIdAndTokenPairs: [rowId=3 subId= 2 token=bd01e789-1a72-4be8-a370-f213881833a1, rowId=1 subId= -1 token=56724516-5b1e-47fd-aefd-28ae6ddb4679, rowId=8 subId= 3 token=9e5f0bdd-5dc6-40d0-8d48-e33bf37660d1, rowId=2 subId= 1 token=45ff5ed2-5948-45fb-a712-9f1371f77d95] 04-12 07:42:15.904 26156:26240 I/BugleDataModel: SubscriptionsTracker bindToTrackingMap bound participants: [ParticipantId=1 subId=-1, ParticipantId=2 subId=1, ParticipantId=3 subId=2, ParticipantId=8 subId=3] 04-12 07:42:15.920 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=2 ] 04-12 07:42:15.924 26156:26422 I/Bugle: SubscriptionUtils.getCanonicalForSelf: self=redacted-pii[12-chars], country=FR [CONTEXT sub_id=2 ] 04-12 07:42:15.939 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10053[I] 04-12 07:42:15.940 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10053[I] 04-12 07:42:15.945 1509: 1544 E/Watchdog: !@Sync: 4615 heap: 134 / 151 FD: 1017 [2025-04-12 07:42:15.945] 04-12 07:42:16.005 15337:12771 I/ContactsProvider: queryCorpLookupIfNecessary - query for knox took 3 ms elapsed 04-12 07:42:16.011 26156:26422 I/Bugle: TelephonyManagerFactory: Returning per-subscription TelephonyManager (>= N) subscription{id:1} 04-12 07:42:16.016 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=1 ] 04-12 07:42:16.018 26156:26422 I/Bugle: TelephonySubscriptionInfoAsOfLMR1: getActiveSubscriptionInfo(): empty sub info for subscription{id:1} 04-12 07:42:16.022 26156:26422 I/Bugle: SubscriptionUtils.getCanonicalForSelf: self=redacted-pii[12-chars], country= [CONTEXT sub_id=1 ] 04-12 07:42:16.025 26156:26422 I/Bugle: TelephonySubscriptionInfoAsOfLMR1: getActiveSubscriptionInfo(): empty sub info for subscription{id:1} 04-12 07:42:16.057 15337:12771 I/ContactsProvider: queryCorpLookupIfNecessary - query for knox took 1 ms elapsed 04-12 07:42:16.067 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=2 ] 04-12 07:42:16.071 26156:26422 I/Bugle: SubscriptionUtils.getCanonicalForSelf: self=redacted-pii[12-chars], country=FR [CONTEXT sub_id=2 ] 04-12 07:42:16.107 15337:12771 I/ContactsProvider: queryCorpLookupIfNecessary - query for knox took 0 ms elapsed 04-12 07:42:16.114 26156:26422 I/Bugle: TelephonyManagerFactory: Returning per-subscription TelephonyManager (>= N) subscription{id:3} 04-12 07:42:16.120 26156:26422 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=3 ] 04-12 07:42:16.122 26156:26422 I/Bugle: TelephonySubscriptionInfoAsOfLMR1: getActiveSubscriptionInfo(): empty sub info for subscription{id:3} 04-12 07:42:16.126 26156:26422 I/Bugle: SubscriptionUtils.getCanonicalForSelf: self=redacted-pii[12-chars], country= [CONTEXT sub_id=3 ] 04-12 07:42:16.130 26156:26422 I/Bugle: TelephonySubscriptionInfoAsOfLMR1: getActiveSubscriptionInfo(): empty sub info for subscription{id:3} 04-12 07:42:16.133 26156:26398 I/Bugle: processRcsReadinessReason: Current ChatTransportType is: 2, ready: true 04-12 07:42:16.134 26156:26398 I/Bugle: shouldLaunchPostReadyWork is false. Returning from the method 04-12 07:42:16.159 15337:12771 I/ContactsProvider: queryCorpLookupIfNecessary - query for knox took 0 ms elapsed 04-12 07:42:16.165 26156:26422 I/BugleDataModel: ParticipantFullRefresh: Number of participants refreshed: 0 04-12 07:42:16.178 26156:26422 I/BugleDataModel: ActionExecutorImpl: ACTION_RESPONSE_QUEUED_SelfParticipantsRefreshAction 04-12 07:42:16.184 26156:26422 I/Bugle: processRcsReadinessReason: Current ChatTransportType is: 2, ready: true 04-12 07:42:16.188 26156:26422 I/Bugle: processRcsReadinessReason: Current ChatTransportType is: 2, ready: true 04-12 07:42:16.193 26156:26237 I/Bugle: getRawTelephonyPhoneNumber redacted-pii[12-chars] [CONTEXT sub_id=2 ] 04-12 07:42:16.196 26156:26237 I/Bugle: SubscriptionUtils.getCanonicalForSelf: self=redacted-pii[12-chars], country=FR [CONTEXT sub_id=2 ] 04-12 07:42:16.197 26156:26422 I/BugleDataModel: ActionExecutorImpl: ACTION_RESPONSE_QUEUED_SendReportAction 04-12 07:42:16.202 26156:26422 I/Bugle: processRcsReadinessReason: Current ChatTransportType is: 2, ready: true 04-12 07:42:16.202 26156:26237 I/BugleSelfIdentity: Phone number for MyIdentity bd01e789-1a72-4be8-a370-f213881833a1 does not change [CONTEXT sub_id=2 icc_id="89330124364015206690" messaging_identity="redacted-pii[12-chars]" rcs_provisioning_id="redacted-pii[0-chars]" ] 04-12 07:42:16.209 26156:26422 I/BugleDataModel: ActionExecutorImpl: ACTION_RESPONSE_QUEUED_ProcessPendingRevocationsAction 04-12 07:42:16.218 26156:26422 I/BugleJobs: GenericWorkerQueueAction: Bailing early, no work found, no failed work found 04-12 07:42:16.219 26156:26422 I/BugleDataModel: ActionExecutorImpl: ACTION_RESPONSE_QUEUED_GenericWorkerQueueAction 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 90000, delta: -752 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 90001, delta: -219 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99005, delta: -23 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99006, delta: -236 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99007, delta: -24275 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99008, delta: -24198 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99011, delta: -3 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99012, delta: -26264 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99013, delta: -26692 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99014, delta: -22776 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99015, delta: -14782 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99016, delta: -41327 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99017, delta: -27942 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99020, delta: -1585 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99021, delta: -34657 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99022, delta: -957 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99025, delta: -43 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99026, delta: -19 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99027, delta: -63 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99028, delta: -24862 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99029, delta: -26831 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99031, delta: -24 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99033, delta: -30599 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99034, delta: -28683 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99037, delta: -16 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99038, delta: -28771 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99039, delta: -28211 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99042, delta: -34042 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99043, delta: -29485 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99044, delta: -21241 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99045, delta: -23808 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99046, delta: -95 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99047, delta: -507 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99051, delta: -26602 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99052, delta: -26582 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99053, delta: -29533 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99054, delta: -14048 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99055, delta: -25655 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99056, delta: -18561 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99057, delta: -24146 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99058, delta: -22740 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99059, delta: -1491 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99065, delta: -1888 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99068, delta: -20271 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99069, delta: -21435 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99071, delta: -29 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99075, delta: -26660 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99076, delta: -21708 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99077, delta: -226277 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99078, delta: -204573 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99081, delta: -367 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99082, delta: -191 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99083, delta: -27 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99087, delta: -6830 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99092, delta: -3589 04-12 07:42:16.237 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99093, delta: -26957 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99094, delta: -8 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99095, delta: -45 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99100, delta: -3487 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99101, delta: -7914 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99104, delta: -102 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99105, delta: -39 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99106, delta: -25071 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99107, delta: -27671 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99108, delta: -33970 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99109, delta: -37224 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99110, delta: -27437 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99111, delta: -26369 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99112, delta: -185 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99115, delta: -9 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99116, delta: -24671 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99117, delta: -25350 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99118, delta: -3 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99121, delta: -13 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99122, delta: -73 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99123, delta: -26073 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99124, delta: -23773 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99125, delta: -28 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99126, delta: -100 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99127, delta: -36 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99128, delta: -25081 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99129, delta: -25531 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99130, delta: -32135 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99131, delta: -31338 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99132, delta: -20331 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99133, delta: -18415 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99134, delta: -186 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99135, delta: -61 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99136, delta: -100 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99137, delta: -40 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99141, delta: -100 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99142, delta: -25 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99147, delta: -22290 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99148, delta: -24332 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99149, delta: -23 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99150, delta: -396 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99151, delta: -411 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99152, delta: -25758 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99153, delta: -25991 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99155, delta: -91 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99156, delta: -26244 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99157, delta: -26417 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99158, delta: -72 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99162, delta: -25138 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99163, delta: -25421 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99165, delta: -27946 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99166, delta: -30918 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99170, delta: -1479 04-12 07:42:16.238 1509: 2171 E/KernelCpuUidFullTimeReader: Negative delta from freq time for uid: 99171, delta: -1869 04-12 07:42:16.239 1509: 2171 D/CustomizedBinderCallsStatsInternal: reportCpuUsage() : 5% 04-12 07:42:16.239 1509: 1546 I/BinderCallsStats: Collected cpu time : 0us, collected call count : 0 for 138452811 ms 04-12 07:42:16.436 1906: 1906 I/wpa_supplicant: Heartbeat 13834 04-12 07:42:16.599 2784: 2784 D/BoundBrokerSvc: onUnbind: Intent { act=com.google.android.gms.time.trustedtime.service.START dat=chimera-action:/... cmp=com.google.android.gms/.chimera.PersistentApiService } 04-12 07:42:16.631 2784: 2784 D/BoundBrokerSvc: onUnbind: Intent { act=com.google.android.gms.time.trustedtime.singleuserapi.service.START dat=chimera-action:/... cmp=com.google.android.gms/.chimera.PersistentSingleUserInternalApiService } 04-12 07:42:16.705 26442:26442 I/dex2oat32: Using CollectorTypeCMC GC. 04-12 07:42:16.898 26442:26442 I/dex2oat32: Large app, accepted running with swap. 04-12 07:42:16.995 593: 593 D/io_stats: !@ 8,32 r 32563664 675668332 w 9623658 305169712 d 585361 338000444 f 0 774396 iot 20029172 0 th 0 0 0 pt 0 inp 0 0 138471.635 04-12 07:42:16.995 593: 593 D/io_stats: !@ Read_top(KB): binder:1111_2(1111) 12428 loop32(779) 8528 android.vending(14785) 5832 04-12 07:42:16.995 593: 593 D/io_stats: !@ Write_top(KB): -(0) 202444 system_server(1509) 64036 kworker/u16:0(13364) 50316 04-12 07:42:18.065 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43294, isSameBssidAndFreq true 04-12 07:42:18.283 26442:26445 W/dex2oat32: Verification error in void com.google.android.ump.UserMessagingPlatform.loadConsentForm(android.content.Context, com.google.android.ump.UserMessagingPlatform$OnConsentFormLoadSuccessListener, com.google.android.ump.UserMessagingPlatform$OnConsentFormLoadFailureListener) void com.google.android.ump.UserMessagingPlatform.loadConsentForm(android.content.Context, com.google.android.ump.UserMessagingPlatform$OnConsentFormLoadSuccessListener, com.google.android.ump.UserMessagingPlatform$OnConsentFormLoadFailureListener) failed to verify: void com.google.android.ump.UserMessagingPlatform.loadConsentForm(android.content.Context, com.google.android.ump.UserMessagingPlatform$OnConsentFormLoadSuccessListener, com.google.android.ump.UserMessagingPlatform$OnConsentFormLoadFailureListener): [0x1] unexpected non-category 1 return type Conflict 04-12 07:42:18.290 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10053[I] 04-12 07:42:18.291 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10053[I] 04-12 07:42:18.396 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:18.422 1509: 1547 W/ActivityManager: Stopping service due to app idle: u0a300 -1m0s878ms com.facebook.katana/com.facebook.mqtt.service.MqttServiceV2 04-12 07:42:18.522 26442:26446 W/dex2oat32: Method java.lang.Object androidx.compose.runtime.snapshots.SnapshotStateMap.mutate(kotlin.jvm.functions.Function1) failed lock verification and will run slower. 04-12 07:42:18.522 26442:26446 W/dex2oat32: Method void androidx.compose.runtime.snapshots.SnapshotStateMap.update(kotlin.jvm.functions.Function1) failed lock verification and will run slower. 04-12 07:42:18.523 26442:26444 W/dex2oat32: Method boolean androidx.compose.runtime.snapshots.SnapshotStateList.conditionalUpdate(kotlin.jvm.functions.Function1) failed lock verification and will run slower. Common causes for lock verification issues are non-optimized dex code and incorrect proguard optimizations. 04-12 07:42:18.523 26442:26444 W/dex2oat32: Method java.lang.Object androidx.compose.runtime.snapshots.SnapshotStateList.mutate(kotlin.jvm.functions.Function1) failed lock verification and will run slower. 04-12 07:42:18.524 26442:26444 W/dex2oat32: Method void androidx.compose.runtime.snapshots.SnapshotStateList.update(kotlin.jvm.functions.Function1) failed lock verification and will run slower. 04-12 07:42:18.525 26442:26446 W/dex2oat32: Method boolean androidx.compose.runtime.snapshots.SnapshotStateMap.removeIf$runtime_release(kotlin.jvm.functions.Function1) failed lock verification and will run slower. 04-12 07:42:18.947 3379: 4485 I/SDHMS:C: SIOP:: AP:420 BAT:357 USB:354 CHG:411 PA:407 WIFI:400 BLK:0 SUBBAT:0 SKIN:380 SKINF:373 SKINB:380 LRP:380 LRP2:380 LRF2:373 LRB2:380 AP2:379 CHG2:364 MEM2:380 WIFI2:379 SPK2:343 VAP05:423 04-12 07:42:18.997 593: 593 D/io_stats: !@ 8,32 r 32563955 675671840 w 9623658 305169712 d 585361 338000444 f 0 774396 iot 20029544 0 th 0 0 0 pt 0 inp 0 0 138473.638 04-12 07:42:19.549 26442:26444 W/dex2oat32: Verification error in void com.google.android.gms.ads.mediation.customevent.CustomEventAdapter.showInterstitial() void com.google.android.gms.ads.mediation.customevent.CustomEventAdapter.showInterstitial() failed to verify: void com.google.android.gms.ads.mediation.customevent.CustomEventAdapter.showInterstitial(): [0x1] unexpected non-category 1 return type Conflict 04-12 07:42:19.577 1188: 1188 D/AALLightSensor: oldLux=2 [SA:2 LA:2] newLux=2 (oriLux: 3) 04-12 07:42:19.675 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:20.069 1300: 1300 D/connsyslogger: Open FIFO for close 04-12 07:42:20.342 1509: 1662 I/ActivityManager: Changes in 99934 8 to 8, 8 to 0 04-12 07:42:20.342 1509: 1662 W/ProcessStats: Tracking association SourceState{4909c35 com.google.android.gms.persistent/10220 ImpBg #1188616} whose proc state 6 is better than process ProcessState{500fd93 com.google.android.gms/10220 pkg=com.google.android.gms} proc state 14 (171 skipped) 04-12 07:42:20.343 1509: 1662 D/ActivityManager: Received SERVICE intent 0x6099d13 Key{startService pkg=com.google.android.gms/com.google.android.gms.auth_authzen__phone intent=act=com.google.android.gms.auth.authzen.cryptauth.DEVICE_STATE_CHECK_DELAY_COMPLETE cat=[targeted_intent_op_prefix:.auth.authzen.cryptauth.DeviceStateSyncManager$CheckStateEventIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService flags=0x2000000 u=0} requestCode=0 from uid 1000 04-12 07:42:20.364 8850:26448 I/Authzen: [DeviceStateSyncManager] The server is in sync with current state. Nothing to do 04-12 07:42:20.955 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:20.998 593: 593 D/io_stats: !@ 8,32 r 32564063 675673004 w 9623666 305169740 d 585362 338002492 f 0 774397 iot 20029748 0 th 0 0 0 pt 0 inp 0 0 138475.638 04-12 07:42:20.999 593: 593 D/io_stats: !@ Read_top(KB): dex2oat(26442) 2640 facebook.katana(25395) 1024 loop20(745) 240 04-12 07:42:20.999 593: 593 D/io_stats: !@ Write_top(KB): -(0) 16 gle.android.gms(8850) 8 .apps.messaging(26156) 8 04-12 07:42:21.077 1509: 3955 D/SemWifiUsabilityStatsMonitor: onWifiUsabilityStats - seqNum 43295, isSameBssidAndFreq true 04-12 07:42:21.078 1943: 1943 D/StatusBarIconController: ignoring old pipeline callback because the new wifi icon is enabled 04-12 07:42:21.080 1943: 2242 D/Tile.WifiTile: handleUpdateState isTransient=false transientEnabling =false cb.isTransient=false state.state = 2 mStateBeforeClick.value =false enabled =true 04-12 07:42:21.080 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:21.089 1943: 2246 I/gralloc4: @set_metadata: update dataspace from GM (0x00000000 -> 0x08010000) 04-12 07:42:21.092 948: 948 I/SurfaceFlinger: SFWD update time=138475732392868 04-12 07:42:21.092 879: 1119 I/hwcomposer: [DRMDEV] (0) failed to waitNextVsync: -1 04-12 07:42:21.092 948: 948 I/BufferQueueProducer: [StatusBar$_1943#88](this:0xb40000776697bba0,id:-1,api:0,p:-1,c:948) queueBuffer: fps=0.11 dur=9017.59 max=9017.59 min=9017.59 04-12 07:42:21.093 948: 948 D/SurfaceFlinger: GPIS:: requestGPISForClientComposition 04-12 07:42:21.095 879: 879 I/hwcomposer: [HWCDisplay] [Display_0 (type:1)] fps:0.221866,dur:9014.46,max:8883.54,min:130.92 04-12 07:42:21.212 879: 1114 I/hwcomposer: HWC] (0)fire a callback of refresh to SF[4: 04-12 07:42:21.223 948: 948 I/BufferQueueProducer: [FramebufferSurface](this:0xb4000077668856d0,id:-1,api:1,p:948,c:948) queueBuffer: fps=0.11 dur=9012.63 max=9012.63 min=9012.63 04-12 07:42:21.247 948: 1112 I/VSyncReactor: Current= 90, Period= 90, Distance= 90 04-12 07:42:21.719 14785:14841 I/Finsky: [133] lob.run(53): AIM: AppInfoManager-Perf > Destroying AppInfoManager ... 04-12 07:42:22.028 26442:26442 I/dex2oat32: dex2oat took 7.420s (17.443s cpu) (threads: 4) arena alloc=0B (0B) java alloc=48MB (50580408B) native alloc=5197KB (5322128B) free=842KB (862832B) swap=16MB (16777216B) 04-12 07:42:22.117 25792:25795 I/artd: dex2oat returned code 0 04-12 07:42:22.134 1509: 1590 I/ArtService: Dexopt result: [packageName = com.appadvisory.drawclimber] DexContainerFileDexoptResult{dexContainerFile=/data/app/~~fD0DuKv6tf9aOEnSWXbDzQ==/com.appadvisory.drawclimber-HlnVY1CHm1KZkupzCJb8mg==/base.apk, primaryAbi=true, abi=arm64-v8a, actualCompilerFilter=verify, status=PERFORMED, dex2oatWallTimeMillis=7723, dex2oatCpuTimeMillis=17620, sizeBytes=71110544, sizeBeforeBytes=0, extendedStatusFlags=[]} 04-12 07:42:22.149 1509: 1590 I/BackupManagerService: [UserID:0] restoreAtInstall pkg=com.appadvisory.drawclimber token=675 restoreSet=0 04-12 07:42:22.151 1509: 1590 V/BackupManagerService: [UserID:0] Finishing install immediately 04-12 07:42:22.152 1509: 1590 D/PackageManager: isLocaleOptimizedPackage() - Non optimized app: com.appadvisory.drawclimber. Proceed with normal install 04-12 07:42:22.174 863: 870 E/statsd: Predicate -6150195365450938007 dropping data for dimension key (27)0x10000->10053[I] 04-12 07:42:22.174 863: 870 E/statsd: Predicate 7729334320784921827 dropping data for dimension key (27)0x10000->10053[I] 04-12 07:42:22.241 1943: 1943 D/StatusBarIconController: ignoring old pipeline callbacks, because the new mobile icons are enabled 04-12 07:42:22.254 1509: 1590 D/AccessibilityManagerService: currentTargets : [] targetsFromSetting : [] 04-12 07:42:22.254 1509: 1590 D/AccessibilityManagerService: componentId : null userState.getTargetAssignedToAccessibilityButton() : null 04-12 07:42:22.254 1509: 1590 D/AccessibilityManagerService: readAccessibilityDirectAccessSettingLocked currentTargets : [] targetsFromSetting : [] 04-12 07:42:22.254 1509: 1590 D/KNOX_MDM_SettingsProvider: isChangeAllowed() : name = accessibility_enabled 04-12 07:42:22.255 1509: 1590 D/WindowMagnificationMgr: requestConnection :false mConnectionState : 3 04-12 07:42:22.255 1509: 1590 W/WindowMagnificationMgr: requestConnection duplicated request: connect=false, mConnectionState=DISCONNECTED 04-12 07:42:22.255 1509: 1590 I/PackageManager: result of install: 1{1364476} 04-12 07:42:22.261 1509: 1590 D/PackageInstallerSession: Marking session 1452981204 as applied 04-12 07:42:22.262 1509: 1591 I/PackageInstallerSession: result of session: 1{1452981204}, Session installed 04-12 07:42:22.271 1509: 1590 D/SystemFileBackupManager: Already scheduled 04-12 07:42:22.279 1509: 1619 D/OverlayManager: reconcileSettingsForPackage pkgName=com.appadvisory.drawclimber userId=0 04-12 07:42:22.279 1509: 1619 I/OverlayManager: updateOverlaysForTarget() called with: targetPackage = [com.appadvisory.drawclimber], userId = [0], flags = [0] 04-12 07:42:22.279 2420:13069 I/HoneySpace.InstallSessionSourceImpl: onFinished 1452981204, true 04-12 07:42:22.279 1509: 1619 D/OverlayManager: Writing overlay settings 04-12 07:42:22.283 1509: 1619 D/OverlayManager: Update package manager about changed overlays 04-12 07:42:22.289 1509: 1619 D/OverlayManager: -> Updating overlay: target=com.appadvisory.drawclimber overlays=[OverlayPaths { resourceDirs = [], overlayPaths = [] }] userId=0 04-12 07:42:22.300 1917: 1917 D/CarrierSvcBindHelper: onPackageAdded: com.appadvisory.drawclimber 04-12 07:42:22.301 1917: 1917 D/CarrierSvcBindHelper: No carrier app for: 0 04-12 07:42:22.301 1917: 1917 D/CarrierSvcBindHelper: No carrier app for: 1 04-12 07:42:22.302 1509: 1509 D/SGM:GameManager: identifyGamePackage. com.appadvisory.drawclimber, mCurrentUserId: 0, callerUserId: 0, callingMethodInfo: com.samsung.android.game.SemGameManager.isGamePackage(SemGameManager.java:109) 04-12 07:42:22.303 1509: 1509 D/SGM:PkgDataHelper: getGamePkgData(). com.appadvisory.drawclimber 04-12 07:42:22.303 1509: 1509 D/SGM:SemGameManager: isGamePackage(), pkgName=com.appadvisory.drawclimber, ret=true 04-12 07:42:22.303 641:29489 E/keystore2: system/security/keystore2/src/keystore2_main.rs:73 - !@ [SQLITE3] 30: open db: flags=6, /data/misc/keystore/vpnprofilestore.sqlite 04-12 07:42:22.304 1509: 1509 I/AudioGameManager: g_game_uid=26|10562|10304|10457|10458|10522|10538|10539|10619|10620|10621|10701|10707|10709|10715|10716|10724|10725|10749|10837|10843|10907|10936|11246|11752|11915|11928 04-12 07:42:22.305 1509: 1803 I/AppWidgetServiceImpl: Received broadcast: android.intent.action.PACKAGE_ADDED, Updates all providers with com.appadvisory.drawclimber, userId: 0 04-12 07:42:22.305 641:26456 E/keystore2: system/security/keystore2/src/keystore2_main.rs:73 - !@ [SQLITE3] 30: open db: flags=6, /data/misc/keystore/vpnprofilestore.sqlite 04-12 07:42:22.306 641:26456 E/keystore2: system/security/keystore2/src/keystore2_main.rs:73 - !@ [SQLITE3] 30: close db /data/misc/keystore/vpnprofilestore.sqlite. 04-12 07:42:22.306 641:29489 E/keystore2: system/security/keystore2/src/keystore2_main.rs:73 - !@ [SQLITE3] 30: close db /data/misc/keystore/vpnprofilestore.sqlite. 04-12 07:42:22.309 1509: 1769 D/CompatibilityChangeReporter: Compat change id reported: 151105954; UID 1000; state: ENABLED 04-12 07:42:22.310 1917: 1917 I/VvmPkgInstalledRcvr: onReceive(): android.intent.action.PACKAGE_ADDED 04-12 07:42:22.310 1509: 1769 E/AppOps: attributionTag VCN not declared in manifest of android 04-12 07:42:22.310 1917: 2273 D/ImsResolver: maybeAddedImsService, packageName: com.appadvisory.drawclimber 04-12 07:42:22.311 2375: 2375 D/RegisteredNfcFServicesCache: Service unchanged, not updating 04-12 07:42:22.311 1509: 1509 D/AppSearchAppsIndexerManagerS: userid in package receiver: 11928 04-12 07:42:22.311 1917: 1917 I/VvmPkgInstalledRcvr: packageName: com.appadvisory.drawclimber, systemDialer: com.samsung.android.dialer 04-12 07:42:22.312 1509: 1867 I/SdkSandboxManager: No SDKs used. Skipping SDK data reconcilation for CallingInfo{mUid=11928, mPackageName='com.appadvisory.drawclimber, mAppProcessToken='null'} 04-12 07:42:22.312 1509: 1854 D/SGM:GameManager: identifyGamePackage. com.appadvisory.drawclimber, mCurrentUserId: 0, callerUserId: 0, callingMethodInfo: com.samsung.android.game.SemGameManager.isGamePackage(SemGameManager.java:109) 04-12 07:42:22.313 1509: 1854 D/SGM:PkgDataHelper: getGamePkgData(). com.appadvisory.drawclimber 04-12 07:42:22.313 1509: 1854 D/SGM:SemGameManager: isGamePackage(), pkgName=com.appadvisory.drawclimber, ret=true 04-12 07:42:22.313 1509: 1769 E/AppOps: attributionTag VCN not declared in manifest of android 04-12 07:42:22.316 1509: 1769 E/AppOps: attributionTag VCN not declared in manifest of android 04-12 07:42:22.318 1509: 2707 I/Telecom:SamsungTelecomServiceImpl: getCallCapablePhoneAccounts - includeDisabledAccounts : false / callingPackage : com.android.phone / callingUser : UserHandle{0} / hasCrossUserAccess : true 04-12 07:42:22.319 1917: 1917 I/VvmPkgInstalledRcvr: capablePhoneAccounts : [ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, 2, UserHandle{0}] 04-12 07:42:22.319 1917: 1917 I/VvmPkgInstalledRcvr: capablePhoneAccounts.size : 1 04-12 07:42:22.320 1509: 2752 I/Telecom:SamsungTelecomServiceImpl: getCallCapablePhoneAccounts - includeDisabledAccounts : false / callingPackage : com.android.phone / callingUser : UserHandle{0} / hasCrossUserAccess : true 04-12 07:42:22.320 1917: 1917 I/VvmPkgInstalledRcvr: phoneAccountHandle : ComponentInfo{com.android.phone/com.android.services.telephony.TelephonyConnectionService}, 2, UserHandle{0} 04-12 07:42:22.321 1917: 1917 I/VvmPkgInstalledRcvr: pinnedTelephonyManager : android.telephony.TelephonyManager@168955f 04-12 07:42:22.329 1509: 1854 D/SemWifiTransportLayerMonitor.TcpMonitorHandler: MSG_SAVE_PACKAGE_INFO 04-12 07:42:22.330 1917: 1917 I/VvmPkgInstalledRcvr: pinnedTelephonyManager : subscriberId: 208*********971 04-12 07:42:22.330 1509: 1854 D/SemWifiTransportLayerFileManager: saveWifiPackageInfoToFile 04-12 07:42:22.331 1509: 1854 D/SemWifiTransportLayerFileManager: writeWifiPackageInfoList