Crash when launching RNBenchmark JSC

[codyi96]

Description

I want to get some test data through this script, but the program seems to have no response😥:

$ python3 start.py -a

#############################################
# Config
#############################################

---------------------------------------------
ABIs: armeabi-v7a
---------------------------------------------

JSC version: 245459.0.0
Meta: Baseline JIT (but not x86), WebKitGTK 2.24.2
Intl: False
JSC binary size:
	armeabi-v7a: -1 MiB


V8 version: 7.5.1
Meta: JIT-less (but not arm64-v8a), V8 7.5.288.23
Intl: True
V8 binary size:
	armeabi-v7a: -1 MiB


Hermes version: 0.1.0
Meta: JIT-less, bytecode precompile
Intl: False
Hermes binary size:
	armeabi-v7a: 1.16 MiB


#############################################
# RenderComponentThroughput Suite
#############################################

---------------------------------------------
RenderComponentThroughput 10s
---------------------------------------------

There are two application had been installed on my device by the Benchmark. However, one of them called RNBenchmark JSC crashed when it is running. I caught some information that might be useful:

2019-11-05 21:23:10.323 28674-28694/? E/SoLoader: couldn't find DSO to load: libhermes.so
    
    --------- beginning of crash
2019-11-05 21:23:10.323 28674-28694/? E/AndroidRuntime: FATAL EXCEPTION: create_react_context
    Process: com.rnbenchmark.jsc, PID: 28674
    java.lang.UnsatisfiedLinkError: couldn't find DSO to load: libhermes.so
        at com.facebook.soloader.SoLoader.doLoadLibraryBySoName(SoLoader.java:738)
        at com.facebook.soloader.SoLoader.loadLibraryBySoName(SoLoader.java:591)
        at com.facebook.soloader.SoLoader.loadLibrary(SoLoader.java:529)
        at com.facebook.soloader.SoLoader.loadLibrary(SoLoader.java:484)
        at com.facebook.hermes.reactexecutor.HermesExecutor.<clinit>(HermesExecutor.java:20)
        at com.facebook.hermes.reactexecutor.HermesExecutorFactory.create(HermesExecutorFactory.java:27)
        at com.facebook.react.ReactInstanceManager$5.run(ReactInstanceManager.java:949)
        at java.lang.Thread.run(Thread.java:764)

Why libhermes.so needs to be loaded when RNBenchmark JSC is launching?🤔
Could u give me some help?
Thank u!

Environment

• macOS 10.14.6
• Python 3
• Node 8.12.0

[Kudo]

@codyi96 Could you provide log before your crash log?
There is a code in RN that if JSC loading failed, it will load Hermes as fallback.
That's why I am asking for previous log and that would be probably of the problem root cause.

[codyi96]

@Kudo This is a completer log.

