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.

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

Already on GitHub? Sign in to your account

Crash on game startup #21

Closed
SkaterDad opened this issue Apr 5, 2020 · 2 comments
Closed

Crash on game startup #21

SkaterDad opened this issue Apr 5, 2020 · 2 comments

Comments

@SkaterDad
Copy link
Contributor

SkaterDad commented Apr 5, 2020

Hello! Thanks for all your great work on Defold and extensions. 馃憤

I wanted to integrate GPSP with my new game, and am having crashes immediately on startup on my phone.

I'm trying to use silent login & leaderboards.

Any ideas what is going on? I've included as much info as I knew how to attain. Happy to get more if needed.

These two error messages seem to be where it crashes:

04-05 09:26:33.362 10853 10876 E defold  : ERROR:GPGSEXT: Failed to parse JSON object(-1): (锟斤拷H)
--------- beginning of crash
04-05 09:26:33.363 10853 10876 F libc    : upload/gpgs/src/gpgs_callback.cpp:81: void gpgs_invoke_callback(MESSAGE_ID, char *): assertion "top == lua_gettop(L)" failed

Thanks!

Info

Defold editor: Latest (1.2.167). Also on 1.2.166
Build: Android
Device: Google Pixel 3a XL

Relevant parts of game.project

dependencies = https://github.com/rgrams/rendercam/archive/v1.0.2.zip,https://github.com/subsoap/defsave/archive/v1.2.1.zip,https://github.com/MaratGilyazov/def_ironsource/archive/1.2.zip,https://github.com/defold/extension-gpgs/archive/1.2.3.zip

[gpgs]
app_id = xxxxxxxxxxxxxx
use_saved_games = 0
request_server_auth_code = 0
request_id_token = 0

Code which I call from an init() lifecycle method. I don't see those prints in my logcat output.

local function callback(self, message_id, message)
	if message_id == gpgs.MSG_SILENT_SIGN_IN then
		if message.status == gpgs.STATUS_SUCCESS then
			msg.post("/mainmenu#main_menu", "gpgs_login")
		else
			gpgs.login()
		end
	elseif message_id == gpgs.MSG_SIGN_IN then
		if message.status == gpgs.STATUS_SUCCESS then
			msg.post("/mainmenu#main_menu", "gpgs_login")
		else
			msg.post("/mainmenu#main_menu", "gpgs_login_failed")
		end
	end
end

function M.init()
	if gpgs then
		gpgs.set_callback(callback)
		print("gpgs: init")
		gpgs.silent_login()
		print("gpgs: starting login")
	end
end

Logcat:

04-04 21:52:20.612  1497  1603 I ActivityManager: Start proc 28058:dev.skaterdad.tpmadness/u0a278 for activity {dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity}
04-04 21:52:20.619 28058 28058 E erdad.tpmadnes: Not starting debugger since process cannot load the jdwp agent.
04-04 21:52:20.653 28058 28058 W erdad.tpmadnes: resources.arsc in APK '/data/app/dev.skaterdad.tpmadness-yX4fq6KUnOCCowKDxM2OLg==/base.apk' is compressed.
04-04 21:52:20.659 28058 28058 I MultiDex: VM with version 2.1.0 has multidex support
04-04 21:52:20.660 28058 28058 I MultiDex: install
04-04 21:52:20.660 28058 28058 I MultiDex: VM has multidex support, MultiDex support library is disabled.
04-04 21:52:20.684 28058 28058 V threaded_app: Creating: 0x7d74087cc0
04-04 21:52:20.684 28058 28081 V threaded_app: Config: mcc=311 mnc=480 lang=en cnt=US orien=1 touch=3 dens=400 keys=1 nav=1 keysHid=3 navHid=0 sdk=29 size=2 long=2 modetype=1 modenight=1
04-04 21:52:20.685 28058 28081 V glfw-android: _glfwPreMain
04-04 21:52:20.688  8081  8104 I MicroDetectionState: Should stop hotword detection immediately - false
04-04 21:52:20.688 28058 28058 V threaded_app: Start: 0x7d74087cc0
04-04 21:52:20.688 28058 28081 V threaded_app: activityState=10
04-04 21:52:20.688 28058 28081 V glfw-android: handleCommand: APP_CMD_START
04-04 21:52:20.689 28058 28058 V threaded_app: Resume: 0x7d74087cc0
04-04 21:52:20.689 28058 28081 V threaded_app: activityState=11
04-04 21:52:20.689 28058 28081 V glfw-android: handleCommand: APP_CMD_RESUME
04-04 21:52:20.697 28058 28058 V threaded_app: InputQueueCreated: 0x7d74087cc0 -- 0x7d74087f40
04-04 21:52:20.697 28058 28081 V threaded_app: APP_CMD_INPUT_CHANGED
04-04 21:52:20.697 28058 28081 V threaded_app: Attaching input queue to looper
04-04 21:52:20.697 28058 28081 V glfw-android: handleCommand: APP_CMD_INPUT_CHANGED
04-04 21:52:20.707 28058 28058 V threaded_app: NativeWindowCreated: 0x7d74087cc0 -- 0x7e09787010
04-04 21:52:20.708 28058 28081 V threaded_app: APP_CMD_INIT_WINDOW
04-04 21:52:20.708 28058 28081 V glfw-android: handleCommand: APP_CMD_INIT_WINDOW
04-04 21:52:20.709 28058 28058 V threaded_app: WindowFocusChanged: 0x7d74087cc0 -- 1
04-04 21:52:20.724  1497  1600 I ActivityTaskManager: Displayed dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity: +154ms
04-04 21:52:20.724 28058 28081 V glfw-android: _glfwPlatformInit
04-04 21:52:20.726 28058 28081 V glfw-android: init_gl
04-04 21:52:20.726 28058 28081 I Adreno  : QUALCOMM build                   : 4a00b69, I4e7e888065
04-04 21:52:20.726 28058 28081 I Adreno  : Build Date                       : 04/09/19
04-04 21:52:20.726 28058 28081 I Adreno  : OpenGL ES Shader Compiler Version: EV031.26.06.00
04-04 21:52:20.726 28058 28081 I Adreno  : Local Branch                     :
04-04 21:52:20.726 28058 28081 I Adreno  : Remote Branch                    :
04-04 21:52:20.726 28058 28081 I Adreno  : Remote Branch                    :
04-04 21:52:20.726 28058 28081 I Adreno  : Reconstruct Branch               :
04-04 21:52:20.726 28058 28081 I Adreno  : Build Config                     : S P 8.0.6 AArch64
04-04 21:52:20.730 28058 28081 I Adreno  : PFP: 0x016ee183, ME: 0x00000000
04-04 21:52:20.736 28058 28081 V glfw-android: create_gl_aux_context..
04-04 21:52:20.737 28058 28081 V glfw-android: create_gl_aux_context success
04-04 21:52:20.737 28058 28081 V glfw-android: _glfwPlatformOpenWindow
04-04 21:52:20.737 28058 28081 V glfw-android: create_gl_surface
04-04 21:52:20.738   882   882 D android.hardware.power@1.3-service.pixel-libperfmgr: LAUNCH: 0
04-04 21:52:20.760 28058 28081 E defold.sound: App is missing the READ_PHONE_STATE permission. Audio will continue while phone call is active.
04-04 21:52:20.760 28058 28089 E GooglePlayServicesUtil: The Google Play services resources were not found. Check your project configuration to ensure that the resources are included.
04-04 21:52:20.766 28058 28081 W libOpenSLES: No channel mask specified; Using mask 0x3 based on requestedspeaker count of 2
04-04 21:52:20.766 28058 28081 D         : PlayerBase::PlayerBase()
04-04 21:52:20.766 28058 28081 D         : TrackPlayerBase::TrackPlayerBase()
04-04 21:52:20.766 28058 28081 I libOpenSLES: Emulating old channel mask behavior (ignoring positional mask 0x3, using default mask 0x3 based on channel count of 2)
04-04 21:52:20.770   907 12636 D AudioFlinger: Client defaulted notificationFrames to 96 for frameCount 576
04-04 21:52:20.771   907 12636 D AF::TrackHandle: OpPlayAudio: track:6038 usage:1 not muted
04-04 21:52:20.773 28058 28081 I AudioTrack: createTrack_l(0): AUDIO_OUTPUT_FLAG_FAST successful; frameCount 0 -> 576
04-04 21:52:20.816   580   580 I hwservicemanager: getTransport: Cannot find entry android.hardware.graphics.mapper@3.0::IMapper/default in either framework or device manifest.
04-04 21:52:20.817 28058 28081 W Gralloc3: mapper 3.x is not supported
04-04 21:52:20.821 28058 28081 V glfw-android: handleCommand: APP_CMD_GAINED_FOCUS
04-04 21:52:21.002 28058 28058 E GooglePlayServicesUtil: The Google Play services resources were not found. Check your project configuration to ensure that the resources are included.
04-04 21:52:21.028 28058 28081 I IntegrationHelper: Verifying Integration:
04-04 21:52:21.028 28058 28081 I IntegrationHelper: *** Permissions ***
04-04 21:52:21.029 28058 28081 I IntegrationHelper: android.permission.INTERNET - VERIFIED
04-04 21:52:21.029 28058 28081 I IntegrationHelper: android.permission.ACCESS_NETWORK_STATE - VERIFIED
04-04 21:52:21.033 22426   690 W GamesServiceBroker: Client connected with SDK 200914000, Services 200914000, Stub module 65579999, and Games 0
04-04 21:52:21.033 28058 28081 I IntegrationHelper: com.ironsource.sdk.controller.InterstitialActivity - VERIFIED
04-04 21:52:21.033 22426   690 W GamesServiceBroker: Launching Play games upgrade activity

