lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]
Message-ID: <CAMi1Hd3H2k1J8hJ6e-Miy5+nVDNzv6qQ3nN-9929B0GbHJkXEg@mail.gmail.com>
Date:   Tue, 18 Oct 2022 21:35:16 +0530
From:   Amit Pundir <amit.pundir@...aro.org>
To:     Catalin Marinas <catalin.marinas@....com>
Cc:     Will Deacon <will@...nel.org>,
        Linus Torvalds <torvalds@...ux-foundation.org>,
        linux-arm-kernel@...ts.infradead.org, linux-kernel@...r.kernel.org,
        Bjorn Andersson <andersson@...nel.org>,
        Dmitry Baryshkov <dmitry.baryshkov@...aro.org>,
        Robin Murphy <robin.murphy@....com>
Subject: Re: [GIT PULL] arm64 updates for 6.1-rc1

On Wed, 12 Oct 2022 at 17:24, Catalin Marinas <catalin.marinas@....com> wrote:
>
> Hi Amit,
>
> On Sat, Oct 08, 2022 at 08:28:26PM +0530, Amit Pundir wrote:
> > On Wed, 5 Oct 2022 at 20:11, Catalin Marinas <catalin.marinas@....com> wrote:
> > > Will Deacon (2):
> > >       arm64: dma: Drop cache invalidation from arch_dma_prep_coherent()
> >
> > Hi Will,
> >
> > This patch broke AOSP on Dragonboard 845c (SDM845). I don't see any
> > relevant crash in the attached log and device silently reboots into
> > USB crash dump mode. The crash is fairly reproducible on db845c. I
> > could trigger it twice in 5 reboots and it always crash at the same
> > point during the boot process. Reverting this patch fixes the crash.
> >
> > I'm happy to test run any debug patche(s), that would help narrow
> > down this breakage.
>
> Cc'ing Robin, maybe he has a better idea (that's commit c44094eee32f).
> Architecturally the change shouldn't make any difference since the cache
> lines can be brought in via the linear mapping at any point. It's just
> less likely to hit a real bug (software or hardware). It's also possible
> that arch_dma_prep_coherent() is used outside the DMA API (if you have
> out of tree drivers).

Hi Catalin,

I can reproduce this crash on vanilla v6.1-rc1 as well with no
out-of-tree drivers.

>
> Leaving the original log in place for Robin. A question I have, with a
> successful boot, what's normally after the bpfloader lines are printed?
> We should try to pinpoint which device/driver causes this. It looks like
> it's well into user-space at that point (graphics about to start?)
>

Yes the device is well into user-space at this point with file-system
mounted. And it always crashes while it is busy bringing up remoteproc
(modem) and running bpf programs.

[   19.535003][    T1] init: starting service 'tqftpserv'...
[   19.579617][    T1] init: starting service 'rmtfs'...
[   19.588578][    T1] init: processing action (load_bpf_programs)
from (/system/etc/init/bpfloader.rc:17)
[   19.596465][  T456] remoteproc remoteproc0: powering up 4080000.remoteproc
[   19.600240][    T1] init: starting service 'bpfloader'...
[   19.608071][  T456] remoteproc remoteproc0: Booting fw image
qcom/sdm845/mba.mbn, size 242400
[   19.616901][    T1] init: SVC_EXEC service 'bpfloader' pid 457 (uid
0 gid 0+7 context default) started; waiting...
[   19.699862][  T457] bpfloader:
/apex/com.android.tethering/etc/flag/out-of-process exists.
[   19.710798][  T457] LibBpfLoader: Section bpfloader_min_ver value is 2 [0x2]
[   19.717980][  T457] LibBpfLoader: Section bpfloader_max_ver value
is 25 [0x19]
[   19.725375][  T457] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   19.732806][  T456] qcom-q6v5-mss 4080000.remoteproc: MBA booted
without debug policy, loading mpss
[   19.732996][  T457] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   19.749603][  T457] LibBpfLoader: BpfLoader version 0x0001c
ignoring ELF object /apex/com.android.tethering/etc/bpf/test.o with
max ver 0x00019
[   19.762621][  T457] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/test.o
        <... ...crash and reboot into bootloader here... ...>


In case of a successful boot, bpfloader exits successfully, modem
boots up fine and standard AOSP services start kicking in.

