[Sugar-devel] Sugar web activity wait 1 minute at startup

[Lionel Laské]

Hi Gonzalo,

I've tested on the last testing image here:
http://wiki.sugarlabs.org/go/0.100/Testing
Don't know if it's webkit1.

             Lionel.



2014-01-27 Gonzalo Odiard <godiard at sugarlabs.org>

> Hi Lionel,
> What image are you using to test sugar 0.100 in the xo?
> Probably you are using the webkit1 implementation, but I didn't see what
> you report yet.
>
> Gonzalo
>
>
> On Sun, Jan 26, 2014 at 8:30 PM, Daniel Narvaez <dwnarvaez at gmail.com>wrote:
>
>> The webkit1 code does not seem to be sending a response if a file does
>> not exist, which I suppose could cause what you are seeing. Though it's
>> logging an error, which I don't see in your log. But the locale.ini does
>> not exist in your activity I guess?
>>
>> It would be good to know for sure if it's webkit1 related. In
>> sugar-build, can you try to
>>
>> export SUGAR_USE_WEBKIT1=yes
>>
>> Then run with sugar-launch and see if you can reproduce the issue.
>>
>> On Sunday, 26 January 2014, Lionel Laské wrote:
>>
>>>
>>> Hi all,
>>>
>>> I'm currently porting my FoodChain activity [1] as a full Sugar Web
>>> activity. It's mainly a packaging work because FoodChain is already written
>>> in HTML5/JavaScript but with a Python package around it.
>>>
>>> The new Sugar Web activity works well but when I'm testing it on Sugar
>>> 0.100 on the XO, the loading process is very long (more than 1 minute) -
>>> tested on the XO 1.75 and XO 4 on the old and the recent package.
>>>
>>> I've isolated the lost time using the sugar-launch command (see log
>>> below). It takes more than 1 minute to load "favicon.ico" (see log between
>>> 15:04:23 and 15:05:34). I don't see any reason for that because it's a very
>>> tiny file.
>>> More, when I delete this file, the lost time is still here and when I
>>> see the trace for another Sugar Web activity, I don't have this loading
>>> time, including when "favicon.ico" is not here.
>>> Launching the activity on sugar-build don't show this issue neither.
>>> I suspect that the problem is not on "favicon.ico" but on something like
>>> a "timeout" somewhere (on a socket ?).
>>> Source code of the activity is here [2], the packaged activity with this
>>> issue could be downloaded here [3].
>>>
>>> Any suggestion is welcome to help me to debug this issue.
>>>
>>> Best regards from France.
>>>
>>>             Lionel.
>>>
>>>
>>> [1] http://activities.sugarlabs.org/en/sugar/addon/4612
>>> [2] https://github.com/llaske/FoodChain
>>> [3] http://laske.fr/tmp/foodchain-4.xo
>>>
>>>
>>>
>>>
>>> [olpc at schoolserver FoodChain.activity]$ sugar-launch
>>> org.olpcfrance.FoodChain
>>> org.olpcfrance.FoodChain
>>> 1390662262.276506 ERROR root: Using port 50662
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:22] "GET /index.html
>>> HTTP/1.1" 200 -
>>>
>>> (sugar-activity:4018): Gdk-CRITICAL **: gdk_device_get_source: assertion
>>> `GDK_IS_DEVICE (device)' failed
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/sugar-web/graphics/css/sugar.css HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /enyo/enyo.css
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /enyo/enyo.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /lib/require.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /depends.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /styles.css
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/package.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/Canvas.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/CanvasControl.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/Shape.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/Circle.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/Rectangle.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/Text.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/canvas/Image.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /l10n.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /util.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /audio.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /timer.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /card.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /chain.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /shadowbutton.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /sprite.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /learngame.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /buildgame.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /playgame.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /credits.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /app.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /activity/activity-icon.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /images/en.svg
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET /images/fr.svg
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:04:23] "GET
>>> /lib/sugar-web/graphics/icons/actions/activity-stop.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:34] "GET /favicon.ico
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:34] "GET /js/loader.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET /js/activity.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET /lib/webL10n.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/activity/activity.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/graphics/radiobuttonsgroup.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/datastore.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/activity/shortcut.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/bus.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/env.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/graphics/icon.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/graphics/activitypalette.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/graphics/palette.js HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET /lib/domReady.js
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/graphics/icons/emblems/arrow-down.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /activity/activity-icon.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /lib/sugar-web/graphics/icons/emblems/arrow-up.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET /locale.ini
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /images/FoodChain.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET /images/one.svg
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /images/one_shadow.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET /images/two.svg
>>> HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /images/two_shadow.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /images/three.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /images/three_shadow.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:35] "GET
>>> /images/information.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:36] "GET
>>> /images/information_shadow.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:36] "GET
>>> /activity/activity-icon.svg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:36] "GET
>>> /audio/popcorn.ogg HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:37] "GET
>>> /images/cards/grass.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:37] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:38] "GET
>>> /images/cards/tick.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:38] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:39] "GET
>>> /images/cards/fox.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:39] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:40] "GET
>>> /images/cards/ox.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:40] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:41] "GET
>>> /images/cards/mole.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:41] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:43] "GET
>>> /images/cards/swan.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:43] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:44] "GET
>>> /images/cards/pig.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:44] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:45] "GET
>>> /images/cards/corn.png HTTP/1.1" 200 -
>>> xo-d2-7d-0b.localdomain - - [25/Jan/2014 15:05:45] "GET
>>> /images/sound_icon.png HTTP/1.1" 200 -
>>> /usr/bin/sugar-activity:164: Warning: gsignal.c:2576: instance
>>> `0x3c58a0' has no handler with id `132'
>>>   main()
>>> /usr/bin/sugar-activity:164: Warning: gsignal.c:2576: instance
>>> `0x2089e8' has no handler with id `133'
>>>   main()
>>> [olpc at schoolserver FoodChain.activity]$
>>>
>>
>>
>> --
>> Daniel Narvaez
>>
>>
>> _______________________________________________
>> Sugar-devel mailing list
>> Sugar-devel at lists.sugarlabs.org
>> http://lists.sugarlabs.org/listinfo/sugar-devel
>>
>>
>
>
> --
> Gonzalo Odiard
>
> SugarLabs - Learning Software for children
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sugarlabs.org/archive/sugar-devel/attachments/20140127/65bf54fd/attachment-0001.html>