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

Dex2Oat Exception while running instrumented Oppia-mobile-android app #30

Closed
sllam opened this issue Feb 14, 2017 · 3 comments
Closed

Dex2Oat Exception while running instrumented Oppia-mobile-android app #30

sllam opened this issue Feb 14, 2017 · 3 comments

Comments

@sllam
Copy link

sllam commented Feb 14, 2017

dex2oat exception while running instrumented version of https://github.com/cuplv/callback-verification/tree/tests/tests/realApplications/oppa-mobile-android/bug. Seems to be related to x86 emu. Will try ARM soon.

02-14 14:14:41.282 3182-3182/? W/dex2oat: Unexpected CPU variant for X86 using defaults: x86
02-14 14:14:41.282 3182-3182/? W/dex2oat: Mismatch between dex2oat instruction set features (ISA: X86 Feature string: smp,-ssse3,-sse4.1,-sse4.2,-avx,-avx2) and those of dex2oat executable (ISA: X86 Feature string: smp,ssse3,-sse4.1,-sse4.2,-avx,-avx2) for the command line:
02-14 14:14:41.282 3182-3182/? W/dex2oat: /system/bin/dex2oat --runtime-arg -classpath --runtime-arg --instruction-set=x86 --instruction-set-features=smp,ssse3,-sse4.1,-sse4.2,-avx,-avx2 --runtime-arg -Xrelocate --boot-image=/system/framework/boot.art --runtime-arg -Xms64m --runtime-arg -Xmx512m --instruction-set-variant=x86 --instruction-set-features=default --dex-file=/data/app/org.digitalcampus.mobile.learning-1/base.apk --oat-file=/data/dalvik-cache/x86/data@[email protected]@[email protected]
02-14 14:14:41.282 3182-3182/? E/dex2oat: Failed to create oat file: /data/dalvik-cache/x86/data@[email protected]@[email protected]: Permission denied
02-14 14:14:41.282 3182-3182/? I/dex2oat: dex2oat took 270.019us (threads: 2)
02-14 14:14:41.283 3167-3167/? W/art: Failed execv(/system/bin/dex2oat --runtime-arg -classpath --runtime-arg --instruction-set=x86 --instruction-set-features=smp,ssse3,-sse4.1,-sse4.2,-avx,-avx2 --runtime-arg -Xrelocate --boot-image=/system/framework/boot.art --runtime-arg -Xms64m --runtime-arg -Xmx512m --instruction-set-variant=x86 --instruction-set-features=default --dex-file=/data/app/org.digitalcampus.mobile.learning-1/base.apk --oat-file=/data/dalvik-cache/x86/data@[email protected]@[email protected]) because non-0 exit status
02-14 14:14:41.284 3167-3167/? A/libc: Fatal signal 11 (SIGSEGV), code 1, fault addr 0x3c in tid 3167 (mobile.learning)
02-14 14:14:41.297 2293-2704/com.google.android.gms I/Icing: Indexing 488571313E209F9928CBCD1DC1B4381C115F07F5 from com.google.android.googlequicksearchbox
02-14 14:14:41.303 2293-2704/com.google.android.gms I/Icing: Indexing done 69DCEB98D00A18F8E6F09EB26AF8CC4CB01F211C
02-14 14:14:41.307 1545-2673/system_process I/OpenGLRenderer: Initialized EGL, version 1.4
02-14 14:14:41.308 2293-2704/com.google.android.gms I/Icing: Indexing done 488571313E209F9928CBCD1DC1B4381C115F07F5
02-14 14:14:41.387 1231-1231/? A/DEBUG: *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
02-14 14:14:41.387 1231-1231/? A/DEBUG: Build fingerprint: 'Android/sdk_google_phone_x86/generic_x86:6.0/MASTER/3393901:userdebug/test-keys'
02-14 14:14:41.387 1231-1231/? A/DEBUG: Revision: '0'
02-14 14:14:41.387 1231-1231/? A/DEBUG: ABI: 'x86'
02-14 14:14:41.387 1231-1231/? A/DEBUG: pid: 3167, tid: 3167, name: mobile.learning >>> org.digitalcampus.mobile.learning <<<
02-14 14:14:41.387 1231-1231/? A/DEBUG: signal 11 (SIGSEGV), code 1 (SEGV_MAPERR), fault addr 0x3c
02-14 14:14:41.388 1231-1231/? A/DEBUG: eax 00000000 ebx b3ffc964 ecx 00000000 edx aa26ce40
02-14 14:14:41.388 1231-1231/? A/DEBUG: esi af76e6b0 edi 00000000
02-14 14:14:41.388 1231-1231/? A/DEBUG: xcs 00000073 xds 0000007b xes 0000007b xfs 00000007 xss 0000007b
02-14 14:14:41.388 1231-1231/? A/DEBUG: eip b3aa45c1 ebp bff7bf88 esp bff7be80 flags 00210286
02-14 14:14:41.389 1231-1231/? A/DEBUG: backtrace:
02-14 14:14:41.389 1231-1231/? A/DEBUG: #00 pc 002045c1 /system/lib/libart.so (art::DexFile::DexFile(unsigned char const*, unsigned int, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, unsigned int, art::MemMap*, art::OatDexFile const*)+111)
02-14 14:14:41.389 1231-1231/? A/DEBUG: #1 pc 0020665f /system/lib/libart.so (art::DexFile::OpenMemory(unsigned char const*, unsigned int, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, unsigned int, art::MemMap*, art::OatDexFile const*, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >)+103)
02-14 14:14:41.389 1231-1231/? A/DEBUG: #2 pc 00207229 /system/lib/libart.so (art::DexFile::Open(art::ZipArchive const&, char const, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, art::DexFile::ZipOpenErrorCode)+233)
02-14 14:14:41.389 1231-1231/? A/DEBUG: #3 pc 002077ec /system/lib/libart.so (art::DexFile::OpenFromZip(art::ZipArchive const&, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, std::__1::vector<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> >, std::__1::allocator<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> > > >)+124)
02-14 14:14:41.389 1231-1231/? A/DEBUG: #4 pc 00207dfb /system/lib/libart.so (art::DexFile::Open(char const*, char const*, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, std::__1::vector<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> >, std::__1::allocator<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> > > >)+219)
02-14 14:14:41.389 1231-1231/? A/DEBUG: #5 pc 00197688 /system/lib/libart.so (art::ClassLinker::OpenDexFilesFromOat(char const*, char const*, std::__1::vector<std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, std::__1::allocator<std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > > >)+1368)
02-14 14:14:41.389 1231-1231/? A/DEBUG: #6 pc 0045816b /system/lib/libart.so (art::DexFile_openDexFileNative(_JNIEnv, _jclass*, _jstring*, _jstring*, int)+363)
02-14 14:14:41.389 1231-1231/? A/DEBUG: #7 pc 7249db7a /data/dalvik-cache/x86/system@[email protected] (offset 0x1eb2000)
02-14 14:14:41.549 1231-1231/? A/DEBUG: Tombstone written to: /data/tombstones/tombstone_06
02-14 14:14:41.549 1231-1231/? E/DEBUG: AM write failed: Broken pipe
02-14 14:14:41.549 1545-1562/system_process I/BootReceiver: Copying /data/tombstones/tombstone_06 to DropBox (SYSTEM_TOMBSTONE)
02-14 14:14:41.588 1248-1248/? I/Zygote: Process 3167 exited due to signal (11)
02-14 14:14:41.600 1545-2051/system_process I/ActivityManager: Process org.digitalcampus.mobile.learning (pid 3167) has died
02-14 14:14:41.604 3191-3191/? I/art: Not late-enabling -Xcheck:jni (already on)
02-14 14:14:41.616 1545-2051/system_process I/ActivityManager: Start proc 3191:org.digitalcampus.mobile.learning/u0a174 for activity org.digitalcampus.mobile.learning/org.digitalcampus.oppia.activity.StartUpActivity
02-14 14:14:41.656 3206-3206/? W/dex2oat: Unexpected CPU variant for X86 using defaults: x86
02-14 14:14:41.656 3206-3206/? W/dex2oat: Mismatch between dex2oat instruction set features (ISA: X86 Feature string: smp,-ssse3,-sse4.1,-sse4.2,-avx,-avx2) and those of dex2oat executable (ISA: X86 Feature string: smp,ssse3,-sse4.1,-sse4.2,-avx,-avx2) for the command line:
02-14 14:14:41.656 3206-3206/? W/dex2oat: /system/bin/dex2oat --runtime-arg -classpath --runtime-arg --instruction-set=x86 --instruction-set-features=smp,ssse3,-sse4.1,-sse4.2,-avx,-avx2 --runtime-arg -Xrelocate --boot-image=/system/framework/boot.art --runtime-arg -Xms64m --runtime-arg -Xmx512m --instruction-set-variant=x86 --instruction-set-features=default --dex-file=/data/app/org.digitalcampus.mobile.learning-1/base.apk --oat-file=/data/dalvik-cache/x86/data@[email protected]@[email protected]
02-14 14:14:41.656 3206-3206/? E/dex2oat: Failed to create oat file: /data/dalvik-cache/x86/data@[email protected]@[email protected]: Permission denied
02-14 14:14:41.656 3206-3206/? I/dex2oat: dex2oat took 177.910us (threads: 2)
02-14 14:14:41.657 3191-3191/? W/art: Failed execv(/system/bin/dex2oat --runtime-arg -classpath --runtime-arg --instruction-set=x86 --instruction-set-features=smp,ssse3,-sse4.1,-sse4.2,-avx,-avx2 --runtime-arg -Xrelocate --boot-image=/system/framework/boot.art --runtime-arg -Xms64m --runtime-arg -Xmx512m --instruction-set-variant=x86 --instruction-set-features=default --dex-file=/data/app/org.digitalcampus.mobile.learning-1/base.apk --oat-file=/data/dalvik-cache/x86/data@[email protected]@[email protected]) because non-0 exit status
02-14 14:14:41.657 3191-3191/? A/libc: Fatal signal 11 (SIGSEGV), code 1, fault addr 0x3c in tid 3191 (mobile.learning)
02-14 14:14:41.763 1231-1231/? A/DEBUG: *** *** *** *** *** *** *** *** *** *** *** *** *** *** *** ***
02-14 14:14:41.763 1231-1231/? A/DEBUG: Build fingerprint: 'Android/sdk_google_phone_x86/generic_x86:6.0/MASTER/3393901:userdebug/test-keys'
02-14 14:14:41.763 1231-1231/? A/DEBUG: Revision: '0'
02-14 14:14:41.763 1231-1231/? A/DEBUG: ABI: 'x86'
02-14 14:14:41.763 1231-1231/? A/DEBUG: pid: 3191, tid: 3191, name: mobile.learning >>> org.digitalcampus.mobile.learning <<<
02-14 14:14:41.763 1231-1231/? A/DEBUG: signal 11 (SIGSEGV), code 1 (SEGV_MAPERR), fault addr 0x3c
02-14 14:14:41.765 1231-1231/? A/DEBUG: eax 00000000 ebx b3ffc964 ecx 00000000 edx aa26cf00
02-14 14:14:41.765 1231-1231/? A/DEBUG: esi af76e6b0 edi 00000000
02-14 14:14:41.765 1231-1231/? A/DEBUG: xcs 00000073 xds 0000007b xes 0000007b xfs 00000007 xss 0000007b
02-14 14:14:41.765 1231-1231/? A/DEBUG: eip b3aa45c1 ebp bff7bf88 esp bff7be80 flags 00210286
02-14 14:14:41.766 1231-1231/? A/DEBUG: backtrace:
02-14 14:14:41.766 1231-1231/? A/DEBUG: #00 pc 002045c1 /system/lib/libart.so (art::DexFile::DexFile(unsigned char const*, unsigned int, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, unsigned int, art::MemMap*, art::OatDexFile const*)+111)
02-14 14:14:41.766 1231-1231/? A/DEBUG: #1 pc 0020665f /system/lib/libart.so (art::DexFile::OpenMemory(unsigned char const*, unsigned int, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, unsigned int, art::MemMap*, art::OatDexFile const*, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >)+103)
02-14 14:14:41.766 1231-1231/? A/DEBUG: #2 pc 00207229 /system/lib/libart.so (art::DexFile::Open(art::ZipArchive const&, char const, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, art::DexFile::ZipOpenErrorCode)+233)
02-14 14:14:41.766 1231-1231/? A/DEBUG: #3 pc 002077ec /system/lib/libart.so (art::DexFile::OpenFromZip(art::ZipArchive const&, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > const&, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, std::__1::vector<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> >, std::__1::allocator<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> > > >)+124)
02-14 14:14:41.766 1231-1231/? A/DEBUG: #4 pc 00207dfb /system/lib/libart.so (art::DexFile::Open(char const*, char const*, std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, std::__1::vector<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> >, std::__1::allocator<std::__1::unique_ptr<art::DexFile const, std::__1::default_delete<art::DexFile const> > > >)+219)
02-14 14:14:41.766 1231-1231/? A/DEBUG: #5 pc 00197688 /system/lib/libart.so (art::ClassLinker::OpenDexFilesFromOat(char const*, char const*, std::__1::vector<std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator >, std::__1::allocator<std::__1::basic_string<char, std::__1::char_traits, std::__1::allocator > > >)+1368)
02-14 14:14:41.766 1231-1231/? A/DEBUG: #6 pc 0045816b /system/lib/libart.so (art::DexFile_openDexFileNative(_JNIEnv, _jclass*, _jstring*, _jstring*, int)+363)
02-14 14:14:41.766 1231-1231/? A/DEBUG: #7 pc 7249db7a /data/dalvik-cache/x86/system@[email protected] (offset 0x1eb2000)
02-14 14:14:41.822 1231-1231/? A/DEBUG: Tombstone written to: /data/tombstones/tombstone_07
02-14 14:14:41.822 1231-1231/? E/DEBUG: AM write failed: Broken pipe
@sllam
Copy link
Author