04-04 21:52:21.040 28058 28107 W IntegrationHelper: --------------- Google Play Services --------------
04-04 21:52:21.041 28058 28107 I IntegrationHelper: Google Play Services - VERIFIED
04-04 21:52:21.042 22426 22509 I PeopleChimeraService: onService. callbacks = aagj@576c4c6, request = com.google.android.gms.common.internal.GetServiceRequest@aaa4c87
--------- beginning of crash
04-04 21:52:21.043 28058 28081 F libc    : upload/gpgs/src/gpgs_callback.cpp:81: void gpgs_invoke_callback(MESSAGE_ID, char *): assertion "top == lua_gettop(L)" failed
04-04 21:52:21.045 28058 28106 D NetworkSecurityConfig: No Network Security Config specified, using platform default
04-04 21:52:21.058  2925  2925 I Elmyra/ElmyraService: Gated by NavigationBarVisibility [mIsNavigationHidden -> true; mExceptions -> [DismissTimer [mReceiverRegistered -> true], SnoozeAlarm [mReceiverRegistered -> true], SilenceCall [mSilenceSettingEnabled -> true], SettingsAction]; mIsNavigationGestural -> false; isActiveAssistantNga() -> false]
04-04 21:52:21.059   866   866 V ContextHubHal: sendMessageToHub
04-04 21:52:21.059 28058 28081 I defold  : INFO:CRASH: Successfully wrote Crashdump to file: /data/user/0/dev.skaterdad.tpmadness/files/_crash
04-04 21:52:21.059 28058 28081 E defold  : ERROR:CRASH: CALL STACK:
04-04 21:52:21.059 28058 28081 E defold  :
04-04 21:52:21.059 28058 28081 E defold  : # 0 pc        0x8bc [vdso] <unknown>+0
04-04 21:52:21.059 28058 28081 E defold  : # 1 pc      0x41f70 ...oid.runtime/lib64/bionic/libc.so abort+156
04-04 21:52:21.059 28058 28081 E defold  :
04-04 21:52:21.059 28058 28081 E defold  :
04-04 21:52:21.060   883  1154 D CHRE    : @ 1913766.063: Parsed nanoapp message from host: app ID 0x476f6f676c00100e, endpoint 0x1, msgType 201, payload size 0
04-04 21:52:21.096  1497  2099 W InputDispatcher: channel 'a0aa997 dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x9
04-04 21:52:21.096  1497  2099 E InputDispatcher: channel 'a0aa997 dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
04-04 21:52:21.097  1497  2851 I WindowManager: WIN DEATH: Window{a0aa997 u0 dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity}
04-04 21:52:21.097  1497  2851 W InputDispatcher: Attempted to unregister already unregistered input channel 'a0aa997 dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity (server)'
04-04 21:52:21.097  1497 14223 I ActivityManager: Process dev.skaterdad.tpmadness (pid 28058) has died: fore TOP
04-04 21:52:21.097  1497  1604 I libprocessgroup: Successfully killed process cgroup uid 10278 pid 28058 in 0ms
04-04 21:52:21.098 13218 13218 V AvrcpMediaPlayerList: onPlaybackConfigChanged(): Configs list size=6
04-04 21:52:21.099   850   850 I Zygote  : Process 28058 exited due to signal 6 (Aborted)
04-04 21:52:21.101  1497 14223 W ActivityTaskManager: Force removing ActivityRecord{476a645 u0 dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity t1686}: app died, no saved state
04-04 21:52:21.101   793 28109 E ResolverController: No valid NAT64 prefix (385, <unspecified>/0)
04-04 21:52:21.102   793 28109 W SocketClient: write error (Broken pipe)

Logcat from a DEBUG build:

04-05 09:26:33.361 10853 10876 E defold  : ERROR:DLIB: ../src/dlib/socket.cpp( 94 ): SOCKET: Unknown result code 1
04-05 09:26:33.361 10853 10876 E defold  :
04-05 09:26:33.361 10853 10876 W defold  : WARNING:DLIB: Failed to send announce message (-1000)
04-05 09:26:33.362 10853 10876 E defold  : ERROR:GPGSEXT: Failed to parse JSON object(-1): (锟斤拷H)
--------- beginning of crash
04-05 09:26:33.363 10853 10876 F libc    : upload/gpgs/src/gpgs_callback.cpp:81: void gpgs_invoke_callback(MESSAGE_ID, char *): assertion "top == lua_gettop(L)" failed
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 513, path = 0, app id = 0x11130, sample rate = 48000
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> send_asm_topology
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> send_adm_topology
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> send_audtable
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE_SIZE
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TABLE
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> send_audvoltable
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_VOL_STEP_TABLE_SIZE
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE, vol index 0
04-05 09:26:33.383   860 17912 D         : Failed to fetch the lookup information of the device 00000201
04-05 09:26:33.383   860 17912 E ACDB-LOADER: Error: ACDB AudProc vol returned = -19
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_SIZE
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> send_audstrmtable
04-05 09:26:33.383   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TABLE_V2
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 488
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> send_afe_topology
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 513, Topology Id 10000ccc
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> send_afe_cal
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE_SIZE
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_COMMON_TABLE
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 513 path = 0
04-05 09:26:33.384   860 17912 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
04-05 09:26:33.384   860 17912 D audio_hw_primary: enable_audio_route: usecase(5) apply and update mixer path: audio-ull-playback speaker
04-05 09:26:33.384   860 17912 D audio_route: Apply path: audio-ull-playback speaker
04-05 09:26:33.439   860 17912 D audio_hw_primary: out_write: retry previous failed cal level set
04-05 09:26:33.439   882   882 D android.hardware.power@1.3-service.pixel-libperfmgr: AUDIO_STREAMING: 0
04-05 09:26:33.439   860 17912 W msm8974_platform: platform_send_gain_dep_cal: Usecase list is empty
04-05 09:26:33.439   860 17912 W qc_adm  : margin check: adm_request_focus_v2(p) failed diff -240
04-05 09:26:33.439   882   882 D android.hardware.power@1.3-service.pixel-libperfmgr: AUDIO_LOW_LATENCY: 1
04-05 09:26:33.439   860 17912 W qc_adm  : margin check: adm_abandon_focus(p) failed diff -240
04-05 09:26:33.467   860 17912 D qc_adm  : ns 1581612 > expected_ns 1000000 (skipped 0)
04-05 09:26:33.479   860 17912 D qc_adm  : ns 1569528 > expected_ns 1000000 (skipped 0)
04-05 09:26:33.497   860 17912 D qc_adm  : ns 1557703 > expected_ns 1000000 (skipped 0)
04-05 09:26:33.501   860 17912 D qc_adm  : ns 1539786 > expected_ns 1000000 (skipped 0)
04-05 09:26:33.504 10853 10876 I defold  : INFO:CRASH: Successfully wrote Crashdump to file: /data/user/0/dev.skaterdad.tpmadness/files/_crash
04-05 09:26:33.504 10853 10876 E defold  : ERROR:CRASH: CALL STACK:
04-05 09:26:33.504 10853 10876 E defold  :
04-05 09:26:33.504 10853 10876 E defold  : # 0 pc        0x8bc [vdso] <unknown>+0
04-05 09:26:33.504 10853 10876 E defold  : # 1 pc      0x41f70 ...oid.runtime/lib64/bionic/libc.so abort+156
04-05 09:26:33.504 10853 10876 E defold  :
04-05 09:26:33.504 10853 10876 E defold  :
04-05 09:26:33.543  1497  2099 W InputDispatcher: channel '47bca0c dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity (server)' ~ Consumer closed input channel or an error occurred.  events=0x9
04-05 09:26:33.543  1497  2099 E InputDispatcher: channel '47bca0c dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
04-05 09:26:33.544  1497  5972 I WindowManager: WIN DEATH: Window{47bca0c u0 dev.skaterdad.tpmadness/com.dynamo.android.DefoldActivity}
04-05 09:26:33.544  1497  2976 I ActivityManager: Process dev.skaterdad.tpmadness (pid 10853) has died: fore TOP

Update: Removing the Ironsource extension removed the crash, so there may be some kind of conflict?

@britzl
Copy link
Contributor

britzl commented Apr 5, 2020

This indicates a broken Lua callstack. It could possibly be caused by this extension but also by IronSource that you were using.

void gpgs_invoke_callback(MESSAGE_ID, char *): assertion "top == lua_gettop(L)" failed

@SkaterDad
Copy link
Contributor Author

Closing this if you're okay with it. I'm not going to be using that Ironsource extension anymore.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

2 participants