2019-11-06 11:01:27.615 904-12113/? I/ActivityManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.rnbenchmark.jsc/com.rnbenchmark.MainActivity bnds=[439,127][642,475]} from uid 10047 pid 3105
2019-11-06 11:01:27.618 904-12113/? E/ANDR-PERF-JNI: com_qualcomm_qtiperformance_native_perf_io_prefetch_start
2019-11-06 11:01:27.618 720-720/? E/ANDR-IOP: IOP HAL: Received pkg_name = com.rnbenchmark.jsc pid = -1
2019-11-06 11:01:27.619 904-1730/? E/OnePlusSmartBoostManager: socket connect
2019-11-06 11:01:27.620 904-1730/? E/OnePlusSmartBoostManager: cmd: iop_start -1 com.rnbenchmark.jsc /data/app/com.rnbenchmark.jsc-r-ePZJSTfGQekQoGnyUwFA== false length = 93
2019-11-06 11:01:27.620 904-1730/? E/OnePlusSmartBoostManager: data: [B@28ac77e length = 93
2019-11-06 11:01:27.620 14647-23723/? E/ANDR-RAMBOOST_SERVER: ramboost cmd_len = 93 cmd: iop_start -1 com.rnbenchmark.jsc /data/app/com.rnbenchmark.jsc-r-ePZJSTfGQekQoGnyUwFA== false
2019-11-06 11:01:27.621 14647-23723/? E/ANDR-RAMBOOST_SERVER: is_in_recent_list is TRUE
2019-11-06 11:01:27.621 14647-23723/? E/ANDR-RAMBOOST_SERVER: io prefetch is deactivate
2019-11-06 11:01:27.629 720-792/? E/ANDR-IOP: io prefetch is disabled
2019-11-06 11:01:27.631 904-12113/? D/ActivityTrigger: activityStartTrigger: Activity is Triggerred in full screen ApplicationInfo{48ec06a com.rnbenchmark.jsc}
2019-11-06 11:01:27.631 904-12113/? E/ActivityTrigger: activityStartTrigger: not whiteListedcom.rnbenchmark.jsc/com.rnbenchmark.MainActivity/1048577
2019-11-06 11:01:27.631 904-12113/? D/ActivityTrigger: activityResumeTrigger: The activity in ApplicationInfo{48ec06a com.rnbenchmark.jsc} is now in focus and seems to be in full-screen mode
2019-11-06 11:01:27.631 904-12113/? E/ActivityTrigger: activityResumeTrigger: not whiteListedcom.rnbenchmark.jsc/com.rnbenchmark.MainActivity/1048577
2019-11-06 11:01:27.631 904-12113/? D/ActivityTrigger: ActivityTrigger activityPauseTrigger 
2019-11-06 11:01:27.634 3105-3105/? D/BaseDraggingActivity: startActivity bookkeeping intent = Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.rnbenchmark.jsc/com.rnbenchmark.MainActivity bnds=[439,127][642,475] }
2019-11-06 11:01:27.634 3105-3105/? D/Stats: Intent.getPackage() is null. therefore try to get package name from componentName.getPackageName(): com.rnbenchmark.jsc
2019-11-06 11:01:27.634 3105-3105/? D/Stats: Intent.getPackage() is null. therefore try to get package name from componentName.getPackageName(): com.rnbenchmark.jsc
2019-11-06 11:01:27.635 3105-4858/? D/Stats: save stats in background ...
2019-11-06 11:01:27.635 3105-3105/? D/ItemClickHandler: onClick appShortcut, tag = ShortcutInfo(id=369 type=APP container=desktop screen=13 cell(2,0) span(1,1) minSpan(1,1) rank=0 user=UserHandle{0} title=RNBench JSC hidden=false dirty = false newInstallTag=null)
2019-11-06 11:01:27.640 3105-3105/? D/Launcher: onPause# hashcode: 149634337
2019-11-06 11:01:27.640 3105-3218/? I/WeatherProvider: un-subscribe the weather callback: 
2019-11-06 11:01:27.641 904-9931/? D/ActivityTrigger: activityResumeTrigger: The activity in ApplicationInfo{48ec06a com.rnbenchmark.jsc} is now in focus and seems to be in full-screen mode
2019-11-06 11:01:27.641 904-9931/? E/ActivityTrigger: activityResumeTrigger: not whiteListedcom.rnbenchmark.jsc/com.rnbenchmark.MainActivity/1048577
2019-11-06 11:01:27.641 904-1147/? D/RestartProcessManager: Update Total Launch Times :com.rnbenchmark.jsc
2019-11-06 11:01:27.641 904-1147/? D/RestartProcessManager: updateSelf :  com.rnbenchmark.jsc, size : 30
2019-11-06 11:01:27.641 904-1147/? D/RestartProcessManager: Increase Total Launch Time : com.rnbenchmark.jsc, times : 1, index : 29
2019-11-06 11:01:27.641 904-1147/? D/RestartProcessManager: Last Running Package : com.rnbenchmark.jsc , start time 1573009287641
2019-11-06 11:01:27.656 904-1149/? I/ActivityManager: Start proc 23725:com.rnbenchmark.jsc/u0a611 for activity com.rnbenchmark.jsc/com.rnbenchmark.MainActivity
2019-11-06 11:01:27.660 23725-23725/? E/rnbenchmark.js: Not starting debugger since process cannot load the jdwp agent.
2019-11-06 11:01:27.666 904-9931/? D/OnePlusSmartBoostManager: writeHotCount com.rnbenchmark.jsc, pid=23725
2019-11-06 11:01:27.671 23725-23738/? I/rnbenchmark.js: The ClassLoaderContext is a special shared library.
2019-11-06 11:01:27.674 742-5590/? D/AudioPolicyService: setRecordSilenced() uid 10611 on silenced 0
2019-11-06 11:01:27.687 23725-23725/? I/Perf: Connecting to perf service.
2019-11-06 11:01:27.690 23725-23725/? D/SoLoader: init start
2019-11-06 11:01:27.690 23725-23725/? D/SoLoader: adding system library source: /vendor/lib
2019-11-06 11:01:27.690 23725-23725/? D/SoLoader: adding system library source: /system/lib
2019-11-06 11:01:27.690 23725-23725/? D/SoLoader: adding application source: com.facebook.soloader.DirectorySoSource[root = /data/app/com.rnbenchmark.jsc-r-ePZJSTfGQekQoGnyUwFA==/lib/arm flags = 0]
2019-11-06 11:01:27.691 23725-23725/? D/SoLoader: adding backup source from : com.facebook.soloader.ApkSoSource[root = /data/data/com.rnbenchmark.jsc/lib-main flags = 1]
2019-11-06 11:01:27.691 23725-23725/? D/SoLoader: Preparing SO source: com.facebook.soloader.DirectorySoSource[root = /system/lib flags = 2]
2019-11-06 11:01:27.691 23725-23725/? D/SoLoader: Preparing SO source: com.facebook.soloader.DirectorySoSource[root = /vendor/lib flags = 2]
2019-11-06 11:01:27.691 23725-23725/? D/SoLoader: Preparing SO source: com.facebook.soloader.DirectorySoSource[root = /data/app/com.rnbenchmark.jsc-r-ePZJSTfGQekQoGnyUwFA==/lib/arm flags = 0]
2019-11-06 11:01:27.691 23725-23725/? D/SoLoader: Preparing SO source: com.facebook.soloader.ApkSoSource[root = /data/data/com.rnbenchmark.jsc/lib-main flags = 1]
2019-11-06 11:01:27.691 23725-23725/? V/fb-UnpackingSoSource: locked dso store /data/user/0/com.rnbenchmark.jsc/lib-main
2019-11-06 11:01:27.693 23725-23725/? I/fb-UnpackingSoSource: dso store is up-to-date: /data/user/0/com.rnbenchmark.jsc/lib-main
2019-11-06 11:01:27.693 23725-23725/? V/fb-UnpackingSoSource: releasing dso store lock for /data/user/0/com.rnbenchmark.jsc/lib-main
2019-11-06 11:01:27.693 23725-23725/? D/SoLoader: init finish: 4 SO sources prepared
2019-11-06 11:01:27.693 23725-23725/? D/SoLoader: init exiting
2019-11-06 11:01:27.696 23725-23741/? E/libc: Access denied finding property "vendor.debug.egl.profiler"
2019-11-06 11:01:27.696 23725-23741/? E/libc: Access denied finding property "vendor.debug.prerotation.disable"
2019-11-06 11:01:27.689 23725-23725/? W/com.rnbenchmark.jsc: type=1400 audit(0.0:13498610): avc: denied { read } for comm=45474C20496E6974 name="u:object_r:vendor_default_prop:s0" dev="tmpfs" ino=22743 scontext=u:r:untrusted_app:s0:c99,c258,c512,c768 tcontext=u:object_r:vendor_default_prop:s0 tclass=file permissive=0
2019-11-06 11:01:27.701 3105-3105/? D/LauncherTransition: [OSP-1899] getActivityLaunchOptions.onCreateAnimation: launcherClosing= true
2019-11-06 11:01:27.704 3105-3105/? D/LauncherTransition: [OSP-1899] getLauncherContentAnimator: isAppOpening= true, trans= 0.0, -131.0
2019-11-06 11:01:27.717 23725-23725/? D/SoLoader: About to load: libjscexecutor.so
2019-11-06 11:01:27.717 23725-23725/? D/SoLoader: libjscexecutor.so not found on /data/data/com.rnbenchmark.jsc/lib-main
2019-11-06 11:01:27.717 23725-23725/? D/SoLoader: libjscexecutor.so found on /data/app/com.rnbenchmark.jsc-r-ePZJSTfGQekQoGnyUwFA==/lib/arm
2019-11-06 11:01:27.717 23725-23725/? D/SoLoader: Not resolving dependencies for libjscexecutor.so
2019-11-06 11:01:27.719 23725-23725/? E/SoLoader: couldn't find DSO to load: libjscexecutor.so caused by: dlopen failed: library "libgnustl_shared.so" not found
2019-11-06 11:01:27.719 23725-23725/? D/ReactNative: ReactInstanceManager.ctor()
2019-11-06 11:01:27.719 23725-23725/? D/SoLoader: init exiting
2019-11-06 11:01:27.721 23725-23725/? D/ReactNative: ReactInstanceManager.createReactContextInBackground()
2019-11-06 11:01:27.721 23725-23725/? D/ReactNative: ReactInstanceManager.recreateReactContextInBackgroundInner()
2019-11-06 11:01:27.721 23725-23725/? D/ReactNative: ReactInstanceManager.recreateReactContextInBackgroundFromBundleLoader()
2019-11-06 11:01:27.721 23725-23725/? D/ReactNative: ReactInstanceManager.recreateReactContextInBackground()
2019-11-06 11:01:27.721 23725-23725/? D/ReactNative: ReactInstanceManager.runCreateReactContextOnNewThread()
2019-11-06 11:01:27.722 23725-23742/? D/SoLoader: About to load: libhermes.so
2019-11-06 11:01:27.722 23725-23742/? D/SoLoader: libhermes.so not found on /data/data/com.rnbenchmark.jsc/lib-main
2019-11-06 11:01:27.722 23725-23742/? D/SoLoader: libhermes.so not found on /data/app/com.rnbenchmark.jsc-r-ePZJSTfGQekQoGnyUwFA==/lib/arm
2019-11-06 11:01:27.722 23725-23742/? D/SoLoader: libhermes.so not found on /vendor/lib
2019-11-06 11:01:27.723 23725-23742/? D/SoLoader: libhermes.so not found on /system/lib
2019-11-06 11:01:27.724 23725-23742/? E/SoLoader: couldn't find DSO to load: libhermes.so
    
    --------- beginning of crash