sllam commented Feb 14, 2017

Tried it on ARM emulator as well. Can't even install app in ARM, Dex2Oat issue.

@sllam
Copy link
Author

sllam commented Feb 14, 2017

Apparently this is an instrumenting issue: I missed this earlier, but the instrumentation failed with the following, even though some apk was written:

Writing APK to: /data/out/oppia-mobile-bug/app-debug.apk
do not forget to sign the .apk file with jarsigner and to align it with zipalign
org.jf.util.ExceptionWithContext: Unsigned short value out of range: 68570
at org.jf.dexlib2.writer.DexDataWriter.writeUshort(DexDataWriter.java:116)
at org.jf.dexlib2.writer.InstructionWriter.write(InstructionWriter.java:329)
at org.jf.dexlib2.writer.DexWriter.writeCodeItem(DexWriter.java:1027)
at org.jf.dexlib2.writer.DexWriter.writeDebugAndCodeItems(DexWriter.java:803)
at org.jf.dexlib2.writer.DexWriter.writeTo(DexWriter.java:252)
at org.jf.dexlib2.writer.DexWriter.writeTo(DexWriter.java:230)
at soot.toDex.DexPrinter.writeTo(DexPrinter.java:251)
at soot.toDex.DexPrinter.printApk(DexPrinter.java:192)
at soot.toDex.DexPrinter.print(DexPrinter.java:1571)
at soot.PackManager.writeOutput(PackManager.java:540)
at soot.Main.run(Main.java:273)
at soot.Main.main(Main.java:147)
at edu.colorad.cs.TraceRunner.TraceRunner$.main(TraceRunner.scala:126)
at edu.colorad.cs.TraceRunner.TraceRunner.main(TraceRunner.scala)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.simontuffs.onejar.Boot.run(Boot.java:340)
at com.simontuffs.onejar.Boot.main(Boot.java:166)

@sllam
Copy link
Author

sllam commented Feb 14, 2017

This is fixed, by instrumenting with the following black list: org.jf.util.:org.joda.time.:org.jarjar.:com.squareup.:org.digitalcampus.oppia.model.:org.apache.http.:okhttp3.internal.:org.apache.:com.splunk.:okhttp3.:com.androidplot.:okio.

@sllam sllam closed this as completed Feb 14, 2017
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
1 participant
@sllam