[   19.242267][    T1] init: starting service 'tqftpserv'...
[   19.272100][    T1] init: starting service 'rmtfs'...
[   19.280426][    T1] init: processing action (load_bpf_programs)
from (/system/etc/init/bpfloader.rc:17)
[   19.288715][  T448] remoteproc remoteproc0: powering up 4080000.remoteproc
[   19.290737][    T1] init: starting service 'bpfloader'...
[   19.299421][  T448] remoteproc remoteproc0: Booting fw image
qcom/sdm845/mba.mbn, size 242400
[   19.306169][    T1] init: SVC_EXEC service 'bpfloader' pid 449 (uid
0 gid 0+7 context default) started; waiting...
[   19.325297][  T449] bpfloader:
/apex/com.android.tethering/etc/flag/out-of-process exists.
[   19.335554][  T449] LibBpfLoader: Section bpfloader_min_ver value is 2 [0x2]
[   19.342773][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 25 [0x19]
[   19.350194][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   19.357886][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   19.365476][  T449] LibBpfLoader: BpfLoader version 0x0001c
ignoring ELF object /apex/com.android.tethering/etc/bpf/test.o with
max ver 0x00019
[   19.378519][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/test.o
[   19.391515][  T449] LibBpfLoader: Section bpfloader_min_ver value is 2 [0x2]
[   19.397239][  T448] qcom-q6v5-mss 4080000.remoteproc: MBA booted
without debug policy, loading mpss
[   19.398678][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 25 [0x19]
[   19.415184][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   19.422825][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   19.430424][  T449] LibBpfLoader: BpfLoader version 0x0001c
ignoring ELF object /apex/com.android.tethering/etc/bpf/offload.o with
max ver 0x00019
[   19.443723][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/offload.o
[   19.453137][  T449] LibBpfLoader: Section bpfloader_min_ver value
is 25 [0x19]
[   19.460494][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   19.468349][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   19.475903][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   19.483450][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object /apex/com.android.tethering/etc/bpf/test@....o
with ver [0x00019,0x10000)
[   19.527906][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_test_tether_downstream6_map id 1
[   19.536802][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_test_bitmap id 2
[   19.545451][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_test_xdp_drop_ipv4_udp_ether id 1
[   19.554598][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/test@....o
[   19.565372][  T449] LibBpfLoader: Section bpfloader_min_ver value
is 25 [0x19]
[   19.572672][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   19.580511][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   19.588069][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   19.595611][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object
/apex/com.android.tethering/etc/bpf/offload@....o with ver
[0x00019,0x10000)
[   19.629859][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_error_map id 3
[   19.636219][  T448] remoteproc remoteproc0: remote processor
4080000.remoteproc is now up
[   19.646726][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_stats_map id 4
[   19.646817][  T448] rmtfs (448) used greatest stack depth: 9952 bytes left
[   19.662274][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_limit_map id 5
[   19.670941][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_downstream6_map id 6
[   19.680189][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_downstream64_map id 7
[   19.689463][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_upstream6_map id 8
[   19.698492][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_downstream4_map id 9
[   19.707692][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_upstream4_map id 10
[   19.762291][  T449] LibBpfLoader: map
/sys/fs/bpf/tethering/map_offload_tether_dev_map id 11
[   19.781943][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_downstream6_ether
id 2
[   19.793483][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_upstream6_ether id
3
[   19.804834][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_downstream6_rawip
id 4
[   19.816326][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_upstream6_rawip id
5
[   19.828262][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_downstream4_rawip
id 6
[   19.840313][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_upstream4_rawip id
7
[   19.852089][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_downstream4_ether
id 8
[   19.864041][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_schedcls_tether_upstream4_ether id
9
[   19.875042][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_xdp_tether_downstream_ether id 10
[   19.885521][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_xdp_tether_downstream_rawip id 11
[   19.896037][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_xdp_tether_upstream_ether id 12
[   19.906437][  T449] LibBpfLoader: prog
/sys/fs/bpf/tethering/prog_offload_xdp_tether_upstream_rawip id 13
[   19.916186][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/offload@....o
[   19.927346][  T449] LibBpfLoader: Section bpfloader_min_ver value is 13 [0xd]
[   19.934578][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   19.942419][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   19.949981][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   19.957519][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object
/apex/com.android.tethering/etc/bpf/netd_shared/netd.o with ver
[0x0000d,0x10000)
[   19.981108][  T449] LibBpfLoader: map configuration_map
selinux_context [fs_bpf_netd_readonly            ] -> 5 ->
'fs_bpf_netd_readonly' (netd_readonly/)
[   19.995188][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_configuration_map id 12
[   20.004173][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_cookie_tag_map id 13
[   20.012604][  T449] LibBpfLoader: map uid_counterset_map
selinux_context [fs_bpf_net_shared               ] -> 4 ->
'fs_bpf_net_shared' (net_shared/)
[   20.026214][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_uid_counterset_map id 14
[   20.034984][  T449] LibBpfLoader: map app_uid_stats_map
selinux_context [fs_bpf_net_shared               ] -> 4 ->
'fs_bpf_net_shared' (net_shared/)
[   20.048710][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_app_uid_stats_map id 15
[   20.057599][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_stats_map_A id 16
[   20.065765][  T449] LibBpfLoader: map stats_map_B selinux_context
[fs_bpf_netd_readonly            ] -> 5 -> 'fs_bpf_netd_readonly'
(netd_readonly/)
[   20.079363][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_stats_map_B id 17
[   20.087521][  T449] LibBpfLoader: map iface_stats_map
selinux_context [fs_bpf_net_shared               ] -> 4 ->
'fs_bpf_net_shared' (net_shared/)
[   20.100823][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_iface_stats_map id 18
[   20.109330][  T449] LibBpfLoader: map uid_owner_map selinux_context
[fs_bpf_net_shared               ] -> 4 -> 'fs_bpf_net_shared'
(net_shared/)
[   20.122473][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_uid_owner_map id 19
[   20.130897][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_uid_permission_map id 20
[   20.139676][  T449] LibBpfLoader: map iface_index_name_map
selinux_context [fs_bpf_net_shared               ] -> 4 ->
'fs_bpf_net_shared' (net_shared/)
[   20.153413][  T449] LibBpfLoader: map
/sys/fs/bpf/netd_shared/map_netd_iface_index_name_map id 21
[   20.163738][  T449] LibBpfLoader: prog cgroupskb_ingress_stats
selinux_context [fs_bpf_netd_readonly            ] -> 5 ->
'fs_bpf_netd_readonly' (netd_readonly/)
[   20.180672][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_cgroupskb_ingress_stats id 14
[   20.190075][  T449] LibBpfLoader: prog cgroupskb_egress_stats
selinux_context [fs_bpf_netd_readonly            ] -> 5 ->
'fs_bpf_netd_readonly' (netd_readonly/)
[   20.206105][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_cgroupskb_egress_stats id 15
[   20.216274][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_skfilter_egress_xtbpf id 16
[   20.226376][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_skfilter_ingress_xtbpf id 17
[   20.235683][  T449] LibBpfLoader: prog schedact_ingress_account
selinux_context [fs_bpf_net_shared               ] -> 4 ->
'fs_bpf_net_shared' (net_shared/)
[   20.250698][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_schedact_ingress_account id 18
[   20.261050][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_skfilter_allowlist_xtbpf id 19
[   20.271359][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_skfilter_denylist_xtbpf id 20
[   20.280757][  T449] LibBpfLoader: prog cgroupsock_inet_create
selinux_context [fs_bpf_netd_readonly            ] -> 5 ->
'fs_bpf_netd_readonly' (netd_readonly/)
[   20.296020][  T449] LibBpfLoader: prog
/sys/fs/bpf/netd_shared/prog_netd_cgroupsock_inet_create id 21
[   20.305386][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/netd_shared/netd.o
[   20.315965][  T449] LibBpfLoader: Section bpfloader_min_ver value is 13 [0xd]
[   20.323187][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   20.331029][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   20.338590][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   20.346129][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object
/apex/com.android.tethering/etc/bpf/net_shared/dscpPolicy.o with ver
[0x0000d,0x10000)
[   20.368275][  T449] LibBpfLoader: map
/sys/fs/bpf/net_shared/map_dscpPolicy_socket_policy_cache_map id 22
[   20.377973][  T449] LibBpfLoader: map
/sys/fs/bpf/net_shared/map_dscpPolicy_ipv4_dscp_policies_map id 23
[   20.387561][  T449] LibBpfLoader: map
/sys/fs/bpf/net_shared/map_dscpPolicy_ipv6_dscp_policies_map id 24
[   20.410850][  T449] LibBpfLoader: prog
/sys/fs/bpf/net_shared/prog_dscpPolicy_schedcls_set_dscp_ether id 22
[   20.420760][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/net_shared/dscpPolicy.o
[   20.432580][  T449] LibBpfLoader: Section bpfloader_min_ver value is 13 [0xd]
[   20.439803][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   20.447640][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   20.455200][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   20.462739][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object
/apex/com.android.tethering/etc/bpf/net_shared/block.o with ver
[0x0000d,0x10000)
[   20.505305][  T449] LibBpfLoader: map
/sys/fs/bpf/net_shared/map_block_blocked_ports_map id 25
[   20.515150][  T449] LibBpfLoader: prog
/sys/fs/bpf/net_shared/prog_block_bind4_block_port id 23
[   20.524754][  T449] LibBpfLoader: prog
/sys/fs/bpf/net_shared/prog_block_bind6_block_port id 24
[   20.533575][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/net_shared/block.o
[   20.544256][  T449] LibBpfLoader: Section bpfloader_min_ver value is 13 [0xd]
[   20.551477][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   20.559313][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   20.566875][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   20.574412][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object
/apex/com.android.tethering/etc/bpf/net_shared/clatd.o with ver
[0x0000d,0x10000)
[   20.617474][  T449] LibBpfLoader: map
/sys/fs/bpf/net_shared/map_clatd_clat_ingress6_map id 26
[   20.626210][  T449] LibBpfLoader: map
/sys/fs/bpf/net_shared/map_clatd_clat_egress4_map id 27
[   20.636225][  T449] LibBpfLoader: prog
/sys/fs/bpf/net_shared/prog_clatd_schedcls_ingress6_clat_ether id 25
[   20.647124][  T449] LibBpfLoader: prog
/sys/fs/bpf/net_shared/prog_clatd_schedcls_ingress6_clat_rawip id 26
[   20.657696][  T449] LibBpfLoader: prog
/sys/fs/bpf/net_shared/prog_clatd_schedcls_egress4_clat_ether id 27
[   20.668425][  T449] LibBpfLoader: prog
/sys/fs/bpf/net_shared/prog_clatd_schedcls_egress4_clat_rawip id 28
[   20.678202][  T449] bpfloader: Loaded object:
/apex/com.android.tethering/etc/bpf/net_shared/clatd.o
[   20.703175][  T449] LibBpfLoader: Section bpfloader_min_ver value
is 28 [0x1c]
[   20.710475][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   20.718306][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   20.725864][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   20.733404][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object /system/etc/bpf/gpuWork.o with ver
[0x0001c,0x10000)
[   20.746152][  T449] LibBpfLoader: map
/sys/fs/bpf/map_gpuWork_gpu_work_map id 28
[   20.753644][  T449] LibBpfLoader: map
/sys/fs/bpf/map_gpuWork_gpu_work_global_data id 29
[   20.762876][  T449] LibBpfLoader: prog
/sys/fs/bpf/prog_gpuWork_tracepoint_power_gpu_work_period id 29
[   20.772275][  T449] bpfloader: Loaded object: /system/etc/bpf/gpuWork.o
[   20.779516][  T449] LibBpfLoader: Section bpfloader_min_ver value
is 28 [0x1c]
[   20.786846][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   20.794688][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   20.802245][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   20.809784][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object /system/etc/bpf/gpuMem.o with ver
[0x0001c,0x10000)
[   20.849720][  T449] LibBpfLoader: map
/sys/fs/bpf/map_gpuMem_gpu_mem_total_map id 30
[   20.858655][  T449] LibBpfLoader: prog
/sys/fs/bpf/prog_gpuMem_tracepoint_gpu_mem_gpu_mem_total id 30
[   20.867977][  T449] bpfloader: Loaded object: /system/etc/bpf/gpuMem.o
[   20.874900][  T449] LibBpfLoader: Section bpfloader_min_ver value
is 28 [0x1c]
[   20.882196][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   20.890031][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   20.897583][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   20.905124][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object /system/etc/bpf/fuseMedia.o with ver
[0x0001c,0x10000)
[   20.917800][  T449] LibBpfLoader: No maps section could be found in
elf object
[   20.925097][  T449] bpfloader: Loaded object: /system/etc/bpf/fuseMedia.o
[   20.932463][  T449] LibBpfLoader: Section bpfloader_min_ver value
is 28 [0x1c]
[   20.939774][  T449] LibBpfLoader: Section bpfloader_max_ver value
is 65536 [0x10000]
[   20.947610][  T449] LibBpfLoader: Section size_of_bpf_map_def value
is 120 [0x78]
[   20.955166][  T449] LibBpfLoader: Section size_of_bpf_prog_def
value is 92 [0x5c]
[   20.962702][  T449] LibBpfLoader: BpfLoader version 0x0001c
processing ELF object /system/etc/bpf/timeInState.o with ver
[0x0001c,0x10000)
[   20.982983][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_total_time_in_state_map id 31
[   20.992893][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_uid_time_in_state_map id 32
[   21.002295][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_uid_concurrent_times_map id 33
[   21.011230][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_uid_last_update_map id 34
[   21.019706][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_cpu_last_update_map id 35
[   21.028159][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_cpu_last_pid_map id 36
[   21.036347][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_cpu_policy_map id 37
[   21.044356][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_policy_freq_idx_map id 38
[   21.052856][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_freq_to_idx_map id 39
[   21.060973][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_nr_active_map id 40
[   21.068895][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_policy_nr_active_map id 41
[   21.077437][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_pid_tracked_hash_map id 42
[   21.085969][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_pid_tracked_map id 43
[   21.094099][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_pid_task_aggregation_map id 44
[   21.103893][  T449] LibBpfLoader: map
/sys/fs/bpf/map_timeInState_pid_time_in_state_map id 45
[   21.116868][  T449] LibBpfLoader: prog
/sys/fs/bpf/prog_timeInState_tracepoint_sched_sched_switch id 31
[   21.127324][  T449] LibBpfLoader: prog
/sys/fs/bpf/prog_timeInState_tracepoint_power_cpu_frequency id 32
[   21.137979][  T449] LibBpfLoader: prog
/sys/fs/bpf/prog_timeInState_tracepoint_sched_sched_process_free id 33
[   21.148047][  T449] bpfloader: Loaded object: /system/etc/bpf/timeInState.o
[   21.157656][    T1] init: Service 'bpfloader' (pid 449) exited with
status 0 waiting took 1.853000 seconds
[   21.167396][    T1] init: Sending signal 9 to service 'bpfloader'
(pid 449) process group...
[   21.176037][    T1] libprocessgroup: Successfully killed process
cgroup uid 0 pid 449 in 0ms
[   21.186578][    T1] init: processing action
(ro.crypto.state=encrypted && ro.crypto.type=file && zygote-start)
from (/system/etc/init/hw/init.rc:1060)
[   21.200189][    T1] init:
start_waiting_for_property("odsign.verification.done", "1"): already
set
[   21.209345][    T1] init: Command 'exec_start
update_verifier_nonencrypted' action=ro.crypto.state=encrypted &&
ro.crypto.type=file && zygote-start (/system/etc/init/hw/init.rc:1063)
took 0ms and failed: Service not found
[   21.231829][    T1] init: starting service 'statsd'...
[   21.237303][    T1] init: Created socket '/dev/socket/statsdw',
mode 222, user 1066, group 1066
[   21.260054][    T1] init: starting service 'netd'...
[   21.265386][    T1] init: Created socket '/dev/socket/dnsproxyd',
mode 660, user 0, group 3003
[   21.274241][    T1] init: Created socket '/dev/socket/mdns', mode
660, user 0, group 1000
[   21.282628][    T1] init: Created socket '/dev/socket/fwmarkd',
mode 660, user 0, group 3003
[   21.294432][    T1] init: starting service 'zygote'...
[   21.299968][    T1] init: Created socket '/dev/socket/zygote', mode
660, user 0, group 1000
[   21.308548][    T1] init: Created socket
'/dev/socket/usap_pool_primary', mode 660, user 0, group 1000
[   21.320892][    T1] init: starting service 'zygote_secondary'...
[   21.327157][    T1] init: Created socket
'/dev/socket/zygote_secondary', mode 660, user 0, group 1000
[   21.336591][    T1] init: Created socket
'/dev/socket/usap_pool_secondary', mode 660, user 0, group 1000
[   21.348788][    T1] init: processing action (zygote-start) from
(/vendor/etc/init/init.db845c.rc:38)
[   21.360963][    T1] init: processing action
(firmware_mounts_complete) from (/system/etc/init/hw/init.rc:513)
[   21.371050][    T1] init: processing action (early-boot) from
(/system/etc/init/installd.rc:5)
[   21.385885][    T1] init: processing action (early-boot) from
(/vendor/etc/init/init.db845c.rc:30)
[   21.395343][    T1] init: Command 'mount debugfs debugfs
/sys/kernel/debug' action=early-boot
(/vendor/etc/init/init.db845c.rc:31) took 0ms and failed: mount()
failed: Device or resource busy
[   21.413899][    T1] init: processing action (boot) from
(/system/etc/init/hw/init.rc:1074)
[   21.424621][    T1] init: Command 'write
/dev/sys/block/by-name/rootdisk/queue/discard_max_bytes 134217728'
action=boot (/system/etc/init/hw/init.rc:1120) took 0ms and failed:
Unable to write to file
'/dev/sys/block/by-name/rootdisk/queue/discard_max_bytes': open()
failed: Permission denied
[   21.424733][  T336] type=1400 audit(27.187:4): avc: denied { write
} for comm="init" name="discard_max_bytes" dev="sysfs" ino=40490
scontext=u:r:init:s0 tcontext=u:object_r:sysfs:s0 tclass=file
permissive=0
[   21.451424][    T1] init: Command 'verity_update_state' action=boot
(/system/etc/init/hw/init.rc:1179) took 0ms and failed:
fs_mgr_load_verity_state() failed
[   21.483352][    T1] init: starting service 'hidl_memory'...
[   21.506462][    T1] init: starting service 'vendor.audio-hal'...
[   21.515157][    T1] init: starting service 'btlinux-1.1'...
[   21.544305][    T1] init: starting service
'vendor.camera-provider-2-4-ext'...
[   21.554697][    T1] init: starting service 'vendor.cas-hal-1-2'...
[   21.563521][    T1] init: starting service 'vendor.gatekeeper-1-0'...
[   21.572369][    T1] init: starting service 'vendor.graphics.allocator-4-0'...
[   21.581826][    T1] init: starting service 'vendor.hwcomposer-2-3'...
[   21.590550][    T1] init: starting service 'health-hal-2-1'...
[   21.598974][    T1] init: starting service 'vendor.power-default'...
[   21.607702][    T1] init: starting service 'vendor.power.stats-default'...
[   21.616988][    T1] init: Command 'class_start hal' action=boot
(/system/etc/init/hw/init.rc:1182) took 133ms and succeeded
[   21.628257][    T1] init: service 'ueventd' requested start, but it
is already running (flags: 2084)
[   21.637473][    T1] init: service 'console' requested start, but it
is already running (flags: 148)
[   21.641487][  T489] healthd: No battery devices found
[   21.643265][  T487] msm_dpu ae01000.display-controller:
[drm:adreno_request_fw [msm]] loaded qcom/a630_sqe.fw from new
location
[   21.646597][    T1] init: service 'apexd' requested start, but it
is already running (flags: 134)
[   21.646810][    T1] init: starting service 'audioserver'...
[   21.649530][  T487] msm_dpu ae01000.display-controller:
[drm:adreno_request_fw [msm]] loaded qcom/a630_gmu.bin from new
location
[   21.654333][  T489] healthd: battery l=85 v=3600 t=35.0 h=2 st=2 chg=au
[   21.665741][    T1] init: starting service 'credstore'...
[   21.724265][    T1] init: starting service 'gpu'...
[   21.731719][    T1] init: service 'lmkd' requested start, but it is
already running (flags: 36)
[   21.740534][    T1] init: service 'servicemanager' requested start,
but it is already running (flags: 2084)
[   21.750640][    T1] init: starting service 'surfaceflinger'...
[   21.756734][    T1] init: Could not create socket
'pdx/system/vr/display/client': Failed to bind socket
'pdx/system/vr/display/client': No such file or directory
[   21.771622][    T1] init: Could not create socket
'pdx/system/vr/display/manager': Failed to bind socket
'pdx/system/vr/display/manager': No such file or directory
[   21.786631][    T1] init: Could not create socket
'pdx/system/vr/display/vsync': Failed to bind socket
'pdx/system/vr/display/vsync': No such file or directory
[   21.827039][    T1] init: service 'vold' requested start, but it is
already running (flags: 2052)
[   21.836014][    T1] init: service 'qrtr-ns' requested start, but it
is already running (flags: 134)
[   21.845138][    T1] init: service 'pd_mapper' requested start, but
it is already running (flags: 134)
[   21.854438][    T1] init: service 'tqftpserv' requested start, but
it is already running (flags: 134)
[   21.863743][    T1] init: service 'rmtfs' requested start, but it
is already running (flags: 134)
[   21.872708][    T1] init: Command 'class_start core' action=boot
(/system/etc/init/hw/init.rc:1184) took 244ms and succeeded
[   21.884040][    T1] init: processing action
(persist.sys.usb.config=* && boot) from
(/system/etc/init/hw/init.usb.rc:108)
[   21.895504][    T1] init: processing action (boot) from
(/system/etc/init/dumpstate.rc:1)
[   21.903868][    T1] init: processing action (boot) from
(/system/etc/init/gsid.rc:25)
[   21.908105][   T11] ath10k_snoc 18800000.wifi: qmi chip_id 0x30214
chip_family 0x4001 board_id 0xff soc_id 0x40030001
[   21.912021][    T1] init: starting service 'exec 15
(/system/bin/gsid run-startup-tasks)'...
[   21.922451][   T11] ath10k_snoc 18800000.wifi: qmi fw_version
0x2009856b fw_build_timestamp 2018-07-19 12:28 fw_build_id
QC_IMAGE_VERSION_STRING=WLAN.HL.2.0-01387-QCAHLSWMTPLZ-1
[   21.948810][    T1] init: processing action
(persist.device_config.profcollect_native_boot.enabled= && boot) from
(/system/etc/init/profcollectd.rc:19)
[   21.962718][    T1] init: starting service 'exec 16
(/system/bin/profcollectctl reset)'...
[   21.972858][    T1] init: processing action (boot) from
(/vendor/etc/init/init.db845c.usb.rc:1)
[   21.981877][    T1] init: Command 'mount configfs none /config'
action=boot (/vendor/etc/init/init.db845c.usb.rc:2) took 0ms and
failed: mount() failed: Device or resource busy
[   22.000190][    T1] init: Service 'exec 15 (/system/bin/gsid
run-startup-tasks)' (pid 522) exited with status 0 oneshot service
took 0.052000 seconds in background
[   22.014936][    T1] init: Sending signal 9 to service 'exec 15
(/system/bin/gsid run-startup-tasks)' (pid 522) process group...
[   22.026605][    T1] libprocessgroup: Successfully killed process
cgroup uid 0 pid 522 in 0ms
[   22.039827][  T263] file system registered
[   22.058523][    T1] init: processing action
(enable_property_trigger) from (<Builtin Action>:0)
[   22.067632][    T1] init: processing action (apexd.status=ready &&
ro.product.cpu.abilist32=*) from (/system/etc/init/hw/init.rc:484)
[   22.082698][    T1] init: starting service 'boringssl_self_test_apex32'...
[   22.092119][    T1] init: SVC_EXEC service
'boringssl_self_test_apex32' pid 528 (uid 0 gid 0+0 context default)
started; waiting...
[   22.308290][  T336] type=1400 audit(28.071:5): avc: denied { read }
for comm="composer@...-se" name="u:object_r:vendor_hw_prop:s0"
dev="tmpfs" ino=298 scontext=u:r:hal_graphics_composer_default:s0
tcontext=u:object_r:vendor_hw_prop:s0 tclass=file permissive=0
[   22.335281][    T1] init: Service 'boringssl_self_test_apex32' (pid
528) exited with status 0 waiting took 0.244000 seconds
[   22.346515][    T1] init: Sending signal 9 to service
'boringssl_self_test_apex32' (pid 528) process group...
[   22.356615][    T1] libprocessgroup: Successfully killed process
cgroup uid 0 pid 528 in 0ms
[   22.366335][    T1] init: processing action (apexd.status=ready &&
ro.product.cpu.abilist64=*) from (/system/etc/init/hw/init.rc:486)
[   22.378727][    T1] init: starting service 'boringssl_self_test_apex64'...
[   22.403204][    T1] init: SVC_EXEC service
'boringssl_self_test_apex64' pid 539 (uid 0 gid 0+0 context default)
started; waiting...
[   22.473464][    T1] init: Service 'boringssl_self_test_apex64' (pid
539) exited with status 0 waiting took 0.086000 seconds
[   22.484721][    T1] init: Sending signal 9 to service
'boringssl_self_test_apex64' (pid 539) process group...
[   22.494858][    T1] libprocessgroup: Successfully killed process
cgroup uid 0 pid 539 in 0ms
[   22.504380][    T1] init: processing action (bootreceiver.enable=1
&& ro.product.cpu.abilist64=*) from (/system/etc/init/hw/init.rc:657)
[   22.561656][    T1] init: Service 'exec 16
(/system/bin/profcollectctl reset)' (pid 523) exited with status 0
oneshot service took 0.589000 seconds in background
[   22.576223][    T1] init: Sending signal 9 to service 'exec 16
(/system/bin/profcollectctl reset)' (pid 523) process group...
[   22.587719][    T1] libprocessgroup: Successfully killed process
cgroup uid 0 pid 523 in 0ms
[   22.598544][    T1] init: processing action
(net.tcp_def_init_rwnd=*) from (/system/etc/init/hw/init.rc:1214)
[   22.608696][    T1] init: processing action
(sys.init.perf_lsm_hooks=1) from (/system/etc/init/hw/init.rc:1225)
[   22.614735][  T336] type=1400 audit(28.371:6): avc: denied { read }
for comm="composer@...-se" name="u:object_r:vendor_hw_prop:s0"
dev="tmpfs" ino=298 scontext=u:r:hal_graphics_composer_default:s0
tcontext=u:object_r:vendor_hw_prop:s0 tclass=file permissive=0
[   22.619036][    T1] init: processing action
(security.perf_harden=1) from (/system/etc/init/hw/init.rc:1239)
[   22.652295][    T1] init: processing action (ro.debuggable=1) from
(/system/etc/init/hw/init.rc:1274)
[   22.661766][    T1] init: processing action (sys.usb.config=adb &&
sys.usb.configfs=1) from (/system/etc/init/hw/init.usb.configfs.rc:17)
[   22.675031][    T1] init: starting service 'adbd'...
[   22.680343][    T1] init: Created socket '/dev/socket/adbd', mode
660, user 1000, group 1000
[   22.707151][    T1] init: processing action
(init.svc.audioserver=running) from
(/system/etc/init/audioserver.rc:35)
[   22.717816][    T1] init: service 'vendor.audio-hal' requested
start, but it is already running (flags: 4)
[   22.727591][    T1] init: Command 'start vendor.audio-hal-aidl'
action=init.svc.audioserver=running
(/system/etc/init/audioserver.rc:37) took 0ms and failed: service
vendor.audio-hal-aidl not found
[   22.745277][    T1] init: Command 'start
vendor.audio-effect-hal-aidl' action=init.svc.audioserver=running
(/system/etc/init/audioserver.rc:38) took 0ms and failed: service
vendor.audio-effect-hal-aidl not found
[   22.764197][    T1] init: Command 'start vendor.audio-hal-4-0-msd'
action=init.svc.audioserver=running
(/system/etc/init/audioserver.rc:39) took 0ms and failed: service
vendor.audio-hal-4-0-msd not found
[   22.782408][    T1] init: Command 'start audio_proxy_service'
action=init.svc.audioserver=running
(/system/etc/init/audioserver.rc:40) took 0ms and failed: service
audio_proxy_service not found
[   22.788406][  T544] read descriptors
[   22.799739][    T1] init: processing action
(ro.persistent_properties.ready=true) from
(/system/etc/init/bootstat.rc:66)
[   22.800153][    T1] init: processing action
(ro.persistent_properties.ready=true) from
(/system/etc/init/bootstat.rc:70)
[   22.803356][  T544] read strings
[   22.814550][    T1] init: starting service 'exec 17
(/system/bin/bootstat --set_system_boot_reason)'...
[   22.839864][    T1] init: processing action (bootreceiver.enable=1
&& ro.product.cpu.abilist64=*) from (/system/etc/init/dmesgd.rc:3)
[   22.852852][    T1] init: Command 'rm
/data/misc/dmesgd/sent_reports.txt' action=bootreceiver.enable=1 &&
ro.product.cpu.abilist64=* (/system/etc/init/dmesgd.rc:5) took 0ms and
failed: unlink() failed: No such file or directory
[   22.873188][    T1] init: processing action
(persist.heapprofd.enable= && traced.lazy.heapprofd=) from
(/system/etc/init/heapprofd.rc:49)
[   22.891868][    T1] init: processing action (ro.debuggable=1) from
(/system/etc/init/llkd-debuggable.rc:1)
[   22.902003][    T1] init: Service 'exec 17 (/system/bin/bootstat
--set_system_boot_reason)' (pid 547) exited with status 0 oneshot
service took 0.062000 seconds in background
[   22.917699][    T1] init: Sending signal 9 to service 'exec 17
(/system/bin/bootstat --set_system_boot_reason)' (pid 547) process
group...
[   22.930359][    T1] libprocessgroup: Successfully killed process
cgroup uid 1000 pid 547 in 0ms
[   22.939654][    T1] init: processing action (ro.debuggable=*) from
(/system/etc/init/llkd.rc:2)
[   22.949027][    T1] init: processing action
(debug.atrace.user_initiated= && persist.traced.enable=1) from
(/system/etc/init/perfetto.rc:47)
[   22.962061][    T1] init: starting service 'traced_probes'...
[   23.010308][    T1] init: processing action
(persist.traced.enable=1) from (/system/etc/init/perfetto.rc:50)
[   23.021462][    T1] init: starting service 'traced'...
[   23.026878][    T1] init: Created socket
'/dev/socket/traced_consumer', mode 666, user 0, group 0
[   23.035956][    T1] init: Created socket
'/dev/socket/traced_producer', mode 666, user 0, group 0
[   23.051235][    T1] init: service 'traced_probes' requested start,
but it is already running (flags: 132)
[   23.060954][    T1] init: processing action
(ro.persistent_properties.ready=true) from
(/system/etc/init/perfetto.rc:116)
[   23.072054][    T1] init: processing action
(persist.traced_perf.enable= && sys.init.perf_lsm_hooks=1 &&
traced.lazy.traced_perf=) from (/system/etc/init/traced_perf.rc:43)
[   23.088097][    T1] init: processing action
(vendor.usb.controller=*) from
(/vendor/etc/init/init.db845c.usb.rc:35)
[   23.099397][    T1] init: processing action (sys.usb.config=adb &&
sys.usb.configfs=1) from (/vendor/etc/init/init.db845c.usb.rc:67)
[   23.112391][    T1] init: processing action (nonencrypted) from
(/system/etc/init/hw/init.rc:1186)
[   23.117923][  T336] type=1400 audit(28.879:7): avc: denied { read }
for comm="composer@...-se" name="u:object_r:vendor_hw_prop:s0"
dev="tmpfs" ino=298 scontext=u:r:hal_graphics_composer_default:s0
tcontext=u:object_r:vendor_hw_prop:s0 tclass=file permissive=0
[   23.121464][    T1] init: service 'zygote_secondary' requested
start, but it is already running (flags: 4)
[   23.154401][    T1] init: service 'zygote' requested start, but it
is already running (flags: 4)
[   23.163563][    T1] init: starting service 'cameraserver'...
[   23.172550][    T1] init: starting service 'idmap2d'...
[   23.198923][    T1] init: starting service 'incidentd'...
[   23.206893][    T1] init: starting service 'installd'...
[   23.214605][    T1] init: starting service 'mediaextractor'...
[   23.223087][    T1] init: starting service 'mediametrics'...
[   23.231354][    T1] init: starting service 'media'...
[   23.238907][    T1] init: service 'netd' requested start, but it is
already running (flags: 4)
[   23.247824][    T1] init: starting service 'storaged'...
[   23.253312][    T1] init: Could not open file
'/d/mmc0/mmc0:0001/ext_csd': Failed to open file
'/d/mmc0/mmc0:0001/ext_csd': No such file or directory
[   23.269187][    T1] init: starting service 'wificond'...
[   23.277087][    T1] init: starting service 'vendor.media.omx'...
[   23.298553][    T1] init: starting service 'media.swcodec'...
[   23.307278][    T1] init: service 'statsd' requested start, but it
is already running (flags: 4)
[   23.316300][    T1] init: Command 'class_start main'
action=nonencrypted (/system/etc/init/hw/init.rc:1187) took 194ms and
succeeded
[   23.328685][    T1] init: starting service 'gatekeeperd'...
[   23.337437][    T1] init: service 'traced' requested start, but it
is already running (flags: 132)
[   23.338293][  T336] type=1400 audit(29.103:8): avc: denied { read }
for comm="storaged" name="stat" dev="sysfs" ino=40456
scontext=u:r:storaged:s0 tcontext=u:object_r:sysfs:s0 tclass=file
permissive=0
[   23.346654][    T1] init: service 'traced_probes' requested start,
but it is already running (flags: 132)
[   23.374381][    T1] init: starting service 'usbd'...
[   23.406482][    T1] init: Command 'class_start late_start'
action=nonencrypted (/system/etc/init/hw/init.rc:1188) took 77ms and
succeeded
[   23.415373][  T474] wsa881x-codec sdw:0:0217:2010:00:1: ASoC: error
at soc_component_read_no_lock on sdw:0:0217:2010:00:1 for register:
[0x0000312d] -16
[   23.419298][    T1] init: starting service 'bootanim'...
[   23.432850][  T474] wsa881x-codec sdw:0:0217:2010:00:1: ASoC: error
at soc_component_read_no_lock on sdw:0:0217:2010:00:1 for register:
[0x0000311b] -16
[   23.442000][    T1] init: Control message: Processed ctl.start for
'bootanim' from pid: 510 (/system/bin/surfaceflinger)
[   23.452050][  T474] wsa881x-codec sdw:0:0217:2010:00:2: ASoC: error
at soc_component_read_no_lock on sdw:0:0217:2010:00:2 for register:
[0x0000312d] -16
[   23.463322][    T1] init: processing action
(load_persist_props_action) from
(/system/etc/init/flags_health_check.rc:1)
[   23.476596][  T474] wsa881x-codec sdw:0:0217:2010:00:2: ASoC: error
at soc_component_read_no_lock on sdw:0:0217:2010:00:2 for register:
[0x0000311b] -16
[   23.488181][    T1] init: Encryption policy of
/data/server_configurable_flags set to
f4f3260e5a1591680b49745bca448896 v2 modes 1/4 flags 0xa
[   23.507702][   T11] qcom,slim-ngd-ctrl 171c0000.slim: SLIM SAT:
Rcvd master capability
[   23.515794][    T1] init: Service 'usbd' (pid 600) exited with
status 0 oneshot service took 0.135000 seconds in background
[   23.533772][    T1] init: Sending signal 9 to service 'usbd' (pid
600) process group...
[   23.542016][    T1] libprocessgroup: Successfully killed process
cgroup uid 0 pid 600 in 0ms
[   23.552397][    T1] init: starting service 'exec 18
(/system/bin/flags_health_check BOOT_FAILURE)'...
[   23.601248][    T1] init: SVC_EXEC service 'exec 18
(/system/bin/flags_health_check BOOT_FAILURE)' pid 614 (uid 1000 gid
1000+0 context default) started; waiting...
[   23.616131][    T1] init: Command 'exec - system system --
/system/bin/flags_health_check BOOT_FAILURE'
action=load_persist_props_action
(/system/etc/init/flags_health_check.rc:5) took 63ms and succeeded
[   23.635210][    T1] init: Service 'exec 18
(/system/bin/flags_health_check BOOT_FAILURE)' (pid 614) exited with
status 0 waiting took 0.072000 seconds
[   23.648836][    T1] init: Sending signal 9 to service 'exec 18
(/system/bin/flags_health_check BOOT_FAILURE)' (pid 614) process
group...
[   23.661364][    T1] libprocessgroup: Successfully killed process
cgroup uid 1000 pid 614 in 0ms
[   23.670476][    T1] init: processing action
(load_persist_props_action) from (/system/etc/init/logcatd.rc:29)
[   23.682014][  T336] type=1400 audit(29.447:9): avc: denied { read }
for comm="composer@...-se" name="u:object_r:vendor_hw_prop:s0"
dev="tmpfs" ino=298 scontext=u:r:hal_graphics_composer_default:s0
tcontext=u:object_r:vendor_hw_prop:s0 tclass=file permissive=0
[   23.682371][    T1] init: processing action (sys.usb.config=adb &&
sys.usb.configfs=1 && sys.usb.ffs.ready=1) from
(/system/etc/init/hw/init.usb.configfs.rc:20)
[   23.727765][    T1] init: processing action (llk.enable=0) from
(/system/etc/init/llkd.rc:12)
[   23.738126][    T1] init: processing action (khungtask.enable=1)
from (/system/etc/init/llkd.rc:18)
[   23.749813][    T1] init: processing action (llk.enable=0) from
(/system/etc/init/llkd.rc:12)
[   23.758922][    T1] init: processing action (khungtask.enable=0)
from (/system/etc/init/llkd.rc:21)
[   23.769039][    T1] init: processing action (init.svc.media=*) from
(/system/etc/init/mediaserver.rc:1)
[   23.779676][    T1] init: processing action (khungtask.enable=true)
from (/system/etc/init/llkd.rc:25)
[   23.789799][    T1] init: processing action
(khungtask.enable=false) from (/system/etc/init/llkd.rc:31)
[   24.344734][  T488] lt9611 10-003b: video check: hactive_a=0,
hactive_b=0, vactive=0, v_total=0, h_total_sysclk=0
[   25.070117][  T190] ath10k_snoc 18800000.wifi: wcn3990 hw1.0 target
0x00000008 chip_id 0x00000000 sub 0000:0000
[   25.080846][  T190] ath10k_snoc 18800000.wifi: kconfig debug 0
debugfs 0 tracing 0 dfs 0 testmode 1
[   25.089988][  T190] ath10k_snoc 18800000.wifi: firmware ver  api 5
features wowlan,mgmt-tx-by-reference,non-bmi crc32 b3d4b790
[   25.135305][  T190] ath10k_snoc 18800000.wifi: htt-ver 3.53 wmi-op
4 htt-op 3 cal file max-sta 32 raw 0 hwcrypto 1
[   25.229856][  T190] ath10k_snoc 18800000.wifi: invalid MAC address;
choosing random
[   26.445563][  T336] type=1400 audit(32.211:10): avc: denied { read
} for comm="binder:350_4" name="wakeup4" dev="sysfs" ino=46186
scontext=u:r:system_suspend:s0 tcontext=u:object_r:sysfs:s0 tclass=dir
permissive=0
[   26.469050][  T336] type=1400 audit(32.211:11): avc: denied { read
} for comm="binder:350_4" name="wakeup2" dev="sysfs" ino=46035
scontext=u:r:system_suspend:s0 tcontext=u:object_r:sysfs:s0 tclass=dir
permissive=0
[   26.488294][  T336] type=1400 audit(32.211:12): avc: denied { read
} for comm="binder:350_4" name="wakeup0" dev="sysfs" ino=36243
scontext=u:r:system_suspend:s0 tcontext=u:object_r:sysfs:s0 tclass=dir
permissive=0
[   26.507755][  T336] type=1400 audit(32.211:13): avc: denied { read
} for comm="binder:350_4" name="wakeup7" dev="sysfs" ino=46674
scontext=u:r:system_suspend:s0 tcontext=u:object_r:sysfs:s0 tclass=dir
permissive=0
[   26.526919][  T336] type=1400 audit(32.211:14): avc: denied { read
} for comm="binder:350_4" name="wakeup5" dev="sysfs" ino=46247
scontext=u:r:system_suspend:s0 tcontext=u:object_r:sysfs:s0 tclass=dir
permissive=0
[   26.546041][  T336] type=1400 audit(32.211:15): avc: denied { read
} for comm="binder:350_4" name="wakeup3" dev="sysfs" ino=46116
scontext=u:r:system_suspend:s0 tcontext=u:object_r:sysfs:s0 tclass=dir
permissive=0
[   26.565141][  T336] type=1400 audit(32.211:16): avc: denied { read
} for comm="binder:350_4" name="wakeup6" dev="sysfs" ino=46588
scontext=u:r:system_suspend:s0 tcontext=u:object_r:sysfs:s0 tclass=dir
permissive=0
[   27.697073][  T432] AidlLazyServiceRegistrar: Process has 1 (of 1
available) client(s) in use after notification apexservice has
clients: 1
[   27.709713][  T432] AidlLazyServiceRegistrar: Shutdown prevented by
forcePersist override flag.
[   30.354040][  T688] package-parsing (688) used greatest stack
depth: 9792 bytes left
[   30.675961][    T1] init: service 'idmap2d' requested start, but it
is already running (flags: 4)
[   30.688043][    T1] init: Control message: Processed ctl.start for
'idmap2d' from pid: 639 (system_server)
[   30.834358][  T489] healthd: battery l=85 v=3600 t=35.0 h=2 st=2 chg=au
[   31.294095][    T1] init: processing action
(sys.sysctl.extra_free_kbytes=*) from
(/system/etc/init/hw/init.rc:1205)
[   31.307317][    T1] init: starting service 'exec 19
(/system/bin/extra_free_kbytes.sh 24300)'...
[   31.337257][    T1] init: SVC_EXEC service 'exec 19
(/system/bin/extra_free_kbytes.sh 24300)' pid 726 (uid 0 gid 0+0
context default) started; waiting...
[   31.639486][    T1] init: Service 'exec 19
(/system/bin/extra_free_kbytes.sh 24300)' (pid 726) exited with status
0 waiting took 0.320000 seconds
[   31.652700][    T1] init: Sending signal 9 to service 'exec 19
(/system/bin/extra_free_kbytes.sh 24300)' (pid 726) process group...
[   31.664733][    T1] libprocessgroup: Successfully killed process
cgroup uid 0 pid 726 in 0ms
[   32.696773][  T432] AidlLazyServiceRegistrar: Process has 0 (of 1
available) client(s) in use after notification apexservice has
clients: 0
[   32.709494][  T432] AidlLazyServiceRegistrar: Shutdown prevented by
forcePersist override flag.
[   36.255572][  T332] logd: logdr: UID=2000 GID=2000 PID=875 b tail=0
logMask=99 pid=0 start=0ns deadline=0ns
[   37.696487][  T432] AidlLazyServiceRegistrar: Process has 1 (of 1
available) client(s) in use after notification apexservice has
clients: 1
[   37.709241][  T432] AidlLazyServiceRegistrar: Shutdown prevented by
forcePersist override flag.
[   38.338612][  T336] type=1400 audit(1666104608.191:17): avc:
granted { read } for comm="rkstack.process" name="psched" dev="proc"
ino=4026531994 scontext=u:r:network_stack:s0
tcontext=u:object_r:proc_net:s0 tclass=file
[   38.358532][  T336] type=1400 audit(1666104608.191:18): avc:
granted { read open } for comm="rkstack.process"
path="/proc/1086/net/psched" dev="proc" ino=4026531994
scontext=u:r:network_stack:s0 tcontext=u:object_r:proc_net:s0
tclass=file
[   38.380026][  T336] type=1400 audit(1666104608.191:19): avc:
granted { getattr } for comm="rkstack.process"
path="/proc/1086/net/psched" dev="proc" ino=4026531994
scontext=u:r:network_stack:s0 tcontext=u:object_r:proc_net:s0
tclass=file
[   38.617748][  T475] Bluetooth: hci0: setting up wcn399x
[   38.757009][  T475] Bluetooth: hci0: QCA Product ID   :0x0000000a
[   38.763227][  T475] Bluetooth: hci0: QCA SOC Version  :0x40010214
[   38.769530][  T475] Bluetooth: hci0: QCA ROM Version  :0x00000201
[   38.775726][  T475] Bluetooth: hci0: QCA Patch Version:0x00000001
[   38.801570][  T475] Bluetooth: hci0: QCA controller version 0x02140201
[   38.808233][  T475] Bluetooth: hci0: QCA Downloading qca/crbtfw21.tlv
[   39.633279][  T475] Bluetooth: hci0: QCA Downloading qca/crnv21.bin
[   39.644525][    T1] init: Service 'bootanim' (pid 603) exited with
status 0 oneshot service took 16.205000 seconds in background
[   39.656244][    T1] init: Sending signal 9 to service 'bootanim'
(pid 603) process group...
[   39.665372][    T1] libprocessgroup: Successfully killed process
cgroup uid 1003 pid 603 in 0ms
[   39.674836][  T475] Bluetooth: hci0: QCA setup on UART is completed
[   39.871775][    T1] init: processing action (sys.boot_completed=1)
from (/system/etc/init/hw/init.rc:1196)
[   39.882217][    T1] init: starting service 'exec 20 (/bin/rm -rf
/data/per_boot)'...
[   39.934126][    T1] init: SVC_EXEC service 'exec 20 (/bin/rm -rf
/data/per_boot)' pid 1432 (uid 1000 gid 1000+0 context default)
started; waiting...
[   39.947707][    T1] init: Command 'exec - system system -- /bin/rm
-rf /data/per_boot' action=sys.boot_completed=1
(/system/etc/init/hw/init.rc:1199) took 65ms and succeeded
[   39.963681][    T1] init: Service 'exec 20 (/bin/rm -rf
/data/per_boot)' (pid 1432) exited with status 0 waiting took 0.071000
seconds
[   39.975951][    T1] init: Sending signal 9 to service 'exec 20
(/bin/rm -rf /data/per_boot)' (pid 1432) process group...
[   39.987364][    T1] libprocessgroup: Successfully killed process
cgroup uid 1000 pid 1432 in 0ms
[   40.030995][    T1] init: Encryption policy of /data/per_boot set
to a24a2d090cd712a9f22d91a727e864b5 v2 modes 1/4 flags 0xa
[   40.042534][    T1] init: processing action (sys.boot_completed=1
&& sys.bootstat.first_boot_completed=0) from
(/system/etc/init/bootstat.rc:76)
[   40.056124][    T1] init: starting service 'exec 21
(/system/bin/bootstat --record_boot_complete --record_boot_reason
--record_time_since_factory_reset -l)'...
[   40.073771][    T1] init: processing action (sys.boot_completed=1)
from (/system/etc/init/flags_health_check.rc:7)
[   40.097685][    T1] init: processing action
(persist.dbg.keep_debugfs_mounted= &&
ro.product.debugfs_restrictions.enabled=true && sys.boot_completed=1)
from (/system/etc/init/init-debug.rc:15)
[   40.115950][    T1] init: processing action (sys.boot_completed=1)
from (/system/etc/init/logd.rc:34)
[   40.125509][    T1] init: starting service 'logd-auditctl'...
[   40.137943][    T1] init: processing action (sys.boot_completed=1
&& sys.wifitracing.started=0) from (/system/etc/init/wifi.rc:28)
[   40.150263][    T1] init: Service 'exec 21 (/system/bin/bootstat
--record_boot_complete --record_boot_reason
--record_time_since_factory_reset -l)' (pid 1497) exited with status 0
oneshot service took 0.078000 seconds in background
[   40.171258][    T1] init: Sending signal 9 to service 'exec 21
(/system/bin/bootstat --record_boot_complete --record_boot_reason
--record_time_since_factory_reset -l)' (pid 1497) process group...
[   40.189477][    T1] libprocessgroup: Successfully killed process
cgroup uid 1000 pid 1497 in 0ms
[   40.199201][    T1] init: Service 'logd-auditctl' (pid 1500) exited
with status 0 oneshot service took 0.066000 seconds in background
[   40.211365][    T1] init: Sending signal 9 to service
'logd-auditctl' (pid 1500) process group...
[   40.220647][    T1] libprocessgroup: Successfully killed process
cgroup uid 1036 pid 1500 in 0ms
[   40.230322][    T1] selinux: SELinux: Could not get canonical path
for /sys/kernel/debug/tracing/instances/wifi restorecon: No such file
or directory.
[   40.244011][    T1] selinux:
[   40.378651][    T1] init: processing action (sys.boot_completed=1)
from (/vendor/etc/init/init.db845c.rc:43)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