NaCl module didn't load

[qaisjp]

chrome://gpu: https://dl.dropboxusercontent.com/u/40656329/GitHub/binji-lovenacl/issue%2027/gpu.htm chrome://version: https://dl.dropboxusercontent.com/u/40656329/GitHub/binji-lovenacl/issue%2027/About%20Version.htm

[miko]

Hello, it works for me with chrome 29, but stops working with chrome 30 with the same exact error ("NaCl module didn't load"). It works again when downgraded to chrome 29, so it is not a OS issue (I am running archlinux). Until now it worked for me for all versions of chrome.

Below are diffs for chrome://version and chrome://gpu:

--- chrome_29_version.txt   2013-10-11 02:24:42.363074737 +0200
+++ chrome_30_version.txt   2013-10-11 02:26:10.080564395 +0200
@@ -1,20 +1,20 @@
-Chromium   29.0.1547.76 (Developer Build 223446) 
+Chromium   30.0.1599.66 (Developer Build 225456) 
 OS Linux 
-Blink  537.36 (@156722)
-JavaScript V8 3.19.18.23
+Blink  537.36 (@158213)
+JavaScript V8 3.20.17.13
 Flash  11.2 r202
-User Agent Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like 
Gecko) Chrome/29.0.1547.76 Safari/537.36
+User Agent Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like 
Gecko) Chrome/30.0.1599.66 Safari/537.36
 Command Line    /usr/lib/chromium/chromium --flag-switches-begin --enable-accel
erated-filters --disable-accelerated-2d-canvas --disable-webgl --enable-css-shad
ers --enable-devtools-experiments --enable-nacl --enable-opus-playback --enable-
usermedia-screen-capturing --ignore-gpu-blacklist --performance-monitor-gatherin
g --flag-switches-end
 Executable Path    /usr/lib/chromium/chromium
 Profile Path   /home/miko/.config/chromium/Default
 Variations b03ddc1f-2d9ef0cc
 f9b252d0-fd526c81
 262f996f-eeefeb17
-24dca50e-4bb3e394
-82d91892-3f4a17df
-246fb659-4c073154
+24dca50e-455c9cca
+246fb659-7158671e
 f296190c-9521b951
 4442aae2-6e3b1976
+ed1d377-e1cc0f14
 75f0f0a0-6bdfffe7
 e2b18481-e1cc0f14
 e7e71889-4ad60575

--- chrome_29_gpu.txt   2013-10-11 02:25:03.439975431 +0200
+++ chrome_30_gpu.txt   2013-10-11 02:26:24.337330986 +0200
@@ -20,15 +20,15 @@
 set_texture_filter_before_generating_mipmap
 use_current_program_after_successful_link
 Version Information
-Data exported  10/11/2013, 2:23:41 AM
-Chrome version Chrome/29.0.1547.76
+Data exported  10/11/2013, 2:25:46 AM
+Chrome version Chrome/30.0.1599.66
 Operating system   Linux 3.11.4-1-ARCH
 Software rendering list version    0
-Driver bug list version    2.1
-ANGLE revision 2424
+Driver bug list version    2.6
+ANGLE revision 2431
 2D graphics backend    Skia
 Driver Information
-Initialization time    61
+Initialization time    81
 Sandboxed  true
 GPU0   VENDOR = 0x10de, DEVICE= 0x0dfc
 GPU1   VENDOR = 0x8086, DEVICE= 0x0166
@@ -48,3 +48,4 @@
 Window system binding vendor   SGI
 Window system binding version  1.4
 Window system binding extensions   GLX_ARB_create_context GLX_ARB_create_co
ntext_profile GLX_ARB_multisample GLX_EXT_create_context_es2_profile GLX_EXT_imp
ort_context GLX_EXT_texture_from_pixmap GLX_EXT_visual_info GLX_EXT_visual_ratin
g GLX_MESA_copy_sub_buffer GLX_OML_swap_method GLX_SGI_swap_control GLX_SGIS_mul
tisample GLX_SGIX_fbconfig GLX_SGIX_pbuffer GLX_SGIX_visual_select_group GLX_INT
EL_swap_event
+Reset notification strategy    0x8261

[binji]

Miko: what happens when you run the test? Click the green guy character and choose "test" from the popup.

[miko]

Chrome 30:

Testing LÖVELINESS

Looking for NaCl plugin ✓
Trying NaCl plugin  ✕
Error
NaCl module didn't load

Chrome 29:

Testing LÖVELINESS