2019-11-06 11:01:27.724 23725-23742/? E/AndroidRuntime: FATAL EXCEPTION: create_react_context
    Process: com.rnbenchmark.jsc, PID: 23725
    java.lang.UnsatisfiedLinkError: couldn't find DSO to load: libhermes.so
        at com.facebook.soloader.SoLoader.doLoadLibraryBySoName(SoLoader.java:738)
        at com.facebook.soloader.SoLoader.loadLibraryBySoName(SoLoader.java:591)
        at com.facebook.soloader.SoLoader.loadLibrary(SoLoader.java:529)
        at com.facebook.soloader.SoLoader.loadLibrary(SoLoader.java:484)
        at com.facebook.hermes.reactexecutor.HermesExecutor.<clinit>(HermesExecutor.java:20)
        at com.facebook.hermes.reactexecutor.HermesExecutorFactory.create(HermesExecutorFactory.java:27)
        at com.facebook.react.ReactInstanceManager$5.run(ReactInstanceManager.java:949)
        at java.lang.Thread.run(Thread.java:764)
2019-11-06 11:01:27.725 561-561/? E/SELinux: avc:  denied  { find } for service=opdiagnose pid=23725 uid=10611 scontext=u:r:untrusted_app:s0:c99,c258,c512,c768 tcontext=u:object_r:opdiagnose_service:s0 tclass=service_manager permissive=0
2019-11-06 11:01:27.726 561-561/? E/SELinux: avc:  denied  { find } for service=opdiagnose pid=23725 uid=10611 scontext=u:r:untrusted_app:s0:c99,c258,c512,c768 tcontext=u:object_r:opdiagnose_service:s0 tclass=service_manager permissive=0

