Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

java.security.ProviderException: Failed to construct key object from newly generated key pair. #284

Open
wiggleroom-2321 opened this issue Jan 25, 2025 · 2 comments
Open

java.security.ProviderException: Failed to construct key object from newly generated key pair. #284

wiggleroom-2321 opened this issue Jan 25, 2025 · 2 comments

Comments

@wiggleroom-2321
Copy link

fail to generating attestation on Pixel 9 Pro XL
logs from phone:

type: logcat
osVersion: google/komodo/komodo:15/AP4A.250105.002/2025011500:user/release-keys
package: app.attestation.auditor:87, targetSdk 35
buffers: main,system,crash,events,kernel
level: verbose

--------- beginning of main
01-25 04:14:32.366  4601  4601 I station.auditor: Using CollectorTypeCMC GC.
01-25 04:14:32.368  4601  4601 E station.auditor: Not starting debugger since process cannot load the jdwp agent.
01-25 04:14:32.414  4601  4601 W libc    : Access denied finding property "ro.debuggable"
--------- beginning of events
01-25 04:14:32.412  4601  4601 I auditd  : avc=type=1400 audit(0.0:706): avc:  denied  { read } for  comm="app_process64" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.412  4601  4601 W app_process64: type=1400 audit(0.0:706): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.426  4601  4601 W libc    : Access denied finding property "ro.debuggable"
01-25 04:14:32.426  4601  4601 W libc    : Access denied finding property "ro.debuggable"
01-25 04:14:32.426  4601  4601 W libc    : Access denied finding property "ro.debuggable"
01-25 04:14:32.427  4601  4601 D AndroidRuntime: >>>>>> START com.android.internal.os.RuntimeInit uid 10105 <<<<<<
01-25 04:14:32.427  4601  4601 W libc    : Access denied finding property "ro.debuggable"
--------- switch to events
01-25 04:14:32.424  4601  4601 I auditd  : avc=type=1400 audit(0.0:707): avc:  denied  { read } for  comm="app_process64" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.424  4601  4601 W app_process64: type=1400 audit(0.0:707): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.424  4601  4601 I auditd  : avc=type=1400 audit(0.0:708): avc:  denied  { read } for  comm="app_process64" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.424  4601  4601 W app_process64: type=1400 audit(0.0:708): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.424  4601  4601 I auditd  : avc=type=1400 audit(0.0:709): avc:  denied  { read } for  comm="app_process64" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.424  4601  4601 W app_process64: type=1400 audit(0.0:709): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.424  4601  4601 I auditd  : avc=type=1400 audit(0.0:710): avc:  denied  { read } for  comm="station.auditor" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.424  4601  4601 W station.auditor: type=1400 audit(0.0:710): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.430  4601  4601 I AndroidRuntime: Using default boot image
01-25 04:14:32.430  4601  4601 I AndroidRuntime: Leaving lock profiling enabled
01-25 04:14:32.430  4601  4601 W libc    : Access denied finding property "odsign.verification.success"
--------- switch to events
01-25 04:14:32.428  4601  4601 I auditd  : avc=type=1400 audit(0.0:711): avc:  denied  { read } for  comm="station.auditor" name="u:object_r:odsign_prop:s0" dev="tmpfs" ino=290 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:odsign_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.428  4601  4601 W station.auditor: type=1400 audit(0.0:711): avc:  denied  { read } for  name="u:object_r:odsign_prop:s0" dev="tmpfs" ino=290 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:odsign_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.430  4601  4601 W libc    : Access denied finding property "ro.debuggable"
--------- switch to events
01-25 04:14:32.428  4601  4601 I auditd  : avc=type=1400 audit(0.0:712): avc:  denied  { read } for  comm="station.auditor" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.428  4601  4601 W station.auditor: type=1400 audit(0.0:712): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.430  4601  4601 E cutils-trace: Error opening trace file: No such file or directory (2)
01-25 04:14:32.432  4601  4601 W app.attestation.auditor: ART APEX data files are untrusted.
01-25 04:14:32.432  4601  4601 I app.attestation.auditor: Using CollectorTypeCMC GC.
--------- switch to events
01-25 04:14:32.428  4601  4601 I auditd  : avc=type=1400 audit(0.0:713): avc:  denied  { getattr } for  comm="station.auditor" path="/apex/apex-info-list.xml" dev="tmpfs" ino=89 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:apex_info_file:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.428  4601  4601 W station.auditor: type=1400 audit(0.0:713): avc:  denied  { getattr } for  path="/apex/apex-info-list.xml" dev="tmpfs" ino=89 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:apex_info_file:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.478  4601  4601 D nativeloader: InitDefaultPublicLibraries for_preload=1: libandroid.so:libaaudio.so:libamidi.so:libbinder_ndk.so:libc.so:libcamera2ndk.so:libdl.so:libEGL.so:libGLESv1_CM.so:libGLESv2.so:libGLESv3.so:libicu.so:libicui18n.so:libicuuc.so:libjnigraphics.so:liblog.so:libmediandk.so:libm.so:libnativehelper.so:libnativewindow.so:libOpenMAXAL.so:libOpenSLES.so:libRS.so:libstdc++.so:libsync.so:libvulkan.so:libwebviewchromium_plat_support.so:libz.so
01-25 04:14:32.486  4601  4601 D nativeloader: Load libicu_jni.so using APEX ns com_android_art for caller /apex/com.android.art/javalib/core-oj.jar: ok
01-25 04:14:32.486  4601  4601 D app.attestation.auditor: u_setTimeZoneFilesDirectory("/apex/com.android.tzdata/etc/tz/versioned/8/icu") succeeded. 
01-25 04:14:32.486  4601  4601 D app.attestation.auditor: I18n APEX ICU file found: /apex/com.android.i18n/etc/icu/icudt75l.dat
01-25 04:14:32.486  4601  4601 D nativeloader: Load libjavacore.so using APEX ns com_android_art for caller /apex/com.android.art/javalib/core-oj.jar: ok
01-25 04:14:32.487  4601  4601 D nativeloader: Load libopenjdk.so using APEX ns com_android_art for caller /apex/com.android.art/javalib/core-oj.jar: ok
01-25 04:14:32.498  4601  4601 W libc    : Access denied finding property "ro.product.name_for_attestation"
01-25 04:14:32.498  4601  4601 W libc    : Access denied finding property "ro.product.device_for_attestation"
01-25 04:14:32.498  4601  4601 W libc    : Access denied finding property "ro.product.manufacturer_for_attestation"
01-25 04:14:32.498  4601  4601 W libc    : Access denied finding property "ro.product.brand_for_attestation"
01-25 04:14:32.498  4601  4601 W libc    : Access denied finding property "ro.product.model_for_attestation"
--------- switch to events
01-25 04:14:32.496  4601  4601 I auditd  : avc=type=1400 audit(0.0:714): avc:  denied  { read } for  comm="main" name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.496  4601  4601 W main    : type=1400 audit(0.0:714): avc:  denied  { read } for  name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.496  4601  4601 I auditd  : avc=type=1400 audit(0.0:715): avc:  denied  { read } for  comm="main" name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.496  4601  4601 W main    : type=1400 audit(0.0:715): avc:  denied  { read } for  name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.496  4601  4601 I auditd  : avc=type=1400 audit(0.0:716): avc:  denied  { read } for  comm="main" name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.496  4601  4601 W main    : type=1400 audit(0.0:716): avc:  denied  { read } for  name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.496  4601  4601 I auditd  : avc=type=1400 audit(0.0:717): avc:  denied  { read } for  comm="main" name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.496  4601  4601 W main    : type=1400 audit(0.0:717): avc:  denied  { read } for  name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.496  4601  4601 I auditd  : avc=type=1400 audit(0.0:718): avc:  denied  { read } for  comm="main" name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.496  4601  4601 W main    : type=1400 audit(0.0:718): avc:  denied  { read } for  name="u:object_r:build_attestation_prop:s0" dev="tmpfs" ino=112 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:build_attestation_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.498  4601  4601 W libc    : Access denied finding property "ro.debuggable"
--------- switch to events
01-25 04:14:32.496  4601  4601 I auditd  : avc=type=1400 audit(0.0:719): avc:  denied  { read } for  comm="main" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.496  4601  4601 W main    : type=1400 audit(0.0:719): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.504  4601  4601 D nativeloader: Load libframework-connectivity-tiramisu-jni.so using APEX ns com_android_tethering for caller /apex/com.android.tethering/javalib/framework-connectivity-t.jar: ok
01-25 04:14:32.504  4601  4601 D AndroidRuntime: Calling main entry com.android.internal.os.ExecInit
01-25 04:14:32.504  4601  4601 D Zygote  : begin preload
01-25 04:14:32.504  4601  4601 I Zygote  : Calling ZygoteHooks.beginPreload()
01-25 04:14:32.516  4601  4601 I Zygote  : Preloading shared libraries...
01-25 04:14:32.517  4601  4601 D nativeloader: Load libandroid.so using system ns (caller=/system/framework/framework.jar!classes5.dex): ok
01-25 04:14:32.517  4601  4601 D nativeloader: Load libjnigraphics.so using system ns (caller=/system/framework/framework.jar!classes5.dex): ok
01-25 04:14:32.517  4601  4601 D nativeloader: Load libcompiler_rt.so using system ns (caller=/system/framework/framework.jar!classes5.dex): ok
01-25 04:14:32.517  4601  4601 E app.attestation.auditor: Unable to find pattern file or unable to map it for am
01-25 04:14:32.518  4601  4601 I Zygote  : Called ZygoteHooks.endPreload()
01-25 04:14:32.519  4601  4601 D nativeloader: Load libjavacrypto.so using APEX ns com_android_conscrypt for caller /apex/com.android.conscrypt/javalib/conscrypt.jar: ok
01-25 04:14:32.522  4601  4601 I Zygote  : Installed AndroidKeyStoreProvider in 4ms.
01-25 04:14:32.522  4601  4601 D Zygote  : end preload
01-25 04:14:32.527  4601  4620 W libc    : Access denied finding property "qemu.sf.lcd_density"
01-25 04:14:32.527  4601  4620 W libc    : Access denied finding property "qemu.sf.lcd_density"
--------- switch to events
01-25 04:14:32.524  4601  4601 I auditd  : avc=type=1400 audit(0.0:720): avc:  denied  { read } for  comm="binder:4601_2" name="u:object_r:qemu_sf_lcd_density_prop:s0" dev="tmpfs" ino=314 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:qemu_sf_lcd_density_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.524  4601  4601 W binder:4601_2: type=1400 audit(0.0:720): avc:  denied  { read } for  name="u:object_r:qemu_sf_lcd_density_prop:s0" dev="tmpfs" ino=314 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:qemu_sf_lcd_density_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.524  4601  4601 I auditd  : avc=type=1400 audit(0.0:721): avc:  denied  { read } for  comm="binder:4601_2" name="u:object_r:qemu_sf_lcd_density_prop:s0" dev="tmpfs" ino=314 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:qemu_sf_lcd_density_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.524  4601  4601 W binder:4601_2: type=1400 audit(0.0:721): avc:  denied  { read } for  name="u:object_r:qemu_sf_lcd_density_prop:s0" dev="tmpfs" ino=314 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:qemu_sf_lcd_density_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.535  4601  4601 D nativeloader: Load libstats_jni.so using APEX ns com_android_os_statsd for caller /apex/com.android.os.statsd/javalib/framework-statsd.jar: ok
01-25 04:14:32.536  4601  4601 I Typeface: Preloading /system/fonts/Roboto-Regular.ttf
01-25 04:14:32.536  4601  4601 I Typeface: Preloading /system/fonts/RobotoStatic-Regular.ttf
01-25 04:14:32.541  4601  4601 I SystemFonts: Loading font config from /system/etc/fonts.xml
01-25 04:14:32.561  4601  4601 D nativeloader: InitApexLibraries:
01-25 04:14:32.561  4601  4601 D nativeloader:   com_android_art: libnativehelper.so
01-25 04:14:32.561  4601  4601 D nativeloader:   com_android_i18n: libicui18n.so:libicuuc.so:libicu.so
01-25 04:14:32.561  4601  4601 D nativeloader:   com_android_neuralnetworks: libneuralnetworks.so
01-25 04:14:32.561  4601  4601 D nativeloader: InitDefaultPublicLibraries for_preload=0: libandroid.so:libaaudio.so:libamidi.so:libbinder_ndk.so:libc.so:libcamera2ndk.so:libclang_rt.hwasan-aarch64-android.so:libdl.so:libEGL.so:libGLESv1_CM.so:libGLESv2.so:libGLESv3.so:libjnigraphics.so:liblog.so:libmediandk.so:libm.so:libnativewindow.so:libOpenMAXAL.so:libOpenSLES.so:libRS.so:libstdc++.so:libsync.so:libvulkan.so:libwebviewchromium_plat_support.so:libz.so
01-25 04:14:32.561  4601  4601 D nativeloader: Configuring clns-1 for other apk /system_ext/framework/androidx.window.extensions.jar. target_sdk_version=35, uses_libraries=ALL, library_path=/product/app/Auditor/lib/arm64:/product/app/Auditor/Auditor.apk!/lib/arm64-v8a, permitted_path=/data:/mnt/expand:/data/user/0/app.attestation.auditor
01-25 04:14:32.561  4601  4601 D nativeloader: InitExtendedPublicLibraries: libedgetpu_dba.google.so
01-25 04:14:32.561  4601  4601 D nativeloader: Extending system_exposed_libraries: libedgetpu_dba.google.so
01-25 04:14:32.561  4601  4601 D nativeloader: InitVendorPublicLibraries: libOpenCL.so:libOpenCL-pixel.so:libedgetpu_client.google.so:libedgetpu_util.so:lib_aion_buffer.so:lib_jpg_encoder.so:libgxp.so:libedgetpu_tachyon.google.so
01-25 04:14:32.561  4601  4601 D nativeloader: InitProductPublicLibraries: 
01-25 04:14:32.562  4601  4601 D nativeloader: Configuring clns-2 for other apk /system_ext/framework/androidx.window.sidecar.jar. target_sdk_version=35, uses_libraries=ALL, library_path=/product/app/Auditor/lib/arm64:/product/app/Auditor/Auditor.apk!/lib/arm64-v8a, permitted_path=/data:/mnt/expand:/data/user/0/app.attestation.auditor
01-25 04:14:32.562  4601  4601 D nativeloader: Extending system_exposed_libraries: libedgetpu_dba.google.so
01-25 04:14:32.570  4601  4601 D nativeloader: InitLlndkLibrariesProduct: libEGL.so:libGLESv1_CM.so:libGLESv2.so:libGLESv3.so:libRS.so:libandroid_net.so:libapexsupport.so:libbinder_ndk.so:libc.so:libcgrouprc.so:libclang_rt.asan-aarch64-android.so:libclang_rt.hwasan-aarch64-android.so:libcom.android.tethering.connectivity_native.so:libdl.so:libft2.so:liblog.so:libm.so:libmediandk.so:libnativewindow.so:libneuralnetworks.so:libselinux.so:libsync.so:libvendorsupport.so:libvndksupport.so:libvulkan.so
01-25 04:14:32.570  4601  4601 D nativeloader: Configuring product-clns-3 for unbundled product apk /product/app/Auditor/Auditor.apk. target_sdk_version=35, uses_libraries=, library_path=/product/app/Auditor/lib/arm64:/product/app/Auditor/Auditor.apk!/lib/arm64-v8a:/product/lib64:/system/product/lib64, permitted_path=/data:/mnt/expand:/data/user/0/app.attestation.auditor:/product/lib64:/system/product/lib64
01-25 04:14:32.570  4601  4601 D nativeloader: InitVndkspLibrariesProduct: VNDK is deprecated with product
01-25 04:14:32.570  4601  4601 D CompatChangeReporter: Compat change id reported: 202956589; UID 10105; state: ENABLED
01-25 04:14:32.573  4601  4601 D nativeloader: Load libframework-connectivity-jni.so using APEX ns com_android_tethering for caller /apex/com.android.tethering/javalib/framework-connectivity.jar: ok
01-25 04:14:32.573  4601  4601 V GraphicsEnvironment: Currently set values for:
01-25 04:14:32.573  4601  4601 V GraphicsEnvironment:   angle_gl_driver_selection_pkgs=[com.android.angle, com.linecorp.b612.android, com.campmobile.snow, com.google.android.apps.tachyon]
01-25 04:14:32.573  4601  4601 V GraphicsEnvironment:   angle_gl_driver_selection_values=[angle, native, native, native]
01-25 04:14:32.573  4601  4601 V GraphicsEnvironment: app.attestation.auditor is not listed in per-application setting
01-25 04:14:32.573  4601  4601 V GraphicsEnvironment: Neither updatable production driver nor prerelease driver is supported.
01-25 04:14:32.577  4601  4601 D CompatChangeReporter: Compat change id reported: 279646685; UID 10105; state: ENABLED
01-25 04:14:32.586  4601  4601 D AppCompatDelegate: Checking for metadata for AppLocalesMetadataHolderService : Service not found
01-25 04:14:32.595  4601  4601 D CompatChangeReporter: Compat change id reported: 309578419; UID 10105; state: ENABLED
01-25 04:14:32.596  4601  4601 D DesktopModeFlagsUtil: Toggle override initialized to: OVERRIDE_UNSET
01-25 04:14:32.601  4601  4601 D CompatChangeReporter: Compat change id reported: 63938206; UID 10105; state: ENABLED
--------- switch to events
01-25 04:14:32.607  4601  4601 I wm_on_create_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=performCreate,time=15ms]
01-25 04:14:32.608  4601  4601 I wm_on_start_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=handleStartActivity,time=0ms]
--------- switch to main
01-25 04:14:32.609  4601  4601 W WindowOnBackDispatcher: OnBackInvokedCallback is not enabled for the application.
01-25 04:14:32.609  4601  4601 W WindowOnBackDispatcher: Set 'android:enableOnBackInvokedCallback="true"' in the application manifest.
--------- switch to events
01-25 04:14:32.611  4601  4601 I wm_on_resume_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=RESUME_ACTIVITY,time=1ms]
--------- switch to main
01-25 04:14:32.612  4601  4601 D CompatChangeReporter: Compat change id reported: 349153669; UID 10105; state: ENABLED
01-25 04:14:32.612  4601  4601 W libc    : Access denied finding property "ro.debuggable"
--------- switch to events
01-25 04:14:32.608  4601  4601 I auditd  : avc=type=1400 audit(0.0:722): avc:  denied  { read } for  comm="station.auditor" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.608  4601  4601 W station.auditor: type=1400 audit(0.0:722): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to events
01-25 04:14:32.615  4601  4601 I wm_on_top_resumed_gained_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=topStateChangedWhenResumed]
01-25 04:14:32.651  4601  4601 I viewroot_draw_event: [window=VRI[AttestationActivity],event=reportDrawFinished seqId=0]
01-25 04:14:32.652  4637  4637 I auditd  : avc=type=1400 audit(0.0:723): avc:  denied  { read } for  comm="getprop" name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
--------- switch to main
01-25 04:14:32.652  4637  4637 W getprop : type=1400 audit(0.0:723): avc:  denied  { read } for  name="u:object_r:userdebug_or_eng_prop:s0" dev="tmpfs" ino=385 scontext=u:r:untrusted_app:s0:c105,c256,c512,c768 tcontext=u:object_r:userdebug_or_eng_prop:s0 tclass=file permissive=0 app=app.attestation.auditor
01-25 04:14:32.656  4637  4637 W libc    : Access denied finding property "ro.debuggable"
01-25 04:14:38.538  4601  4641 D ProfileInstaller: Installing profile for app.attestation.auditor
--------- switch to events
01-25 04:14:46.470  4601  4601 I wm_on_top_resumed_lost_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=topStateChangedWhenResumed]
01-25 04:14:46.471  4601  4601 I wm_on_paused_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=performPause,time=0ms]
01-25 04:14:47.709  4601  4601 I wm_on_activity_result_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=ACTIVITY_RESULT]
01-25 04:14:47.709  4601  4601 I wm_on_resume_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=RESUME_ACTIVITY,time=0ms]
01-25 04:14:47.709  4601  4601 I wm_on_top_resumed_gained_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=topWhenResuming]
01-25 04:14:47.709  4601  4601 I wm_on_top_resumed_lost_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=topStateChangedWhenResumed]
01-25 04:14:47.709  4601  4601 I wm_on_paused_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=performPause,time=0ms]
--------- switch to main
01-25 04:14:47.725  4601  4669 I CameraManagerGlobal: Connecting to camera service
01-25 04:14:47.725  4601  4601 D CamLifecycleController: CameraProvider is not ready.
01-25 04:14:47.725  4601  4601 D CameraController: Use cases not attached to camera.
01-25 04:14:47.725  4601  4601 D CamLifecycleController: CameraProvider is not ready.
01-25 04:14:47.725  4601  4601 D CameraController: Use cases not attached to camera.
--------- switch to events
01-25 04:14:47.725  4601  4601 I wm_on_create_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=performCreate,time=9ms]
01-25 04:14:47.726  4601  4601 I wm_on_start_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=handleStartActivity,time=0ms]
01-25 04:14:47.726  4601  4601 I wm_on_resume_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=RESUME_ACTIVITY,time=1ms]
01-25 04:14:47.729  4601  4601 I wm_on_top_resumed_gained_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=topStateChangedWhenResumed]
--------- switch to main
01-25 04:14:47.737  4601  4669 D nativeloader: Load libmedia_jni.so using system ns (caller=/system/framework/framework.jar!classes2.dex): ok
01-25 04:14:47.737  4601  4669 D MtpDeviceJNI: register_android_mtp_MtpDevice
01-25 04:14:47.739  4601  4669 D CameraRepository: Added camera: 0
01-25 04:14:47.740  4601  4669 I Camera2CameraInfo: Device Level: INFO_SUPPORTED_HARDWARE_LEVEL_FULL
01-25 04:14:47.741  4601  4669 D CameraRepository: Added camera: 1
01-25 04:14:47.741  4601  4669 I Camera2CameraInfo: Device Level: INFO_SUPPORTED_HARDWARE_LEVEL_FULL
01-25 04:14:47.741  4601  4669 D CameraValidator: Verifying camera lens facing on komodo, lensFacingInteger: null
--------- switch to events
01-25 04:14:47.747  4601  4601 I viewroot_draw_event: [window=VRI[QRScannerActivity],event=reportDrawFinished seqId=0]
--------- switch to main
01-25 04:14:47.748  4601  4601 D CameraController: PreviewView not attached to CameraController.
01-25 04:14:47.748  4601  4601 D CameraController: Use cases not attached to camera.
01-25 04:14:47.750  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
01-25 04:14:47.750  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
01-25 04:14:47.752  4601  4601 D DynamicRangeResolver: Resolved dynamic range for use case x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef45 to no compatible HDR dynamic ranges.
01-25 04:14:47.752  4601  4601 D DynamicRangeResolver: DynamicRange@c3b5d90{encoding=UNSPECIFIED, bitDepth=0}
01-25 04:14:47.752  4601  4601 D DynamicRangeResolver: ->
01-25 04:14:47.752  4601  4601 D DynamicRangeResolver: DynamicRange@bd6c053{encoding=SDR, bitDepth=8}
01-25 04:14:47.753  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
01-25 04:14:47.753  4601  4601 D DeferrableSurface: Surface created[total_surfaces=1, used_surfaces=0](J.r@1b06245}
01-25 04:14:47.753  4601  4601 D DeferrableSurface: Surface created[total_surfaces=2, used_surfaces=0](x.h0@779ddc1}
01-25 04:14:47.753  4601  4601 D DeferrableSurface: New surface in use[total_surfaces=2, used_surfaces=1](x.h0@779ddc1}
01-25 04:14:47.753  4601  4601 D DeferrableSurface: use count+1, useCount=1 x.h0@779ddc1
01-25 04:14:47.753  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
01-25 04:14:47.754  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
01-25 04:14:47.754  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
01-25 04:14:47.754  4601  4601 D DeferrableSurface: Surface created[total_surfaces=3, used_surfaces=1](x.h0@d73b5f2}
01-25 04:14:47.754  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Use case x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737 ACTIVE
01-25 04:14:47.755  4601  4672 D UseCaseAttachState: Active and attached use case: [] for camera: 0
01-25 04:14:47.755  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Use case x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566 ACTIVE
01-25 04:14:47.755  4601  4672 D UseCaseAttachState: Active and attached use case: [] for camera: 0
01-25 04:14:47.755  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Use cases [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] now ATTACHED
01-25 04:14:47.755  4601  4672 D UseCaseAttachState: All use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:47.755  4601  4672 D UseCaseAttachState: Active and attached use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:47.755  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Resetting Capture Session
01-25 04:14:47.755  4601  4601 D PreviewView: Surface requested by Preview.
01-25 04:14:47.755  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Releasing session in state INITIALIZED
01-25 04:14:47.756  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Attempting to force open the camera.
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: tryOpenCamera(Camera@8592d18[id=0]) [Available Cameras: 1, Already Open: false (Previous state: null)] --> SUCCESS
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: Recalculating open cameras:
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: Camera                                       State                 
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: Camera@8592d18[id=0]                         OPENING               
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: Camera@3b115ad[id=1]                         UNKNOWN               
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:47.756  4601  4672 D CameraStateRegistry: Open count: 1 (Max allowed: 1)
01-25 04:14:47.756  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Opening camera.
01-25 04:14:47.756  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Transitioning camera internal state: INITIALIZED --> OPENING
01-25 04:14:47.756  4601  4672 D CameraStateMachine: New public camera state CameraState{type=OPENING, error=null} from OPENING and null
01-25 04:14:47.756  4601  4672 D CameraStateMachine: Publishing new public camera state CameraState{type=OPENING, error=null}
01-25 04:14:47.756  4601  4672 D UseCaseAttachState: All use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:47.756  4601  4601 D PreviewView: Preview transformation info updated. TransformationInfo{getCropRect=Rect(0, 0 - 1600, 1200), getRotationDegrees=90, getTargetRotation=-1, hasCameraTransform=true, getSensorToBufferTransform=Matrix{[1.0, 0.0, 0.0][0.0, 1.0, 0.0][0.0, 0.0, 1.0]}, getMirroring=false}
01-25 04:14:47.756  4601  4601 D PreviewTransform: Transformation info set: TransformationInfo{getCropRect=Rect(0, 0 - 1600, 1200), getRotationDegrees=90, getTargetRotation=-1, hasCameraTransform=true, getSensorToBufferTransform=Matrix{[1.0, 0.0, 0.0][0.0, 1.0, 0.0][0.0, 0.0, 1.0]}, getMirroring=false} 1600x1200 false
01-25 04:14:47.756  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
--------- switch to events
01-25 04:14:47.760  4601  4601 I surfaceview_layout: [window=SV[237369366 QRScannerActivity],format=4,width=1600,height=1200,z=-2,sizeFrom=layout,attached=1,lifecycleStrategy=0,viewVisible=1]
01-25 04:14:47.761  4601  4601 I surfaceview_callback: [window=SV[237369366 QRScannerActivity],callback=surfaceCreated]
--------- switch to main
01-25 04:14:47.761  4601  4601 D SurfaceViewImpl: Surface created.
--------- switch to events
01-25 04:14:47.761  4601  4601 I surfaceview_callback: [window=SV[237369366 QRScannerActivity],callback=surfaceChanged -- format=4 w=1600 h=1200]
--------- switch to main
01-25 04:14:47.761  4601  4601 D SurfaceViewImpl: Surface changed. Size: 1600x1200
--------- switch to events
01-25 04:14:47.761  4601  4601 I surfaceview_callback: [window=SV[237369366 QRScannerActivity],callback=surfaceRedrawNeeded]
--------- switch to main
01-25 04:14:47.767  4601  4601 D SurfaceViewImpl: Surface set on Preview.
01-25 04:14:47.786  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Use case x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737 ACTIVE
01-25 04:14:47.786  4601  4672 D UseCaseAttachState: Active and attached use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:47.786  4601  4672 D Camera2CameraImpl: {Camera@8592d18[id=0]} Use case x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566 ACTIVE
01-25 04:14:47.786  4601  4672 D UseCaseAttachState: Active and attached use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:47.786  4601  4672 D UseCaseAttachState: Active and attached use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:47.787  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} CameraDevice.onOpened()
01-25 04:14:47.787  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Transitioning camera internal state: OPENING --> OPENED
01-25 04:14:47.787  4601  4669 D CameraStateRegistry: Recalculating open cameras:
01-25 04:14:47.787  4601  4669 D CameraStateRegistry: Camera                                       State                 
01-25 04:14:47.787  4601  4669 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:47.787  4601  4669 D CameraStateRegistry: Camera@8592d18[id=0]                         OPEN                  
01-25 04:14:47.787  4601  4669 D CameraStateRegistry: Camera@3b115ad[id=1]                         UNKNOWN               
01-25 04:14:47.787  4601  4669 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:47.787  4601  4669 D CameraStateRegistry: Open count: 1 (Max allowed: 1)
01-25 04:14:47.787  4601  4669 D CameraStateMachine: New public camera state CameraState{type=OPEN, error=null} from OPEN and null
01-25 04:14:47.787  4601  4669 D CameraStateMachine: Publishing new public camera state CameraState{type=OPEN, error=null}
01-25 04:14:47.787  4601  4669 D UseCaseAttachState: All use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:47.788  4601  4669 D SyncCaptureSessionBase: [q.h0@b6965b4] getSurface...done
01-25 04:14:47.788  4601  4669 D CaptureSession: Opening capture session.
01-25 04:14:47.789  4601  4669 D DeferrableSurface: use count+1, useCount=2 x.h0@779ddc1
01-25 04:14:47.789  4601  4669 D DeferrableSurface: New surface in use[total_surfaces=3, used_surfaces=2](x.h0@d73b5f2}
01-25 04:14:47.789  4601  4669 D DeferrableSurface: use count+1, useCount=1 x.h0@d73b5f2
01-25 04:14:47.821  4601  4669 D CaptureSession: Attempting to send capture request onConfigured
01-25 04:14:47.821  4601  4669 D CaptureSession: Issuing request for session.
01-25 04:14:47.821  4601  4669 D Camera2CaptureRequestBuilder: createCaptureRequest
01-25 04:14:47.824  4601  4669 D CaptureSession: CameraCaptureSession.onConfigured() mState=OPENED
01-25 04:14:47.824  4601  4669 D CaptureSession: CameraCaptureSession.onReady() OPENED
01-25 04:14:48.054  4601  4669 D StreamStateObserver: Update Preview stream state to STREAMING
01-25 04:14:48.262  4601  4601 D VRI[AttestationActivity]: visibilityChanged oldVisibility=true newVisibility=false
--------- switch to events
01-25 04:14:48.272  4601  4601 I viewroot_draw_event: [window=VRI[AttestationActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
01-25 04:14:48.272  4601  4601 I wm_on_stop_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=STOP_ACTIVITY_ITEM,time=0ms]
--------- switch to main
01-25 04:14:48.280  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
01-25 04:14:48.702  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 10.48
01-25 04:14:49.377  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 14.81
01-25 04:14:49.757  4601  4669 D UseCaseAttachState: Active and attached use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:49.757  4601  4669 D CaptureSession: Attempting to submit CaptureRequest after setting
01-25 04:14:49.758  4601  4669 D CaptureSession: Issuing request for session.
01-25 04:14:49.758  4601  4669 D Camera2CaptureRequestBuilder: createCaptureRequest
01-25 04:14:49.765  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Issue capture request
01-25 04:14:49.765  4601  4669 D CaptureSession: Issuing capture request.
01-25 04:14:49.767  4601  4669 D Camera2CaptureRequestBuilder: createCaptureRequest
01-25 04:14:50.046  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 14.95
01-25 04:14:50.724  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 14.75
01-25 04:14:51.384  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 15.16
01-25 04:14:51.756  4601  4669 D UseCaseAttachState: Active and attached use case: [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] for camera: 0
01-25 04:14:51.757  4601  4669 D CaptureSession: Attempting to submit CaptureRequest after setting
01-25 04:14:51.757  4601  4669 D CaptureSession: Issuing request for session.
01-25 04:14:51.757  4601  4669 D Camera2CaptureRequestBuilder: createCaptureRequest
01-25 04:14:51.760  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Issue capture request
01-25 04:14:51.760  4601  4669 D CaptureSession: Issuing capture request.
01-25 04:14:51.760  4601  4669 D Camera2CaptureRequestBuilder: createCaptureRequest
01-25 04:14:51.773  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 25.66
01-25 04:14:52.111  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 29.62
01-25 04:14:52.502  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 25.60
01-25 04:14:52.832  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 30.29
--------- switch to events
01-25 04:14:53.081  4601  4601 I wm_on_top_resumed_lost_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=topStateChangedWhenResumed]
01-25 04:14:53.082  4601  4601 I wm_on_paused_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=performPause,time=0ms]
--------- switch to main
01-25 04:14:53.095  4601  4601 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
--------- switch to events
01-25 04:14:53.107  4601  4601 I wm_on_restart_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=performRestart,time=0ms]
01-25 04:14:53.108  4601  4601 I wm_on_start_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=handleStartActivity,time=2ms]
--------- switch to main
01-25 04:14:53.109  4601  4601 W WindowOnBackDispatcher: OnBackInvokedCallback is not enabled for the application.
01-25 04:14:53.109  4601  4601 W WindowOnBackDispatcher: Set 'android:enableOnBackInvokedCallback="true"' in the application manifest.
01-25 04:14:53.110  4601  4601 D AttestationActivity: onActivityResult 665042776 -1
--------- switch to events
01-25 04:14:53.110  4601  4601 I wm_on_activity_result_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=ACTIVITY_RESULT]
01-25 04:14:53.110  4601  4601 I wm_on_resume_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=RESUME_ACTIVITY,time=0ms]
01-25 04:14:53.110  4601  4601 I wm_on_top_resumed_gained_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=topWhenResuming]
01-25 04:14:53.120  4601  4601 I viewroot_draw_event: [window=VRI[AttestationActivity],event=Start draw after previous draw not visible]
01-25 04:14:53.128  4601  4601 I viewroot_draw_event: [window=VRI[AttestationActivity],event=reportDrawFinished seqId=0]
--------- switch to main
01-25 04:14:53.166  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 29.92
01-25 04:14:53.505  4601  4738 D QRCodeImageAnalyzer: Analysis FPS: 29.51
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: Couldn't parse certificate in keystore
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: java.security.cert.CertificateException: com.android.org.conscrypt.OpenSSLX509CertificateFactory$ParsingException: com.android.org.conscrypt.OpenSSLX509CertificateFactory$ParsingException: java.lang.RuntimeException: error:0c00006d:ASN.1 encoding routines:OPENSSL_internal:DECODE_ERROR
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509CertificateFactory.engineGenerateCertificate(OpenSSLX509CertificateFactory.java:303)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at java.security.cert.CertificateFactory.generateCertificate(CertificateFactory.java:366)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at android.security.keystore2.AndroidKeyStoreSpi.toCertificate(AndroidKeyStoreSpi.java:240)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at android.security.keystore2.AndroidKeyStoreProvider.makeAndroidKeyStorePublicKeyFromKeyEntryResponse(AndroidKeyStoreProvider.java:231)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at android.security.keystore2.AndroidKeyStoreKeyPairGeneratorSpi.generateKeyPair(AndroidKeyStoreKeyPairGeneratorSpi.java:702)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at java.security.KeyPairGenerator$Delegate.generateKeyPair(KeyPairGenerator.java:750)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at T0.q.f(Unknown Source:11)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at T0.q.g(Unknown Source:213)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at T0.b.run(Unknown Source:19)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:487)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at java.util.concurrent.FutureTask.run(FutureTask.java:264)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at java.lang.Thread.run(Thread.java:1117)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: Caused by: com.android.org.conscrypt.OpenSSLX509CertificateFactory$ParsingException: com.android.org.conscrypt.OpenSSLX509CertificateFactory$ParsingException: java.lang.RuntimeException: error:0c00006d:ASN.1 encoding routines:OPENSSL_internal:DECODE_ERROR
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509CertificateFactory$Parser.generateItem(OpenSSLX509CertificateFactory.java:147)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509CertificateFactory.engineGenerateCertificate(OpenSSLX509CertificateFactory.java:301)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	... 13 more
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: Caused by: com.android.org.conscrypt.OpenSSLX509CertificateFactory$ParsingException: java.lang.RuntimeException: error:0c00006d:ASN.1 encoding routines:OPENSSL_internal:DECODE_ERROR
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509Certificate.fromX509DerInputStream(OpenSSLX509Certificate.java:106)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509CertificateFactory$1.fromX509DerInputStream(OpenSSLX509CertificateFactory.java:253)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509CertificateFactory$1.fromX509DerInputStream(OpenSSLX509CertificateFactory.java:243)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509CertificateFactory$Parser.generateItem(OpenSSLX509CertificateFactory.java:137)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	... 14 more
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: Caused by: java.lang.RuntimeException: error:0c00006d:ASN.1 encoding routines:OPENSSL_internal:DECODE_ERROR
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.NativeCrypto.d2i_X509_bio(Native Method)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	at com.android.org.conscrypt.OpenSSLX509Certificate.fromX509DerInputStream(OpenSSLX509Certificate.java:100)
01-25 04:14:53.588  4601  4753 W AndroidKeyStore: 	... 17 more
01-25 04:14:53.591  4601  4753 E AttestationActivity: attestation generation error
01-25 04:14:53.591  4601  4753 E AttestationActivity: java.io.IOException: java.security.ProviderException: Failed to construct key object from newly generated key pair.
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at T0.q.f(Unknown Source:18)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at T0.q.g(Unknown Source:213)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at T0.b.run(Unknown Source:19)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:487)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at java.util.concurrent.FutureTask.run(FutureTask.java:264)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:644)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at java.lang.Thread.run(Thread.java:1117)
01-25 04:14:53.591  4601  4753 E AttestationActivity: Caused by: java.security.ProviderException: Failed to construct key object from newly generated key pair.
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at android.security.keystore2.AndroidKeyStoreKeyPairGeneratorSpi.generateKeyPair(AndroidKeyStoreKeyPairGeneratorSpi.java:719)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at java.security.KeyPairGenerator$Delegate.generateKeyPair(KeyPairGenerator.java:750)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at T0.q.f(Unknown Source:11)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	... 7 more
01-25 04:14:53.591  4601  4753 E AttestationActivity: Caused by: java.security.UnrecoverableKeyException: Failed to parse the X.509 certificate containing the public key. This likely indicates a hardware problem.
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at android.security.keystore2.AndroidKeyStoreProvider.makeAndroidKeyStorePublicKeyFromKeyEntryResponse(AndroidKeyStoreProvider.java:233)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	at android.security.keystore2.AndroidKeyStoreKeyPairGeneratorSpi.generateKeyPair(AndroidKeyStoreKeyPairGeneratorSpi.java:702)
01-25 04:14:53.591  4601  4753 E AttestationActivity: 	... 9 more
01-25 04:14:53.649  4601  4601 D VRI[QRScannerActivity]: visibilityChanged oldVisibility=true newVisibility=false
--------- switch to events
01-25 04:14:53.656  4601  4601 I surfaceview_layout: [window=SV[237369366 QRScannerActivity],format=4,width=1600,height=1200,z=-2,sizeFrom=layout,attached=1,lifecycleStrategy=0,viewVisible=0]
01-25 04:14:53.657  4601  4601 I surfaceview_callback: [window=SV[237369366 QRScannerActivity],callback=surfaceDestroyed]
--------- switch to main
01-25 04:14:53.657  4601  4601 D SurfaceViewImpl: Surface destroyed.
01-25 04:14:53.657  4601  4601 D SurfaceViewImpl: Surface closed x.k0@c954ea8
01-25 04:14:53.657  4601  4601 D DeferrableSurface: surface closed,  useCount=2 closed=true x.h0@779ddc1
01-25 04:14:53.661  4601  4686 E BufferQueueProducer: [SurfaceView[app.attestation.auditor/app.attestation.auditor.QRScannerActivity]#2(BLAST Consumer)2](id:11f900000004,api:4,p:953,c:4601) queueBuffer: BufferQueue has been abandoned
--------- switch to events
01-25 04:14:53.663  4601  4601 I viewroot_draw_event: [window=VRI[QRScannerActivity],event=applyTransactionOnDraw applyImmediately]
01-25 04:14:53.663  4601  4601 I viewroot_draw_event: [window=VRI[QRScannerActivity],event=applyTransactionOnDraw applyImmediately]
01-25 04:14:53.663  4601  4601 I viewroot_draw_event: [window=VRI[QRScannerActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
--------- switch to main
01-25 04:14:53.664  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Use cases [x.b0-8e41d9f5-0b4a-4e2c-a617-937cdc14ef4577446737, x.D-c9741d5c-4e30-48a8-ac0f-d99a43b7be2d181200566] now DETACHED for camera
01-25 04:14:53.664  4601  4669 D UseCaseAttachState: All use case: [] for camera: 0
01-25 04:14:53.665  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Resetting Capture Session
--------- switch to events
01-25 04:14:53.665  4601  4601 I wm_on_stop_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=LIFECYCLER_STOP_ACTIVITY,time=0ms]
--------- switch to main
01-25 04:14:53.665  4601  4601 D DeferrableSurface: surface closed,  useCount=0 closed=true J.r@1b06245
01-25 04:14:53.665  4601  4601 D DeferrableSurface: Surface terminated[total_surfaces=2, used_surfaces=2](J.r@1b06245}
01-25 04:14:53.665  4601  4601 D DeferrableSurface: use count-1,  useCount=1 closed=true x.h0@779ddc1
01-25 04:14:53.665  4601  4601 D DeferrableSurface: surface closed,  useCount=1 closed=true x.h0@d73b5f2
--------- switch to events
01-25 04:14:53.665  4601  4601 I wm_on_destroy_called: [Token=192404910,Component Name=app.attestation.auditor.QRScannerActivity,Reason=performDestroy,time=0ms]
--------- switch to main
01-25 04:14:53.666  4601  4601 W WindowOnBackDispatcher: sendCancelIfRunning: isInProgress=false callback=android.view.ViewRootImpl$$ExternalSyntheticLambda11@c18fc83
--------- switch to events
01-25 04:14:53.666  4601  4601 I viewroot_draw_event: [window=VRI[QRScannerActivity],event=applyTransactionOnDraw applyImmediately]
01-25 04:14:53.666  4601  4601 I viewroot_draw_event: [window=VRI[QRScannerActivity],event=applyTransactionOnDraw applyImmediately]
--------- switch to main
01-25 04:14:53.667  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Releasing session in state OPENED
01-25 04:14:53.668  4601  4669 D UseCaseAttachState: Active and attached use case: [] for camera: 0
01-25 04:14:53.669  4601  4669 D UseCaseAttachState: Active and attached use case: [] for camera: 0
01-25 04:14:53.669  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Closing camera.
01-25 04:14:53.669  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Transitioning camera internal state: OPENED --> CLOSING
01-25 04:14:53.669  4601  4669 D CameraStateRegistry: Recalculating open cameras:
01-25 04:14:53.669  4601  4669 D CameraStateRegistry: Camera                                       State                 
01-25 04:14:53.669  4601  4669 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:53.669  4601  4669 D CameraStateRegistry: Camera@8592d18[id=0]                         CLOSING               
01-25 04:14:53.669  4601  4669 D CameraStateRegistry: Camera@3b115ad[id=1]                         UNKNOWN               
01-25 04:14:53.669  4601  4669 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:53.669  4601  4669 D CameraStateRegistry: Open count: 1 (Max allowed: 1)
01-25 04:14:53.669  4601  4669 D CameraStateMachine: New public camera state CameraState{type=CLOSING, error=null} from CLOSING and null
01-25 04:14:53.669  4601  4669 D CameraStateMachine: Publishing new public camera state CameraState{type=CLOSING, error=null}
01-25 04:14:53.669  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Resetting Capture Session
01-25 04:14:53.669  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Releasing session in state CLOSING
01-25 04:14:53.669  4601  4669 D CaptureSession: onSessionFinished()
01-25 04:14:53.672  4601  4601 D StreamStateObserver: Update Preview stream state to IDLE
01-25 04:14:53.680  4601  4686 E BufferQueueProducer: [SurfaceView[app.attestation.auditor/app.attestation.auditor.QRScannerActivity]#2(BLAST Consumer)2](id:11f900000004,api:4,p:953,c:4601) dequeueBuffer: BufferQueue has been abandoned
01-25 04:14:53.692  4601  4686 E BufferQueueProducer: [SurfaceView[app.attestation.auditor/app.attestation.auditor.QRScannerActivity]#2(BLAST Consumer)2](id:11f900000004,api:4,p:953,c:4601) queueBuffer: BufferQueue has been abandoned
01-25 04:14:53.930  4601  4669 D UseCaseAttachState: Active and attached use case: [] for camera: 0
01-25 04:14:53.931  4601  4669 D DeferrableSurface: use count-1,  useCount=0 closed=true x.h0@779ddc1
01-25 04:14:53.931  4601  4669 D DeferrableSurface: Surface no longer in use[total_surfaces=2, used_surfaces=1](x.h0@779ddc1}
01-25 04:14:53.931  4601  4669 D DeferrableSurface: Surface terminated[total_surfaces=1, used_surfaces=1](x.h0@779ddc1}
01-25 04:14:53.931  4601  4669 D DeferrableSurface: use count-1,  useCount=0 closed=true x.h0@d73b5f2
01-25 04:14:53.931  4601  4669 D DeferrableSurface: Surface no longer in use[total_surfaces=1, used_surfaces=0](x.h0@d73b5f2}
01-25 04:14:53.931  4601  4669 D DeferrableSurface: Surface terminated[total_surfaces=0, used_surfaces=0](x.h0@d73b5f2}
01-25 04:14:53.931  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} CameraDevice.onClosed()
01-25 04:14:53.931  4601  4669 D Camera2CameraImpl: {Camera@8592d18[id=0]} Transitioning camera internal state: CLOSING --> INITIALIZED
01-25 04:14:53.934  4601  4601 D SurfaceViewImpl: Safe to release surface.
01-25 04:14:53.934  4601  4669 D CameraStateRegistry: Recalculating open cameras:
01-25 04:14:53.934  4601  4669 D CameraStateRegistry: Camera                                       State                 
01-25 04:14:53.934  4601  4669 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:53.934  4601  4669 D CameraStateRegistry: Camera@8592d18[id=0]                         CLOSED                
01-25 04:14:53.934  4601  4669 D CameraStateRegistry: Camera@3b115ad[id=1]                         UNKNOWN               
01-25 04:14:53.934  4601  4669 D CameraStateRegistry: -------------------------------------------------------------------
01-25 04:14:53.934  4601  4669 D CameraStateRegistry: Open count: 0 (Max allowed: 1)
01-25 04:14:53.934  4601  4669 D CameraStateMachine: New public camera state CameraState{type=CLOSED, error=null} from CLOSED and null
01-25 04:14:53.934  4601  4669 D CameraStateMachine: Publishing new public camera state CameraState{type=CLOSED, error=null}
--------- switch to events
01-25 04:15:01.276  4601  4601 I viewroot_draw_event: [window=VRI[PopupWindow:8bfa8e0],event=reportDrawFinished seqId=0]
01-25 04:15:01.278  4601  4601 I viewroot_draw_event: [window=VRI[PopupWindow:8bfa8e0],event=reportDrawFinished seqId=0]
--------- switch to main
01-25 04:15:03.787  4601  4601 W WindowOnBackDispatcher: sendCancelIfRunning: isInProgress=false callback=android.view.ViewRootImpl$$ExternalSyntheticLambda11@fb4d455
--------- switch to events
01-25 04:15:05.805  4601  4601 I wm_on_top_resumed_lost_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=topStateChangedWhenResumed]
01-25 04:15:05.840  4601  4601 I view_enqueue_input_event: [eventType=Motion - Cancel,action=app.attestation.auditor/app.attestation.auditor.AttestationActivity]
01-25 04:15:06.356  4601  4601 I wm_on_paused_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=performPause,time=0ms]
--------- switch to main
01-25 04:15:06.357  4601  4601 D VRI[AttestationActivity]: visibilityChanged oldVisibility=true newVisibility=false
--------- switch to events
01-25 04:15:06.371  4601  4601 I viewroot_draw_event: [window=VRI[AttestationActivity],event=Not drawing due to not visible. Reason=!mAppVisible && !mForceDecorViewVisibility]
01-25 04:15:06.373  4601  4601 I wm_on_stop_called: [Token=166671266,Component Name=app.attestation.auditor.AttestationActivity,Reason=STOP_ACTIVITY_ITEM,time=0ms]
@thestinger
Copy link
Member

When did you install GrapheneOS? Did you restore from a backup? Does it have internet access?

@wiggleroom-2321
Copy link
Author

When did you install GrapheneOS? Did you restore from a backup? Does it have internet access?

netinstaller, edge on windows; at first i restore it from my previous 6a, after the issue i wipe it and install gos again and the issue still presenting; yes it has.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@thestinger @wiggleroom-2321