Looking for NaCl plugin ✓
Trying NaCl plugin  ✓
Trying WebGL    ✕
Error
Couldn't get a WebGL context from canvas.

[binji]

I've updated LÖVELINESS to version 0.2.4. When you get that, run the test again. It should give more information about the failure.

[miko]

I got:

Testing LÖVELINESS

Looking for NaCl plugin ✓
Trying NaCl plugin  ✕
Error
LÖVELINESS version 0.2.4
NaCl Module load error: NaCl module load failed: Nexe crashed during startup

The other difference is that I get the error immediately, while in 0.2.3 the message "Trying NaCl plugin" was waiting like 2-3 seconds before the error.

I have just noticed that on the console I get:

** Signal 11 from untrusted code: pc=87f0fcede12

(of course the pc address changes each time)

[miko]

This may be interesting for you:

$ NACL_DEBUG_ENABLE=1 PPAPI_BROWSER_DEBUG=1 NACL_PLUGIN_DEBUG=1 NACL_PPAPI_PROXY_DEBUG=1 NACL_SRPC_DEBUG=50 NACLVERBOSITY=50 chromium

[35,1188579072:21:32:55.002419] only received 0 (0x0) bytes, but internal header is 16 (0x10) bytes
[35,1188579072:21:32:55.002563] NaClImcRecvTypedMsg: returning -5
[SRPC:HOST:35,1188579072:21:32:55.002673] MessageChannelBufferFirstFragment: read failed (-5).
[SRPC:HOST:35,1188579072:21:32:55.002787] MessageChannelBufferRead: couldn't buffer.
[SRPC:HOST:35,1188579072:21:32:55.002901] NaClSrpcMessageChannelPeek: read failed (-1).
[SRPC:HOST:35,1188579072:21:32:55.003015] NaClSrpcRpcWait(channel=0x7ff730001100): loop done: (nil), 3
[SRPC:HOST:35,1188579072:21:32:55.003059] NaClSrpcRpcWait(channel=0x7ff730001100): rpc is NULL (this is not an error)
[SRPC:HOST:35,1188579072:21:32:55.003103] ServerLoop(service=0x7ff7300008c0, socket_desc=0x7ff76143fc50, instance_data=0x7ff7613613b0) done
[SRPC:HOST:35,1188579072:21:32:55.003143] NaClSrpcDtor(channel=0x7ff730001100)
[SRPC:HOST:35,1188579072:21:32:55.003252] NaClSrpcChannelDtorHelper(channel=0x7ff730001100)
[35,1188579072:21:32:55.003328] NaClRefCountUnref(0x7ff76143fc50).
[35,1188579072:21:32:55.003397] NaClSimpleRevServiceRpcHandler: NaClSrpcServerLoop returned 1
[35,1188579072:21:32:55.003438] PluginReverseInterface::ReportCrash
[35,1188579072:21:32:55.003467] PluginReverseInterface::ReportCrash: invoking CB
PLUGIN 1381951975003518: Plugin::NexeDidCrash (pp_error=0)
PLUGIN 1381951975003535: Plugin::NexeDidCrash: crash event!
[35,1188579072:21:32:55.003507] Leaving NaClSimpleRevServiceRpcHandler
[35,1188579072:21:32:55.003557] Leaving ConnRpcBase
[35,1188579072:21:32:55.003598] NaClRefCountUnref(0x7ff76142a0a0).
[35,1188579072:21:32:55.003638] NaClRefCountDtor(0x7ff76142a0a0), refcount 0, destroying.
[35,1188579072:21:32:55.003677] NaClThreadInterfaceStart: thread object 0x7ff761433320 returned 0x0.
[35,1188579072:21:32:55.003717] NaClReverseThreadIfExit: thread 0x7ff761433320 is exiting

and so on

[miko]