[Kudo]

@codyi96 That root cause is
2019-11-06 11:01:27.719 23725-23725/? E/SoLoader: couldn't find DSO to load: libjscexecutor.so caused by: dlopen failed: library "libgnustl_shared.so" not found

Weird to me that no one built by gcc toolchain and that should not happen.
A possibility is that to download react-native from jcenter and 50b7d92 addressed this.
Could you pull latest code and try again?

[codyi96]

@Kudo I'm facing another problem after pulling latest commit.
I made my device connected to the computer, and run command as following:

python3 start.py -a

It shows me that more than one device/emulator:

#############################################
# Config
#############################################

---------------------------------------------
ABIs: armeabi-v7a
---------------------------------------------

JSC version: 245459.0.0
Meta: Baseline JIT (but not x86), WebKitGTK 2.24.2
Intl: False
JSC binary size:
        armeabi-v7a: -1 MiB


V8 version: 7.5.1
Meta: JIT-less (but not arm64-v8a), V8 7.5.288.23
Intl: True
V8 binary size:
        armeabi-v7a: -1 MiB


Hermes version: 0.1.0
Meta: JIT-less, bytecode precompile
Intl: False
Hermes binary size:
        armeabi-v7a: 1.16 MiB


#############################################
# RenderComponentThroughput Suite
#############################################