Now, the sad news is that after downgrading chromium to 0.29 the 0.2.4 version does not work. How do I get my 0.2.3 version back ;(

Anyways, for chromium 0.29 I get different output:

Looking for NaCl plugin ✓
Trying NaCl plugin  ✕
Error
LÖVELINESS version 0.2.4
NaCl module started loading, but didn't finish.

and from console (with env settings like before):

MODULE: ModulePpapi::CreateInstance (pp_instance=-521057099)
PLUGIN 1381952368475291: Plugin::New (pp_instance=-521057099)
PLUGIN 1381952368475305: Plugin::Plugin (this=0x7ff345bd9880, pp_instance=-52105
7099)
PLUGIN 1381952368475310: FileDownloader::FileDownloader (this=0x7ff345bd9958)
PLUGIN 1381952368475327: Plugin::New (plugin=0x7ff345bd9880)
MODULE: ModulePpapi::CreateInstance (return 0x7ff345bd9880)
PLUGIN 1381952368475333: Plugin::Init (argc=4)
PLUGIN 1381952368475360: ScriptablePlugin::NewPlugin (plugin=0x7ff345bd9880)
PLUGIN 1381952368475364: ScriptablePlugin::ScriptablePlugin (this=0x7ff345dd7cc0
, plugin=0x7ff345bd9880)
PLUGIN 1381952368475366: ScriptablePlugin::NewPlugin (return 0x7ff345dd7cc0)
PLUGIN 1381952368475368: Plugin::Init (scriptable_handle=0x7ff345dd7cc0)
PLUGIN 1381952368475373: Plugin::Init (url_util_=0x7ff32bbc14d0)
PLUGIN 1381952368475375: Plugin::Init (instance=0x7ff345bd9880)
PLUGIN 1381952368475389: Plugin::Init (wrapper_factory=0x7ff345dbd1f0)
PLUGIN 1381952368475392: Plugin::AddPropertyGet (prop_name='exitStatus')
PLUGIN 1381952368475396: Plugin::AddPropertyGet (prop_name='lastError')
PLUGIN 1381952368475398: Plugin::AddPropertyGet (prop_name='readyState')
PLUGIN 1381952368475401: Plugin::Init (return 1)
PLUGIN 1381952368475409: Plugin::RequestNaClManifest (url='test_release.nmf')
PLUGIN 1381952368475412: Plugin::RequestNaClManifest (plugin base url='chrome-ex
tension://mompnkcmpbopandjnddeecgeeojegohc/test.html')
PLUGIN 1381952368475422: Plugin::RequestNaClManifest (resolved url='chrome-exten
sion://mompnkcmpbopandjnddeecgeeojegohc/test_release.nmf')
PLUGIN 1381952368475431: Plugin::EnqueueProgressEvent (event_type='loadstart', u
rl='', length_computable=0, loaded=0, total=0)
PLUGIN 1381952368475449: FileDownloader::Open (url=chrome-extension://mompnkcmpb
opandjnddeecgeeojegohc/test_release.nmf)
PLUGIN 1381952368475617: FileDownloader::Open (pp_error=-1)
PLUGIN 1381952368475624: Plugin::Init (status=1)
PLUGIN 1381952368477626: Plugin::DispatchProgressEvent (result=0)
PLUGIN 1381952368477638: Plugin::DispatchProgressEvent (event_type='loadstart', 
url='', length_computable=0, loaded=0, total=0)
PLUGIN 1381952368477971: Plugin::GetInstanceObject (this=0x7ff345bd9880)
PLUGIN 1381952368477981: ScriptablePlugin::AddRef (this=0x7ff345dd7cc0, var=0x7f
f345cdb6d0)
PLUGIN 1381952368477984: Plugin::GetInstanceObject (handle=0x7ff345dd7cc0, handl
e_var=0x7ff345cdb6d0)
PLUGIN 1381952368478011: ScriptablePlugin::HasProperty (this=0x7ff345dd7cc0, nam
e=Var<'dispatchEvent'>)
PLUGIN 1381952368478017: Plugin::HasProperty (prop_name=dispatchEvent)
PLUGIN 1381952368478020: ScriptablePlugin::HasProperty (has_property=0)
PLUGIN 1381952368478024: ScriptablePlugin::HasMethod (this=0x7ff345dd7cc0, name=
'Var<'dispatchEvent'>')
PLUGIN 1381952368478358: FileDownloader::URLLoadStartNotify (pp_error=0)
PLUGIN 1381952368478374: FileDownloader::InitialResponseIsValid (chrome-extensio
n response status_code=200)
PLUGIN 1381952368478380: FileDownloader::FinishStreaming (async_notify_ok=1)
PLUGIN 1381952368478408: FileDownloader::URLLoadFinishNotify (pp_error=0)
PLUGIN 1381952368478416: FileDownloader::URLLoadFinishNotify (full_url=Var<'chro
me-extension://mompnkcmpbopandjnddeecgeeojegohc/test_release.nmf'>)
PLUGIN 1381952368478467: FileDownloader::URLLoadFinishNotify (async_notify_ok=1)
PLUGIN 1381952368478675: FileDownloader::StreamFinishNotify (pp_error=0)
PLUGIN 1381952368478682: Plugin::NaClManifestFileDidOpen (pp_error=0)
PLUGIN 1381952368478741: Plugin::NaClManifestFileDidOpen (file_desc=24)
PLUGIN 1381952368478789: Plugin::SetManifestObject(): manifest_json='{
  "files": {},
  "program": {
    "x86-64": {
      "url": "test_x86_64_release.nexe"
    },
    "arm": {
      "url": "test_arm_release.nexe"
    },
    "x86-32": {
      "url": "test_x86_32_release.nexe"
    }
  }
}
'.
PLUGIN 1381952368478842: Plugin::EnqueueProgressEvent (event_type='progress', ur
l='', length_computable=0, loaded=0, total=0)
PLUGIN 1381952368631311: FileDownloader::OpenFast (url=chrome-extension://mompnk
cmpbopandjnddeecgeeojegohc/test_x86_64_release.nexe)
PLUGIN 1381952368631328: Plugin::NexeFileDidOpen (pp_error=0)
PLUGIN 1381952368631332: Plugin::NexeFileDidOpen (file_desc=25)
PLUGIN 1381952368631429: Plugin::EnqueueProgressEvent (event_type='progress', ur
l='chrome-extension://mompnkcmpbopandjnddeecgeeojegohc/test_x86_64_release.nexe'
, length_computable=1, loaded=658640, total=658640)
PLUGIN 1381952368631590: Plugin::ShutDownSubprocesses (this=0x7ff345bd9880)
PLUGIN 1381952368631594: Plugin::ShutDownSubprocesses (main subprocess={ this=0x
7ff345bd98e0, srpc_client=0, service_runtime=0 })
PLUGIN 1381952368631664: Plugin::ShutDownSubprocess (this=0x7ff345bd9880, return
)
PLUGIN 1381952368631669: Plugin::LoadNaClModuleCommon (service_runtime=0x7ff345d
97600)
PLUGIN 1381952369155053: Plugin::LoadNaClModuleCommon (service_runtime_started=1
)
PLUGIN 1381952369155063: Plugin::LoadNaClModule (main subprocess={ this=0x7ff345
bd98e0, srpc_client=0, service_runtime=0x7ff345d97600 })
PLUGIN 1381952369155220: Plugin::DispatchProgressEvent (result=0)
PLUGIN 1381952369155224: Plugin::DispatchProgressEvent (event_type='progress', u
rl='', length_computable=0, loaded=0, total=0)
PLUGIN 1381952369155392: ScriptablePlugin::HasProperty (this=0x7ff345dd7cc0, nam
e=Var<'dispatchEvent'>)
PLUGIN 1381952369155400: Plugin::HasProperty (prop_name=dispatchEvent)
PLUGIN 1381952369155403: ScriptablePlugin::HasProperty (has_property=0)
PLUGIN 1381952369155406: ScriptablePlugin::HasMethod (this=0x7ff345dd7cc0, name=
'Var<'dispatchEvent'>')
PLUGIN 1381952369161870: Plugin::DispatchProgressEvent (result=0)
PLUGIN 1381952369161897: Plugin::DispatchProgressEvent (event_type='progress', u
rl='chrome-extension://mompnkcmpbopandjnddeecgeeojegohc/test_x86_64_release.nexe
', length_computable=1, loaded=658640, total=658640)
PLUGIN 1381952369162108: ScriptablePlugin::HasProperty (this=0x7ff345dd7cc0, nam
e=Var<'dispatchEvent'>)
PLUGIN 1381952369162120: Plugin::HasProperty (prop_name=dispatchEvent)
PLUGIN 1381952369162123: ScriptablePlugin::HasProperty (has_property=0)
PLUGIN 1381952369162129: ScriptablePlugin::HasMethod (this=0x7ff345dd7cc0, name=
'Var<'dispatchEvent'>')
PLUGIN 1381952371447025: Plugin::~Plugin (this=0x7ff345bd9880, scriptable_plugin
=0x7ff345dd7cc0)
PLUGIN 1381952371447075: ScriptablePlugin::Unref (this=0x7ff345dd7cc0, var=0x7ff
345cdb6d0)
PLUGIN 1381952371447078: ScriptablePlugin::Unref (delete var)
PLUGIN 1381952371447082: ScriptablePlugin::~ScriptablePlugin (this=0x7ff345dd7cc
0)
PLUGIN 1381952371447084: ScriptablePlugin::~ScriptablePlugin (this=0x7ff345dd7cc
0, return)
PLUGIN 1381952371447087: Plugin::ShutDownSubprocesses (this=0x7ff345bd9880)
PLUGIN 1381952371447089: Plugin::ShutDownSubprocesses (main subprocess={ this=0x
7ff345bd98e0, srpc_client=0, service_runtime=0x7ff345d97600 })
PLUGIN 1381952371478091: Plugin::ShutDownSubprocess (this=0x7ff345bd9880, return
)
PLUGIN 1381952371478146: Plugin::~Plugin (this=0x7ff345bd9880, return)

[miko]

I tried to build this app locally, but even then it does not work. I can send out outputs of: NACL_DEBUG_ENABLE=1 PPAPI_BROWSER_DEBUG=1 NACL_PLUGIN_DEBUG=1 NACL_PPAPI_PROXY_DEBUG=1 NACL_SRPC_DEBUG=255 NACLVERBOSITY=255 make run-package > /tmp/out.log 2>/tmp/err.log (as it writes more data on stderr). It is a lot of data, so I will not paste it here, except a few last lines from stderr:

[15,3817010944:06:28:50.270597] NaClStartThreadInApp: secure stack:   0x7f69e382e
d18
[15,3817010944:06:28:50.270602] NaClStartThreadInApp: adjusted stack: 0x7f69e382e
d00
[15,3817010944:06:28:50.270605] NaClStackThreadInApp: user stack: 0x4de4fffeff48
[15,3817010944:06:28:50.270609] NaClStartThreadInApp: switching to untrusted code
[15,3817010944:06:28:50.270624] Entering syscall 71: return address 0x4de40fa04e4
0
[15,3817010944:06:28:50.270631] Entered NaClSysMutexLock(0x7f69e503b540, 10563386
76)
[15,3817010944:06:28:50.270637] Returning from syscall 71: return value -9 (0xfff
ffff7)

** Signal 11 from untrusted code: pc=4de40fcede12
[10,3675485952:08:28:50.272030] only received 0 (0x0) bytes, but internal header 
is 16 (0x10) bytes

BTW, you can add to readme that python2 is required, and python3 is not supported. I had to make this fix to compile it:

mkdir /tmp/bin; ln -s /usr/bin/python2 /tmp/bin/python; export PATH=/tmp/bin:$PATH

[miko]

OK, good news - the compiled version works (even with WebGL, which did not work before) when chromium is downgraded to version 29. Here are the diffs between stdout and stderr for both 29 and 30:

stdout:

PLUGIN 1381991330227640: Plugin::LoadNaClModuleCommon (service_runtime=0x7f75e0d
e83c0)
PLUGIN 1381991330237150: Plugin::LoadNaClModuleCommon (service_runtime_started=1
)
PLUGIN 1381991330259968: Plugin::LoadNaClModuleCommon (nexe_loaded=1)
PLUGIN 1381991330259977: Plugin::LoadNaClModule (main subprocess={ this=0x7f75e0
e44990, srpc_client=0, service_runtime=0x7f75e0de83c0 })
PLUGIN 1381991330260140: Plugin::DispatchProgressEvent (result=0)

and:

PLUGIN 1381992247818057: Plugin::LoadNaClModuleCommon (service_runtime=0x7f61e18
1f150)
PLUGIN 1381992247857042: Plugin::LoadNaClModuleCommon (service_runtime_started=1
)
PLUGIN 1381992247857048: Plugin::LoadNaClModule (main subprocess={ this=0x7f61e1
882380, srpc_client=0, service_runtime=0x7f61e181f150 })
PLUGIN 1381992247857213: Plugin::DispatchProgressEvent (result=0)

(note: missing "nexe_loaded=1" line)

then: PLUGIN 1381992247865304: ScriptablePlugin::HasMethod (this=0x7f61e18d0c20, name= 'Var<'dispatchEvent'>') PLUGIN 1381992247949729: SrpcClient::SrpcClient (this=0x7f61e187cbc0) PLUGIN 1381992247949734: SrpcClient::Init (this=0x7f61e187cbc0, wrapper=0x7f61e1 852950) PLUGIN 1381992248018961: SrpcClient::Init (Ctor worked) PLUGIN 1381992248018965: SrpcClient::GetMethods (this=0x7f61e187cbc0) PLUGIN 1381992248018969: SrpcClient::Init (GetMethods worked) PLUGIN 1381992248020655: Plugin::LoadNaClModule (main subprocess={ this=0x7f61e1 882380, srpc_client=0x7f61e187cbc0, service_runtime=0x7f61e181f150 }) PLUGIN 1381992248020810: Plugin::EnqueueProgressEvent (event_type='load', url='c hrome-extension://mompnkcmpbopandjnddeecgeeojegohc/test_x86_64_release.nexe', le ngth_computable=1, loaded=658640, total=658640) and:

PLUGIN 1381991330267726: ScriptablePlugin::HasMethod (this=0x7f75e0ee2110, name=
'Var<'dispatchEvent'>')
PLUGIN 1381991330272519: Plugin::NexeDidCrash (pp_error=0)
PLUGIN 1381991330272525: Plugin::NexeDidCrash: crash event!
PLUGIN 1381991330272910: Plugin::ReportLoadError (error='Nexe crashed during sta
rtup')
PLUGIN 1381991330273042: Plugin::EnqueueProgressEvent (event_type='error', url='
', length_computable=0, loaded=0, total=0)
PLUGIN 1381991330273053: Plugin::EnqueueProgressEvent (event_type='loadend', url
='', length_computable=0, loaded=0, total=0)

And for stderr:

[15,3817593088:06:28:50.236799] After @ix 0: 0x00000007, avail_ix 0
[15,3817593088:06:28:50.236804] ... done.
[15,3817593088:06:28:50.236808] Set(6,0x7f69e501e350) @ix 0: 0x00000007
[15,3817593088:06:28:50.236812] After @ix 0: 0x00000047, avail_ix 0
[15,3647092480:06:28:50.236818] NaClRefCountCtor(0x7f69d4002910).
[10,3677129024:08:28:50.236983] ServiceRuntime::StartSelLdr (return 1)
[10,3677129024:08:28:50.237064] MutexLocker: taking lock 7f75e0de8410
[10,3677129024:08:28:50.237109] MutexLocker: dropping lock 7f75e0de8410
[15,3817593088:06:28:50.237162] Entered NaClCreateServiceSocket
[15,3817593088:06:28:50.237175] NaClRefCountCtor(0x7f69e5021740).
[15,3817593088:06:28:50.237179] NaClRefCountCtor(0x7f69e50217a0).
[15,3817593088:06:28:50.237183] got bound socket at 0x7f69e50217a0, addr at 0x7f
69e5021740
[10,3677129024:08:28:50.237156] ServiceRuntime::LoadNexeAndStart (nacl_desc=0x7f
75e0e9bb20)
[15,3817593088:06:28:50.237192] NaClRefCountCtor(0x7f69e5021800).

and

[15,1451120896:06:44:07.828708] After @ix 0: 0x00000007, avail_ix 0
[15,1451120896:06:44:07.828710] ... done.
[15,1451120896:06:44:07.828712] Set(6,0x10646f0) @ix 0: 0x00000007
[15,1451120896:06:44:07.828714] After @ix 0: 0x00000047, avail_ix 0
[15,1451120896:06:44:07.828996] Entered NaClCreateServiceSocket
[15,1451120896:06:44:07.829004] NaClRefCountCtor(0x01067be0).
[15,1451120896:06:44:07.829008] NaClRefCountCtor(0x01067c40).
[15,1451120896:06:44:07.829010] got bound socket at 0x01067c40, addr at 0x01067b
e0
[15,1451120896:06:44:07.829015] NaClRefCountCtor(0x01067ca0).

(note: missing StartSelLdr and taking/dropping lock, missing LoadNexeAndStart)

[binji]

Wow, thanks for all this information! I'll bring it up with some of the guys on the NaCl team and see if we can find out what might have happened.

[miko]

I think I found the reason (but not a solution yet) - the packages are built with different options:

https://projects.archlinux.org/svntogit/packages.git/commit/trunk?h=packages/chromium&id=0d9c04a58b29d0da3e185c4a82b999dfd4bb8f9a

[binji]

Hmm, I'm not 100%, but I think the toolchain revision is wrong. 30.0.1599.66 should have a toolchain revision of 11958 for NaCl and 11986 for PNaCl. Is it possible to rebuild the package with these versions and test?

[binji]

Try running another NaCl application as well: https://chrome.google.com/webstore/detail/nativeclient-jumpnbump/gcdlggajikigfglpegfonpipaephckkd

[miko]

Right, I got the same error for this NaCl app. I'll try to rebuild it (it takes ages ;( )

[miko]

Hello, just to let you know - latest version of chromium from archlinux distro (currently at 31.0.1650.48) works OK for me, so I have no issues anymore. Thanks!

[binji]

Ah, cool! Thanks for the update. :)