---------------------------------------------
RenderComponentThroughput 10s
---------------------------------------------

failed to clear the 'main' log
error: more than one device/emulator
- waiting for device -
error: more than one device/emulator

It seems that the script creates a virtual device, but adb devices shows me only one device.

List of devices attached
2ab3abbb	device

Interestingly, when i unplug usb wire(script is still running), adb devices shows:

List of devices attached
emulator-5554	offline

I guess emulator-5554 and 2ab3abbb should both represent my device.
However, i'm perplexed that why the teminal shows me that error: more than one device/emulator.😞
Could you give me some inspiration?

[codyi96]

@Kudo This problem still exists:

2019-11-06 15:28:39.400 904-2201/? D/ActivityManager: killBackgroundProcesses() killing com.rnbenchmark.hermes from pid=16520, uid=2000
2019-11-06 15:28:39.531 904-2201/? I/ActivityManager: START u0 {act=android.intent.action.VIEW dat=rnbench://jsc/RenderComponentThroughput?interval=10000 flg=0x10000000 cmp=com.rnbenchmark.jsc/com.rnbenchmark.MainActivity} from uid 2000 pid 16527
2019-11-06 15:28:39.536 904-2201/? E/ANDR-PERF-JNI: com_qualcomm_qtiperformance_native_perf_io_prefetch_start
2019-11-06 15:28:39.536 720-720/? E/ANDR-IOP: IOP HAL: Received pkg_name = com.rnbenchmark.jsc pid = -1
2019-11-06 15:28:39.537 904-1730/? E/OnePlusSmartBoostManager: socket connect
2019-11-06 15:28:39.537 904-1730/? E/OnePlusSmartBoostManager: cmd: iop_start -1 com.rnbenchmark.jsc /data/app/com.rnbenchmark.jsc-kaGHa4dAraF9wVP6cF-OTg== false length = 93
2019-11-06 15:28:39.537 904-1730/? E/OnePlusSmartBoostManager: data: [B@d59b848 length = 93
2019-11-06 15:28:39.538 14647-16532/? E/ANDR-RAMBOOST_SERVER: ramboost cmd_len = 93 cmd: iop_start -1 com.rnbenchmark.jsc /data/app/com.rnbenchmark.jsc-kaGHa4dAraF9wVP6cF-OTg== false
2019-11-06 15:28:39.538 14647-16532/? E/ANDR-RAMBOOST_SERVER: is_in_recent_list is TRUE
2019-11-06 15:28:39.538 14647-16532/? E/ANDR-RAMBOOST_SERVER: io prefetch is deactivate
2019-11-06 15:28:39.548 720-792/? E/ANDR-IOP: io prefetch is disabled
2019-11-06 15:28:39.548 904-2201/? D/ActivityTrigger: activityStartTrigger: Activity is Triggerred in full screen ApplicationInfo{527c01d com.rnbenchmark.jsc}
2019-11-06 15:28:39.548 904-2201/? E/ActivityTrigger: activityStartTrigger: not whiteListedcom.rnbenchmark.jsc/com.rnbenchmark.MainActivity/1048577
2019-11-06 15:28:39.549 904-2201/? D/ActivityTrigger: activityResumeTrigger: The activity in ApplicationInfo{527c01d com.rnbenchmark.jsc} is now in focus and seems to be in full-screen mode
2019-11-06 15:28:39.549 904-2201/? E/ActivityTrigger: activityResumeTrigger: not whiteListedcom.rnbenchmark.jsc/com.rnbenchmark.MainActivity/1048577
2019-11-06 15:28:39.549 904-2201/? D/ActivityTrigger: ActivityTrigger activityPauseTrigger 
2019-11-06 15:28:39.552 3105-3105/? D/Launcher: onPause# hashcode: 149634337
2019-11-06 15:28:39.552 3105-3218/? I/WeatherProvider: un-subscribe the weather callback: 
2019-11-06 15:28:39.553 904-1774/? D/ActivityTrigger: activityResumeTrigger: The activity in ApplicationInfo{527c01d com.rnbenchmark.jsc} is now in focus and seems to be in full-screen mode
2019-11-06 15:28:39.553 904-1774/? E/ActivityTrigger: activityResumeTrigger: not whiteListedcom.rnbenchmark.jsc/com.rnbenchmark.MainActivity/1048577
2019-11-06 15:28:39.553 904-1147/? D/RestartProcessManager: Update Total Launch Times :com.rnbenchmark.jsc
2019-11-06 15:28:39.553 904-1147/? D/RestartProcessManager: updateSelf :  com.rnbenchmark.jsc, size : 30
2019-11-06 15:28:39.553 904-1147/? D/RestartProcessManager: Increase Total Launch Time : com.rnbenchmark.jsc, times : 1, index : 29
2019-11-06 15:28:39.553 904-1147/? D/RestartProcessManager: Last Running Package : com.rnbenchmark.jsc , start time 1573025319553
2019-11-06 15:28:39.566 904-1149/? I/ActivityManager: Start proc 16535:com.rnbenchmark.jsc/u0a631 for activity com.rnbenchmark.jsc/com.rnbenchmark.MainActivity
2019-11-06 15:28:39.571 16535-16535/? E/rnbenchmark.js: Not starting debugger since process cannot load the jdwp agent.
2019-11-06 15:28:39.582 904-2342/? D/OnePlusSmartBoostManager: writeHotCount com.rnbenchmark.jsc, pid=16535
2019-11-06 15:28:39.586 16535-16550/? I/rnbenchmark.js: The ClassLoaderContext is a special shared library.
2019-11-06 15:28:39.587 630-657/? E/CommandListener: CommandListener::FirewallCmd=[firewall,set_uid_rule,standby,10631,allow,] client pid = 904, uid = 1000, gid = 1000
2019-11-06 15:28:39.587 630-657/? E/FirewallController: FirewallController::setUidRule chain = 2, uid = 10631, rule = 1, firewallType = 1, mUseBpfOwnerMatch = 0
2019-11-06 15:28:39.587 630-657/? E/FirewallController: FirewallController::setUidRule command = *filter
    -D fw_standby -m owner --uid-owner 10631 -j DROP
    COMMIT
2019-11-06 15:28:39.590 742-2456/? D/AudioPolicyService: setRecordSilenced() uid 10631 on silenced 0
2019-11-06 15:28:39.602 16535-16535/? I/Perf: Connecting to perf service.
2019-11-06 15:28:39.606 16535-16535/? D/SoLoader: init start
2019-11-06 15:28:39.606 16535-16535/? D/SoLoader: adding system library source: /vendor/lib
2019-11-06 15:28:39.606 16535-16535/? D/SoLoader: adding system library source: /system/lib
2019-11-06 15:28:39.606 16535-16535/? D/SoLoader: adding application source: com.facebook.soloader.DirectorySoSource[root = /data/app/com.rnbenchmark.jsc-kaGHa4dAraF9wVP6cF-OTg==/lib/arm flags = 0]
2019-11-06 15:28:39.607 16535-16535/? D/SoLoader: adding backup source from : com.facebook.soloader.ApkSoSource[root = /data/data/com.rnbenchmark.jsc/lib-main flags = 1]
2019-11-06 15:28:39.607 16535-16535/? D/SoLoader: Preparing SO source: com.facebook.soloader.DirectorySoSource[root = /system/lib flags = 2]
2019-11-06 15:28:39.607 16535-16535/? D/SoLoader: Preparing SO source: com.facebook.soloader.DirectorySoSource[root = /vendor/lib flags = 2]
2019-11-06 15:28:39.607 16535-16535/? D/SoLoader: Preparing SO source: com.facebook.soloader.DirectorySoSource[root = /data/app/com.rnbenchmark.jsc-kaGHa4dAraF9wVP6cF-OTg==/lib/arm flags = 0]
2019-11-06 15:28:39.607 16535-16535/? D/SoLoader: Preparing SO source: com.facebook.soloader.ApkSoSource[root = /data/data/com.rnbenchmark.jsc/lib-main flags = 1]
2019-11-06 15:28:39.608 16535-16535/? V/fb-UnpackingSoSource: locked dso store /data/user/0/com.rnbenchmark.jsc/lib-main
2019-11-06 15:28:39.609 16535-16535/? V/fb-UnpackingSoSource: deps mismatch on deps store: regenerating
2019-11-06 15:28:39.609 16535-16535/? V/fb-UnpackingSoSource: so store dirty: regenerating
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libc++_shared.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libfb.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libfolly_futures.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libfolly_json.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libglog.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libglog_init.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libicu_common.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libimagepipeline.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libjsc.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libjscexecutor.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libjsinspector.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libnative-filters.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libnative-imagetranscoder.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libreactnativejni.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? D/ApkSoSource: not allowing consideration of lib/armeabi-v7a/libyoga.so: deferring to libdir
2019-11-06 15:28:39.622 16535-16535/? V/fb-UnpackingSoSource: regenerating DSO store com.facebook.soloader.ApkSoSource
2019-11-06 15:28:39.623 16535-16535/? V/fb-UnpackingSoSource: Finished regenerating DSO store com.facebook.soloader.ApkSoSource
2019-11-06 15:28:39.623 16535-16535/? V/fb-UnpackingSoSource: starting syncer worker
2019-11-06 15:28:39.630 16535-16535/? V/fb-UnpackingSoSource: releasing dso store lock for /data/user/0/com.rnbenchmark.jsc/lib-main (from syncer thread)
2019-11-06 15:28:39.630 16535-16535/? V/fb-UnpackingSoSource: not releasing dso store lock for /data/user/0/com.rnbenchmark.jsc/lib-main (syncer thread started)
2019-11-06 15:28:39.630 16535-16535/? D/SoLoader: init finish: 4 SO sources prepared
2019-11-06 15:28:39.630 16535-16535/? D/SoLoader: init exiting
2019-11-06 15:28:39.623 16535-16535/? W/com.tencent.mm:appbrand0: type=1400 audit(0.0:13950690): avc: denied { read } for comm=45474C20496E6974 name="u:object_r:vendor_default_prop:s0" dev="tmpfs" ino=22743 scontext=u:r:untrusted_app:s0:c119,c258,c512,c768 tcontext=u:object_r:vendor_default_prop:s0 tclass=file permissive=0
2019-11-06 15:28:39.633 16535-16555/? E/libc: Access denied finding property "vendor.debug.egl.profiler"
2019-11-06 15:28:39.623 16535-16535/? W/com.tencent.mm:appbrand0: type=1400 audit(0.0:13950691): avc: denied { read } for comm=45474C20496E6974 name="u:object_r:vendor_default_prop:s0" dev="tmpfs" ino=22743 scontext=u:r:untrusted_app:s0:c119,c258,c512,c768 tcontext=u:object_r:vendor_default_prop:s0 tclass=file permissive=0
2019-11-06 15:28:39.634 16535-16555/? E/libc: Access denied finding property "vendor.debug.prerotation.disable"
2019-11-06 15:28:39.646 16535-16535/? D/SoLoader: About to load: libjscexecutor.so
2019-11-06 15:28:39.646 16535-16535/? D/SoLoader: libjscexecutor.so not found on /data/data/com.rnbenchmark.jsc/lib-main
2019-11-06 15:28:39.646 16535-16535/? D/SoLoader: libjscexecutor.so found on /data/app/com.rnbenchmark.jsc-kaGHa4dAraF9wVP6cF-OTg==/lib/arm
2019-11-06 15:28:39.646 16535-16535/? D/SoLoader: Not resolving dependencies for libjscexecutor.so
2019-11-06 15:28:39.649 16535-16535/? E/SoLoader: couldn't find DSO to load: libjscexecutor.so caused by: dlopen failed: library "libgnustl_shared.so" not found
2019-11-06 15:28:39.649 16535-16535/? D/ReactNative: ReactInstanceManager.ctor()
2019-11-06 15:28:39.649 16535-16535/? D/SoLoader: init exiting
2019-11-06 15:28:39.651 16535-16535/? D/ReactNative: ReactInstanceManager.createReactContextInBackground()
2019-11-06 15:28:39.651 16535-16535/? D/ReactNative: ReactInstanceManager.recreateReactContextInBackgroundInner()
2019-11-06 15:28:39.651 16535-16535/? D/ReactNative: ReactInstanceManager.recreateReactContextInBackgroundFromBundleLoader()
2019-11-06 15:28:39.651 16535-16535/? D/ReactNative: ReactInstanceManager.recreateReactContextInBackground()
2019-11-06 15:28:39.651 16535-16535/? D/ReactNative: ReactInstanceManager.runCreateReactContextOnNewThread()
2019-11-06 15:28:39.651 16535-16556/? D/SoLoader: About to load: libhermes.so
2019-11-06 15:28:39.652 16535-16556/? D/SoLoader: libhermes.so not found on /data/data/com.rnbenchmark.jsc/lib-main
2019-11-06 15:28:39.652 16535-16556/? D/SoLoader: libhermes.so not found on /data/app/com.rnbenchmark.jsc-kaGHa4dAraF9wVP6cF-OTg==/lib/arm
2019-11-06 15:28:39.652 16535-16556/? D/SoLoader: libhermes.so not found on /vendor/lib
2019-11-06 15:28:39.652 16535-16556/? D/SoLoader: libhermes.so not found on /system/lib
2019-11-06 15:28:39.653 16535-16556/? E/SoLoader: couldn't find DSO to load: libhermes.so
    
    --------- beginning of crash
2019-11-06 15:28:39.653 16535-16556/? E/AndroidRuntime: FATAL EXCEPTION: create_react_context
    Process: com.rnbenchmark.jsc, PID: 16535
    java.lang.UnsatisfiedLinkError: couldn't find DSO to load: libhermes.so
        at com.facebook.soloader.SoLoader.doLoadLibraryBySoName(SoLoader.java:738)
        at com.facebook.soloader.SoLoader.loadLibraryBySoName(SoLoader.java:591)
        at com.facebook.soloader.SoLoader.loadLibrary(SoLoader.java:529)
        at com.facebook.soloader.SoLoader.loadLibrary(SoLoader.java:484)
        at com.facebook.hermes.reactexecutor.HermesExecutor.<clinit>(HermesExecutor.java:20)
        at com.facebook.hermes.reactexecutor.HermesExecutorFactory.create(HermesExecutorFactory.java:27)
        at com.facebook.react.ReactInstanceManager$5.run(ReactInstanceManager.java:949)
        at java.lang.Thread.run(Thread.java:764)

[Kudo]

@codyi96 Weird! Could you please provide the react native AAR in node_modules to me?

cd /path/to/react-native-js-benchmark
md5 node_modules/react-native/android/com/facebook/react/react-native/0.60.3/react-native-0.60.3.aar

The result should be

MD5 (node_modules/react-native/android/com/facebook/react/react-native/0.60.3/react-native-0.60.3.aar) = 4a105526b4c68eaa652dca92e9e66221

[codyi96]

@Kudo It's same to yours.

MD5 (node_modules/react-native/android/com/facebook/react/react-native/0.60.3/react-native-0.60.3.aar) = 4a105526b4c68eaa652dca92e9e66221

[codyi96]

@Kudo I found this code in tools.py:

gradle_prop += '--project-prop ' + maven_repo_prop

It's used to changed maven url of libraries.
However, I found that there is a directory called android-jsc in node_modules/jsc-android/... and no in js_dist/jsc_official_245459/.... I don't quite understand why u want to do this.

$ ll node_modules/jsc-android/dist/org/webkit
total 0
drwxr-xr-x  6 zou  staff   192B 11  5 17:55 android-jsc
drwxr-xr-x  6 zou  staff   192B 11  5 17:55 android-jsc-cppruntime
drwxr-xr-x  6 zou  staff   192B 11  6 20:49 android-jsc-intl

$ ll js_dist/jsc_official_245459/package/dist/org/webkit
total 0
drwxr-xr-x  6 zou  staff   192B 11  5 17:50 android-jsc-cppruntime
drwxr-xr-x  6 zou  staff   192B 11  5 17:50 android-jsc-intl

[codyi96]

@Kudo It works after cleaning the result of build and running again.
It may be that due to my error operation caused android-jsc directory is not existed. By the way, it may be more reasonable to create an empty js_dist directory in the project directory. Otherwise, the first time you run the script, you will be prompted ModuleNotFoundError: No module named 'js_dist'.
As for the more than one device/emulator problem, I temporarily added the -s parameter to specify the device, and I have not found a better solution so far.
Anyway, thank you very much!😀

[Kudo]

@codyi96

1. For js_dist, it was my fault and 990620d fixed this.

2. node_modules/jsc-android/... is unused and included from react-native node dependency.

3. more than one device/emulator: I am not going to support multiple devices in the meantime, sorry.
   Adding -s for you is not a bad idea or you could leave one device connected during the time to run benchmark.