builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1447946915.47 results: success (0) buildid: 20151118154839 builduid: 05e2be9280b341659856e5b8a58bc70d revision: 5326ac1a435a44d335752ed727fa157273b91244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.472695) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.473140) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.473423) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006610 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.519198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.519476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.580255) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.580499) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.643734) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.643993) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.644343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.644622) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 07:28:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.5M=0s 2015-11-19 07:28:35 (31.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102602 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.778619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.778896) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017068 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.834064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:35.834362) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5326ac1a435a44d335752ed727fa157273b91244 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5326ac1a435a44d335752ed727fa157273b91244 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 07:28:36,019 truncating revision to first 12 chars 2015-11-19 07:28:36,019 Setting DEBUG logging. 2015-11-19 07:28:36,019 attempt 1/10 2015-11-19 07:28:36,019 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5326ac1a435a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 07:28:36,664 unpacking tar archive at: mozilla-inbound-5326ac1a435a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.948773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:36.799249) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:36.799516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:36.815185) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:36.815456) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 07:28:36.815848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 07:28:36.816137) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:37 INFO - MultiFileLogger online at 20151119 07:28:37 in /builds/slave/test 07:28:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 07:28:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:37 INFO - {'append_to_log': False, 07:28:37 INFO - 'base_work_dir': '/builds/slave/test', 07:28:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 07:28:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:37 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 07:28:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:37 INFO - 'config_files': ('talos/linux_config.py',), 07:28:37 INFO - 'default_actions': ('clobber', 07:28:37 INFO - 'read-buildbot-config', 07:28:37 INFO - 'download-and-extract', 07:28:37 INFO - 'populate-webroot', 07:28:37 INFO - 'create-virtualenv', 07:28:37 INFO - 'install', 07:28:37 INFO - 'run-tests'), 07:28:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:37 INFO - 'download_minidump_stackwalk': True, 07:28:37 INFO - 'download_symbols': 'ondemand', 07:28:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:37 INFO - 'installer_path': 'installer.exe', 07:28:37 INFO - 'log_level': 'info', 07:28:37 INFO - 'log_name': 'talos', 07:28:37 INFO - 'log_to_console': True, 07:28:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:37 INFO - 'opt_config_files': (), 07:28:37 INFO - 'pip_index': False, 07:28:37 INFO - 'sps_profile': False, 07:28:37 INFO - 'sps_profile_interval': 0, 07:28:37 INFO - 'suite': 'dromaeojs', 07:28:37 INFO - 'system_bits': '64', 07:28:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:37 INFO - 'title': 'talos-linux64-ix-017', 07:28:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:37 INFO - 'use_talos_json': True, 07:28:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:37 INFO - 'work_dir': 'build'} 07:28:37 INFO - ##### 07:28:37 INFO - ##### Running clobber step. 07:28:37 INFO - ##### 07:28:37 INFO - Running pre-action listener: _resource_record_pre_action 07:28:37 INFO - Running main action method: clobber 07:28:37 INFO - rmtree: /builds/slave/test/build 07:28:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:37 INFO - Running post-action listener: _resource_record_post_action 07:28:37 INFO - ##### 07:28:37 INFO - ##### Running read-buildbot-config step. 07:28:37 INFO - ##### 07:28:37 INFO - Running pre-action listener: _resource_record_pre_action 07:28:37 INFO - Running main action method: read_buildbot_config 07:28:37 INFO - Using buildbot properties: 07:28:37 INFO - { 07:28:37 INFO - "properties": { 07:28:37 INFO - "buildnumber": 5937, 07:28:37 INFO - "product": "firefox", 07:28:37 INFO - "script_repo_revision": "production", 07:28:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:28:37 INFO - "repository": "", 07:28:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 07:28:37 INFO - "buildid": "20151118154839", 07:28:37 INFO - "slavename": "talos-linux64-ix-017", 07:28:37 INFO - "pgo_build": "False", 07:28:37 INFO - "basedir": "/builds/slave/test", 07:28:37 INFO - "project": "", 07:28:37 INFO - "platform": "ubuntu64_hw", 07:28:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:28:37 INFO - "slavebuilddir": "test", 07:28:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 07:28:37 INFO - "branch": "mozilla-inbound", 07:28:37 INFO - "repo_path": "integration/mozilla-inbound", 07:28:37 INFO - "stage_platform": "linux64", 07:28:37 INFO - "builduid": "05e2be9280b341659856e5b8a58bc70d", 07:28:37 INFO - "revision": "5326ac1a435a44d335752ed727fa157273b91244" 07:28:37 INFO - }, 07:28:37 INFO - "sourcestamp": { 07:28:37 INFO - "repository": "", 07:28:37 INFO - "hasPatch": false, 07:28:37 INFO - "project": "", 07:28:37 INFO - "branch": "mozilla-inbound-linux64-talos", 07:28:37 INFO - "changes": [ 07:28:37 INFO - { 07:28:37 INFO - "category": null, 07:28:37 INFO - "files": [ 07:28:37 INFO - { 07:28:37 INFO - "url": null, 07:28:37 INFO - "name": "https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:28:37 INFO - } 07:28:37 INFO - ], 07:28:37 INFO - "repository": "", 07:28:37 INFO - "rev": "5326ac1a435a44d335752ed727fa157273b91244", 07:28:37 INFO - "who": "mchang@mozilla.com", 07:28:37 INFO - "when": 1447893334, 07:28:37 INFO - "number": 6679828, 07:28:37 INFO - "comments": "Bug 1208636 - Adjust displayport size based on available system memory. r=kats", 07:28:37 INFO - "project": "", 07:28:37 INFO - "at": "Wed 18 Nov 2015 16:35:34", 07:28:37 INFO - "branch": "mozilla-inbound-linux64-talos", 07:28:37 INFO - "revlink": "", 07:28:37 INFO - "properties": [ 07:28:37 INFO - [ 07:28:37 INFO - "buildid", 07:28:37 INFO - "20151118154839", 07:28:37 INFO - "Change" 07:28:37 INFO - ], 07:28:37 INFO - [ 07:28:37 INFO - "builduid", 07:28:37 INFO - "05e2be9280b341659856e5b8a58bc70d", 07:28:37 INFO - "Change" 07:28:37 INFO - ], 07:28:37 INFO - [ 07:28:37 INFO - "pgo_build", 07:28:37 INFO - "False", 07:28:37 INFO - "Change" 07:28:37 INFO - ] 07:28:37 INFO - ], 07:28:37 INFO - "revision": "5326ac1a435a44d335752ed727fa157273b91244" 07:28:37 INFO - } 07:28:37 INFO - ], 07:28:37 INFO - "revision": "5326ac1a435a44d335752ed727fa157273b91244" 07:28:37 INFO - } 07:28:37 INFO - } 07:28:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:28:37 INFO - Running post-action listener: _resource_record_post_action 07:28:37 INFO - ##### 07:28:37 INFO - ##### Running download-and-extract step. 07:28:37 INFO - ##### 07:28:37 INFO - Running pre-action listener: _resource_record_pre_action 07:28:37 INFO - Running main action method: download_and_extract 07:28:37 INFO - mkdir: /builds/slave/test/build/tests 07:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:37 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json 07:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json 07:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:28:41 INFO - Downloaded 1302 bytes. 07:28:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:28:41 INFO - Using the following test package requirements: 07:28:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:41 INFO - u'jsshell-linux-x86_64.zip'], 07:28:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:41 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:42 INFO - Downloaded 21331175 bytes. 07:28:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:28:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:28:43 INFO - Return code: 0 07:28:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:43 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:45 INFO - Downloaded 21331175 bytes. 07:28:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:28:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:28:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:28:46 INFO - Return code: 0 07:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:46 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:28:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:28:47 INFO - Downloaded 11130997 bytes. 07:28:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:28:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:28:47 INFO - Return code: 0 07:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:47 INFO - https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:28:49 INFO - Downloaded 55770415 bytes. 07:28:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:28:49 INFO - mkdir: /builds/slave/test/properties 07:28:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:28:49 INFO - Writing to file /builds/slave/test/properties/build_url 07:28:49 INFO - Contents: 07:28:49 INFO - build_url:https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:28:49 INFO - Running post-action listener: _resource_record_post_action 07:28:49 INFO - Running post-action listener: set_extra_try_arguments 07:28:49 INFO - ##### 07:28:49 INFO - ##### Running populate-webroot step. 07:28:49 INFO - ##### 07:28:49 INFO - Running pre-action listener: _resource_record_pre_action 07:28:49 INFO - Running main action method: populate_webroot 07:28:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:28:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:28:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:28:49 INFO - '../fennec_ids.txt'], 07:28:49 INFO - 'tests': ['tcheck2']}, 07:28:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:28:49 INFO - '--tppagecycles', 07:28:49 INFO - '7'], 07:28:49 INFO - 'tests': ['tsvgm']}}, 07:28:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:28:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:28:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:28:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:28:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'tests': ['damp', 'tps']}, 07:28:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['damp', 'tps']}, 07:28:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:28:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:28:49 INFO - 'other': {'tests': ['a11yr', 07:28:49 INFO - 'ts_paint', 07:28:49 INFO - 'tpaint', 07:28:49 INFO - 'sessionrestore', 07:28:49 INFO - 'sessionrestore_no_auto_restore']}, 07:28:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['a11yr', 07:28:49 INFO - 'ts_paint', 07:28:49 INFO - 'tpaint', 07:28:49 INFO - 'sessionrestore', 07:28:49 INFO - 'sessionrestore_no_auto_restore']}, 07:28:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['a11yr', 07:28:49 INFO - 'ts_paint', 07:28:49 INFO - 'tpaint', 07:28:49 INFO - 'sessionrestore', 07:28:49 INFO - 'sessionrestore_no_auto_restore']}, 07:28:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['a11yr', 07:28:49 INFO - 'ts_paint', 07:28:49 INFO - 'tpaint', 07:28:49 INFO - 'sessionrestore', 07:28:49 INFO - 'sessionrestore_no_auto_restore']}, 07:28:49 INFO - 'other_l64': {'tests': ['a11yr', 07:28:49 INFO - 'ts_paint', 07:28:49 INFO - 'tpaint', 07:28:49 INFO - 'sessionrestore', 07:28:49 INFO - 'sessionrestore_no_auto_restore']}, 07:28:49 INFO - 'other_nol64': {'tests': ['a11yr', 07:28:49 INFO - 'ts_paint', 07:28:49 INFO - 'tpaint', 07:28:49 INFO - 'sessionrestore', 07:28:49 INFO - 'sessionrestore_no_auto_restore']}, 07:28:49 INFO - 'svgr': {'tests': ['tsvgx', 07:28:49 INFO - 'tsvgr_opacity', 07:28:49 INFO - 'tart', 07:28:49 INFO - 'tscrollx', 07:28:49 INFO - 'cart']}, 07:28:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['tsvgx', 07:28:49 INFO - 'tsvgr_opacity', 07:28:49 INFO - 'tart', 07:28:49 INFO - 'tscrollx', 07:28:49 INFO - 'cart']}, 07:28:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'tests': ['tp5o']}, 07:28:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'talos_options': ['--e10s'], 07:28:49 INFO - 'tests': ['tp5o']}, 07:28:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'talos_options': ['--xperf_path', 07:28:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:49 INFO - 'tests': ['tp5n']}, 07:28:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:49 INFO - 'talos_options': ['--e10s', 07:28:49 INFO - '--xperf_path', 07:28:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:49 INFO - 'tests': ['tp5n']}}, 07:28:49 INFO - 'talos.zip': {'path': '', 07:28:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:28:49 INFO - Running post-action listener: _resource_record_post_action 07:28:49 INFO - ##### 07:28:49 INFO - ##### Running create-virtualenv step. 07:28:49 INFO - ##### 07:28:49 INFO - Running pre-action listener: _resource_record_pre_action 07:28:49 INFO - Running main action method: create_virtualenv 07:28:49 INFO - Creating virtualenv /builds/slave/test/build/venv 07:28:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:28:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:28:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:28:49 INFO - Using real prefix '/usr' 07:28:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:28:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:51 INFO - Installing pip.................done. 07:28:51 INFO - Return code: 0 07:28:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7386534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:28:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:28:51 INFO - Using env: {'DISPLAY': ':0', 07:28:51 INFO - 'HOME': '/home/cltbld', 07:28:51 INFO - 'LANG': 'en_US.UTF-8', 07:28:51 INFO - 'LANGUAGE': 'en_US:en', 07:28:51 INFO - 'LOGNAME': 'cltbld', 07:28:51 INFO - 'MAIL': '/var/mail/cltbld', 07:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:51 INFO - 'MOZ_NO_REMOTE': '1', 07:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:51 INFO - 'NO_EM_RESTART': '1', 07:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:51 INFO - 'PWD': '/builds/slave/test', 07:28:51 INFO - 'SHELL': '/bin/bash', 07:28:51 INFO - 'SHLVL': '1', 07:28:51 INFO - 'TERM': 'linux', 07:28:51 INFO - 'TMOUT': '86400', 07:28:51 INFO - 'USER': 'cltbld', 07:28:51 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:51 INFO - '_': '/tools/buildbot/bin/python'} 07:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:28:52 INFO - Cleaning up... 07:28:52 INFO - Return code: 0 07:28:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7386534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:28:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:28:52 INFO - Using env: {'DISPLAY': ':0', 07:28:52 INFO - 'HOME': '/home/cltbld', 07:28:52 INFO - 'LANG': 'en_US.UTF-8', 07:28:52 INFO - 'LANGUAGE': 'en_US:en', 07:28:52 INFO - 'LOGNAME': 'cltbld', 07:28:52 INFO - 'MAIL': '/var/mail/cltbld', 07:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:52 INFO - 'MOZ_NO_REMOTE': '1', 07:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:52 INFO - 'NO_EM_RESTART': '1', 07:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:52 INFO - 'PWD': '/builds/slave/test', 07:28:52 INFO - 'SHELL': '/bin/bash', 07:28:52 INFO - 'SHLVL': '1', 07:28:52 INFO - 'TERM': 'linux', 07:28:52 INFO - 'TMOUT': '86400', 07:28:52 INFO - 'USER': 'cltbld', 07:28:52 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:52 INFO - '_': '/tools/buildbot/bin/python'} 07:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:52 INFO - Downloading/unpacking psutil>=0.7.1 07:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:28:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:28:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:54 INFO - Installing collected packages: psutil 07:28:54 INFO - Running setup.py install for psutil 07:28:54 INFO - building 'psutil._psutil_linux' extension 07:28:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:28:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:28:54 INFO - building 'psutil._psutil_posix' extension 07:28:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:28:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:28:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:54 INFO - Successfully installed psutil 07:28:54 INFO - Cleaning up... 07:28:54 INFO - Return code: 0 07:28:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7386534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:28:54 INFO - Using env: {'DISPLAY': ':0', 07:28:54 INFO - 'HOME': '/home/cltbld', 07:28:54 INFO - 'LANG': 'en_US.UTF-8', 07:28:54 INFO - 'LANGUAGE': 'en_US:en', 07:28:54 INFO - 'LOGNAME': 'cltbld', 07:28:54 INFO - 'MAIL': '/var/mail/cltbld', 07:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:54 INFO - 'MOZ_NO_REMOTE': '1', 07:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:54 INFO - 'NO_EM_RESTART': '1', 07:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:54 INFO - 'PWD': '/builds/slave/test', 07:28:54 INFO - 'SHELL': '/bin/bash', 07:28:54 INFO - 'SHLVL': '1', 07:28:54 INFO - 'TERM': 'linux', 07:28:54 INFO - 'TMOUT': '86400', 07:28:54 INFO - 'USER': 'cltbld', 07:28:54 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:54 INFO - '_': '/tools/buildbot/bin/python'} 07:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:28:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:28:56 INFO - Installing collected packages: mozsystemmonitor 07:28:56 INFO - Running setup.py install for mozsystemmonitor 07:28:56 INFO - Successfully installed mozsystemmonitor 07:28:56 INFO - Cleaning up... 07:28:56 INFO - Return code: 0 07:28:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7386534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:28:56 INFO - Using env: {'DISPLAY': ':0', 07:28:56 INFO - 'HOME': '/home/cltbld', 07:28:56 INFO - 'LANG': 'en_US.UTF-8', 07:28:56 INFO - 'LANGUAGE': 'en_US:en', 07:28:56 INFO - 'LOGNAME': 'cltbld', 07:28:56 INFO - 'MAIL': '/var/mail/cltbld', 07:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:56 INFO - 'MOZ_NO_REMOTE': '1', 07:28:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:56 INFO - 'NO_EM_RESTART': '1', 07:28:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:56 INFO - 'PWD': '/builds/slave/test', 07:28:56 INFO - 'SHELL': '/bin/bash', 07:28:56 INFO - 'SHLVL': '1', 07:28:56 INFO - 'TERM': 'linux', 07:28:56 INFO - 'TMOUT': '86400', 07:28:56 INFO - 'USER': 'cltbld', 07:28:56 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:56 INFO - '_': '/tools/buildbot/bin/python'} 07:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:56 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:58 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:59 INFO - Downloading docopt-0.6.1.tar.gz 07:28:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:59 INFO - Running setup.py install for blobuploader 07:28:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:59 INFO - Running setup.py install for requests 07:28:59 INFO - Running setup.py install for docopt 07:28:59 INFO - Successfully installed blobuploader requests docopt 07:28:59 INFO - Cleaning up... 07:28:59 INFO - Return code: 0 07:28:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7386534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:59 INFO - Using env: {'DISPLAY': ':0', 07:28:59 INFO - 'HOME': '/home/cltbld', 07:28:59 INFO - 'LANG': 'en_US.UTF-8', 07:28:59 INFO - 'LANGUAGE': 'en_US:en', 07:28:59 INFO - 'LOGNAME': 'cltbld', 07:28:59 INFO - 'MAIL': '/var/mail/cltbld', 07:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:59 INFO - 'MOZ_NO_REMOTE': '1', 07:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:59 INFO - 'NO_EM_RESTART': '1', 07:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:59 INFO - 'PWD': '/builds/slave/test', 07:28:59 INFO - 'SHELL': '/bin/bash', 07:28:59 INFO - 'SHLVL': '1', 07:28:59 INFO - 'TERM': 'linux', 07:28:59 INFO - 'TMOUT': '86400', 07:28:59 INFO - 'USER': 'cltbld', 07:28:59 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:59 INFO - '_': '/tools/buildbot/bin/python'} 07:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:00 INFO - Running setup.py (path:/tmp/pip-_7nbLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:00 INFO - Running setup.py (path:/tmp/pip-Sy7zVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:00 INFO - Running setup.py (path:/tmp/pip-ncZ1Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:00 INFO - Running setup.py (path:/tmp/pip-t78diy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:00 INFO - Running setup.py (path:/tmp/pip-1D7leI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:00 INFO - Running setup.py (path:/tmp/pip-PQfYwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:00 INFO - Running setup.py (path:/tmp/pip-vgQQoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:00 INFO - Running setup.py (path:/tmp/pip-cp2gze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:00 INFO - Running setup.py (path:/tmp/pip-HvtHUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:00 INFO - Running setup.py (path:/tmp/pip-wb8hQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:00 INFO - Running setup.py (path:/tmp/pip-kbwO39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:00 INFO - Running setup.py (path:/tmp/pip-9_ykYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:00 INFO - Running setup.py (path:/tmp/pip-j7uvU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:01 INFO - Running setup.py (path:/tmp/pip-CQL6_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:01 INFO - Running setup.py (path:/tmp/pip-RMXzdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:01 INFO - Running setup.py (path:/tmp/pip-2BF3Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:01 INFO - Running setup.py (path:/tmp/pip-ezS8Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:01 INFO - Running setup.py install for manifestparser 07:29:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:01 INFO - Running setup.py install for mozcrash 07:29:01 INFO - Running setup.py install for mozdebug 07:29:01 INFO - Running setup.py install for mozdevice 07:29:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:29:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:01 INFO - Running setup.py install for mozfile 07:29:01 INFO - Running setup.py install for mozhttpd 07:29:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:01 INFO - Running setup.py install for mozinfo 07:29:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Running setup.py install for mozInstall 07:29:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Running setup.py install for mozleak 07:29:02 INFO - Running setup.py install for mozlog 07:29:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Running setup.py install for moznetwork 07:29:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Running setup.py install for mozprocess 07:29:02 INFO - Running setup.py install for mozprofile 07:29:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Running setup.py install for mozrunner 07:29:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:02 INFO - Running setup.py install for mozscreenshot 07:29:02 INFO - Running setup.py install for moztest 07:29:03 INFO - Running setup.py install for mozversion 07:29:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:03 INFO - Cleaning up... 07:29:03 INFO - Return code: 0 07:29:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7386534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:03 INFO - Using env: {'DISPLAY': ':0', 07:29:03 INFO - 'HOME': '/home/cltbld', 07:29:03 INFO - 'LANG': 'en_US.UTF-8', 07:29:03 INFO - 'LANGUAGE': 'en_US:en', 07:29:03 INFO - 'LOGNAME': 'cltbld', 07:29:03 INFO - 'MAIL': '/var/mail/cltbld', 07:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:03 INFO - 'MOZ_NO_REMOTE': '1', 07:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:03 INFO - 'NO_EM_RESTART': '1', 07:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:03 INFO - 'PWD': '/builds/slave/test', 07:29:03 INFO - 'SHELL': '/bin/bash', 07:29:03 INFO - 'SHLVL': '1', 07:29:03 INFO - 'TERM': 'linux', 07:29:03 INFO - 'TMOUT': '86400', 07:29:03 INFO - 'USER': 'cltbld', 07:29:03 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:03 INFO - '_': '/tools/buildbot/bin/python'} 07:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:03 INFO - Running setup.py (path:/tmp/pip-7RuHLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:03 INFO - Running setup.py (path:/tmp/pip-iWyAAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:03 INFO - Running setup.py (path:/tmp/pip-fFxVJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:03 INFO - Running setup.py (path:/tmp/pip-tEqyBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:03 INFO - Running setup.py (path:/tmp/pip-U22ZBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:03 INFO - Running setup.py (path:/tmp/pip-mEMLtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:03 INFO - Running setup.py (path:/tmp/pip-oSvJ20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:03 INFO - Running setup.py (path:/tmp/pip-RZXZNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:03 INFO - Running setup.py (path:/tmp/pip-xTkidK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:04 INFO - Running setup.py (path:/tmp/pip-f_P67z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:04 INFO - Running setup.py (path:/tmp/pip-jQFAK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:04 INFO - Running setup.py (path:/tmp/pip-Vh2aKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:04 INFO - Running setup.py (path:/tmp/pip-OpnKkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:04 INFO - Running setup.py (path:/tmp/pip-u9qPhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:04 INFO - Running setup.py (path:/tmp/pip-IboZJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:04 INFO - Running setup.py (path:/tmp/pip-xYaxyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:29:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:04 INFO - Running setup.py (path:/tmp/pip-SzQnEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:06 INFO - Downloading blessings-1.5.1.tar.gz 07:29:06 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:06 INFO - Installing collected packages: blessings 07:29:06 INFO - Running setup.py install for blessings 07:29:06 INFO - Successfully installed blessings 07:29:06 INFO - Cleaning up... 07:29:06 INFO - Return code: 0 07:29:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:06 INFO - Reading from file tmpfile_stdout 07:29:06 INFO - Current package versions: 07:29:06 INFO - argparse == 1.2.1 07:29:06 INFO - blessings == 1.5.1 07:29:06 INFO - blobuploader == 1.2.4 07:29:06 INFO - docopt == 0.6.1 07:29:06 INFO - manifestparser == 1.1 07:29:06 INFO - mozInstall == 1.12 07:29:06 INFO - mozcrash == 0.16 07:29:06 INFO - mozdebug == 0.1 07:29:06 INFO - mozdevice == 0.47 07:29:06 INFO - mozfile == 1.2 07:29:06 INFO - mozhttpd == 0.7 07:29:06 INFO - mozinfo == 0.9 07:29:06 INFO - mozleak == 0.1 07:29:06 INFO - mozlog == 3.0 07:29:06 INFO - moznetwork == 0.27 07:29:06 INFO - mozprocess == 0.22 07:29:06 INFO - mozprofile == 0.27 07:29:06 INFO - mozrunner == 6.11 07:29:06 INFO - mozscreenshot == 0.1 07:29:06 INFO - mozsystemmonitor == 0.0 07:29:06 INFO - moztest == 0.7 07:29:06 INFO - mozversion == 1.4 07:29:06 INFO - psutil == 3.1.1 07:29:06 INFO - requests == 1.2.3 07:29:06 INFO - wsgiref == 0.1.2 07:29:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7386534c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:29:06 INFO - Using env: {'DISPLAY': ':0', 07:29:06 INFO - 'HOME': '/home/cltbld', 07:29:06 INFO - 'LANG': 'en_US.UTF-8', 07:29:06 INFO - 'LANGUAGE': 'en_US:en', 07:29:06 INFO - 'LOGNAME': 'cltbld', 07:29:06 INFO - 'MAIL': '/var/mail/cltbld', 07:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:06 INFO - 'MOZ_NO_REMOTE': '1', 07:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:06 INFO - 'NO_EM_RESTART': '1', 07:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:06 INFO - 'PWD': '/builds/slave/test', 07:29:06 INFO - 'SHELL': '/bin/bash', 07:29:06 INFO - 'SHLVL': '1', 07:29:06 INFO - 'TERM': 'linux', 07:29:06 INFO - 'TMOUT': '86400', 07:29:06 INFO - 'USER': 'cltbld', 07:29:06 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:06 INFO - '_': '/tools/buildbot/bin/python'} 07:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:29:06 INFO - Cleaning up... 07:29:06 INFO - Return code: 0 07:29:06 INFO - Running post-action listener: _resource_record_post_action 07:29:06 INFO - Running post-action listener: _start_resource_monitoring 07:29:06 INFO - Starting resource monitoring. 07:29:06 INFO - ##### 07:29:06 INFO - ##### Running install step. 07:29:06 INFO - ##### 07:29:06 INFO - Running pre-action listener: _resource_record_pre_action 07:29:06 INFO - Running main action method: install 07:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:07 INFO - Reading from file tmpfile_stdout 07:29:07 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:07 INFO - Reading from file tmpfile_stdout 07:29:07 INFO - Output received: 07:29:07 INFO - Usage: mozinstall [options] installer 07:29:07 INFO - Options: 07:29:07 INFO - -h, --help show this help message and exit 07:29:07 INFO - -d DEST, --destination=DEST 07:29:07 INFO - Directory to install application into. [default: 07:29:07 INFO - "/builds/slave/test"] 07:29:07 INFO - --app=APP Application being installed. [default: firefox] 07:29:07 INFO - mkdir: /builds/slave/test/build/application 07:29:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:29:21 INFO - Reading from file tmpfile_stdout 07:29:21 INFO - Output received: 07:29:21 INFO - /builds/slave/test/build/application/firefox/firefox 07:29:21 INFO - Running post-action listener: _resource_record_post_action 07:29:21 INFO - ##### 07:29:21 INFO - ##### Running run-tests step. 07:29:21 INFO - ##### 07:29:21 INFO - Running pre-action listener: _resource_record_pre_action 07:29:21 INFO - Running main action method: run_tests 07:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:21 INFO - Python 2.7.3 07:29:21 INFO - Return code: 0 07:29:21 INFO - grabbing minidump binary from tooltool 07:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e25b70>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e76dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e77250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:29:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:29:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:21 INFO - Return code: 0 07:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test/build 07:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 07:29:21 INFO - Using env: {'DISPLAY': ':0', 07:29:21 INFO - 'HOME': '/home/cltbld', 07:29:21 INFO - 'LANG': 'en_US.UTF-8', 07:29:21 INFO - 'LANGUAGE': 'en_US:en', 07:29:21 INFO - 'LOGNAME': 'cltbld', 07:29:21 INFO - 'MAIL': '/var/mail/cltbld', 07:29:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:21 INFO - 'MOZ_NO_REMOTE': '1', 07:29:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:21 INFO - 'NO_EM_RESTART': '1', 07:29:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:21 INFO - 'PWD': '/builds/slave/test', 07:29:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:21 INFO - 'SHELL': '/bin/bash', 07:29:21 INFO - 'SHLVL': '1', 07:29:21 INFO - 'TERM': 'linux', 07:29:21 INFO - 'TMOUT': '86400', 07:29:21 INFO - 'USER': 'cltbld', 07:29:21 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066', 07:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:21 INFO - '_': '/tools/buildbot/bin/python'} 07:29:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 07:29:21 INFO - mozversion INFO | application_buildid: 20151118154839 07:29:21 INFO - mozversion INFO | application_changeset: 5326ac1a435a44d335752ed727fa157273b91244 07:29:21 INFO - mozversion INFO | application_display_name: Nightly 07:29:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:21 INFO - mozversion INFO | application_name: Firefox 07:29:21 INFO - mozversion INFO | application_remotingname: firefox 07:29:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:29:21 INFO - mozversion INFO | application_vendor: Mozilla 07:29:21 INFO - mozversion INFO | application_version: 45.0a1 07:29:21 INFO - mozversion INFO | platform_buildid: 20151118154839 07:29:21 INFO - mozversion INFO | platform_changeset: 5326ac1a435a44d335752ed727fa157273b91244 07:29:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:29:21 INFO - mozversion INFO | platform_version: 45.0a1 07:29:21 INFO - 2015-11-19 07:29:21,602 DEBUG : using testdate: 1447946961 07:29:21 INFO - 2015-11-19 07:29:21,602 DEBUG : actual date: 1447946961 07:29:21 INFO - 2015-11-19 07:29:21,611 INFO : starting webserver on 'localhost:42844' 07:29:21 INFO - 2015-11-19 07:29:21,612 INFO : Starting test suite talos-linux64-ix-017 07:29:21 INFO - 2015-11-19 07:29:21,612 INFO : Starting test dromaeo_css 07:29:21 INFO - 2015-11-19 07:29:21,612 DEBUG : operating with platform_type : linux_ 07:29:21 INFO - 2015-11-19 07:29:21,613 INFO : Initialising browser for dromaeo_css test... 07:29:21 INFO - 2015-11-19 07:29:21,627 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwbMdC/profile http://localhost:42844/getInfo.html 07:29:26 INFO - 2015-11-19 07:29:26,089 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:29:26 INFO - 2015-11-19 07:29:26,089 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:29:26 INFO - 2015-11-19 07:29:26,089 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:29:26 INFO - 2015-11-19 07:29:26,089 DEBUG : BROWSER_OUTPUT: __metrics 07:29:26 INFO - 2015-11-19 07:29:26,206 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:27 INFO - 2015-11-19 07:29:27,346 INFO : Browser initialized. 07:29:27 INFO - 2015-11-19 07:29:27,347 INFO : Running cycle 1/1 for dromaeo_css test... 07:29:27 INFO - 2015-11-19 07:29:27,347 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOwbMdC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:29:39 INFO - 2015-11-19 07:29:39,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 141860864 07:29:39 INFO - 2015-11-19 07:29:39,220 DEBUG : BROWSER_OUTPUT: 07:30:30 INFO - 2015-11-19 07:30:30,739 DEBUG : BROWSER_OUTPUT: 1447947030736 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:32:42 INFO - 2015-11-19 07:32:42,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42844/tests/dromaeo/cssquery-ext.html) 07:32:43 INFO - 2015-11-19 07:32:43,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 237490176 07:32:43 INFO - 2015-11-19 07:32:43,535 DEBUG : BROWSER_OUTPUT: 07:35:46 INFO - 2015-11-19 07:35:46,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-ext.html (next: http://localhost:42844/tests/dromaeo/cssquery-jquery.html) 07:35:46 INFO - 2015-11-19 07:35:46,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 221077504 07:35:46 INFO - 2015-11-19 07:35:46,644 DEBUG : BROWSER_OUTPUT: 07:38:48 INFO - 2015-11-19 07:38:48,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42844/tests/dromaeo/cssquery-mootools.html) 07:38:49 INFO - 2015-11-19 07:38:49,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 214642688 07:38:49 INFO - 2015-11-19 07:38:49,338 DEBUG : BROWSER_OUTPUT: 07:41:51 INFO - 2015-11-19 07:41:51,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42844/tests/dromaeo/cssquery-prototype.html) 07:41:51 INFO - 2015-11-19 07:41:51,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 204238848 07:41:51 INFO - 2015-11-19 07:41:51,885 DEBUG : BROWSER_OUTPUT: 07:44:54 INFO - 2015-11-19 07:44:54,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42844/tests/dromaeo/cssquery-yui.html) 07:44:55 INFO - 2015-11-19 07:44:55,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 206938112 07:44:55 INFO - 2015-11-19 07:44:55,203 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/dromaeo/cssquery-yui.html (next: http://localhost:42844/tests/dromaeo/cssquery-dojo.html) 07:47:57 INFO - 2015-11-19 07:47:57,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 248168448 07:47:57 INFO - 2015-11-19 07:47:57,736 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,737 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:47:57 INFO - 2015-11-19 07:47:57,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:47:57 INFO - 2015-11-19 07:47:57,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:47:57 INFO - 2015-11-19 07:47:57,737 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:47:57 INFO - 2015-11-19 07:47:57,741 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2658.8005899557534;2747.0797282910225;2748.2579703480046;2756.7243275672436;2777.236260028492;4525.230710779168;4667.1365797327435;4693.530646935309;4751.90496190076;4767.1419144553965;4649.558291962258;4683.812647494096;4686.765661716918;4730.858074257778;4788.257820037891;4294.141171765652;4334.089841133366;4370.4099946507295;4377.474703035624;4397.384366188736;4433.401490798749;4485.215087359716;4491.752953587551;4492.415985921842;4497;4170.541240463546;4190.20386126635;4299.742015479082;4322.7190232634775;4333.783310834446;4342;4383.430154079981;4391.3193455014525;4415.448068991376;4435.911281774379;4137.689673274516;4366.978165109154;4367.825286988548;4372.060007098489;4413.3821265022925;4576.725396476222;4594.540545945412;4674.602658774008;4683.414573178353;4705.435347758256;5050.595952323805;5065.569426598743;5067.163917953533;5074.13739664258;5105.795768169269;4839.758012099381;4943.555080042777;5099.974500127476;5107.489251074863;5108.591312694975;4624.537546245382;4663.953360466419;4697.154512187771;4735.621150307967;4770.117528257283;5140.228965655107;5215.504527069922;5217.113090774577;5224.869378265497;5266.499682530153;4639.489656137822;4743.1225223333795;5015.548600625962;5024.6231532634465;5033.723145226974;4962.082014827196;4964.304997300381;5056.898862022739;5077.390713114376;5094.057599344133;5059.544640982329;5076.035553244872;5080.263361812516;5080.847574572768;5124.077666020077;5063.291139240509;5066.16408292635;5069.5437410632485;5072.264521644414;5075.187969924868;4022.8189731462153;4088.1619268049976;4113.814878330482;4120.876373708794;4176.227397931392;3727.7204209684382;3729;3758.3422900992764;3770.5098337216536;3779.7921114338974;4408.25059739845;4413.602775750198;4417.271150260235;4441;4442.355858400514;4760.33355330254;4870.269459581091;4874.610031197496;4966.826161084345;5138.254953031789;4389.62688171509;4393.340998850198;4394.67039971997;4428.402165707588;4433.667474939392;4523.660725445539;4525.117602067565;4528.728276303433;4529.252673308933;4569.748663823455;4599.126166028578;4721.929171062506;4727.432708075053;4856.223004319362;4864.73243971585;4983.277424773315;5079.5428411443145;5084.949150508448;5105.2342148678;5112.872178195575;4801.18379875429;4805.615550756001;4808.471068182567;4813.855584332476;4849.369581954465;4748.525147485224;4861.927071094007;5000.024995125916;5004.899902002013;5043.394792624908;4928.778204980857;4995.8001679932395;5081.364829396325;5084.669496482717;5116.846494605168;4952.975235123801;4953.529414705597;4965.006998600222;4969.627277954096;5011.223260394645;4614.123316569841;4716.221823399101;4954.5788607968725;4955.851324460272;5002.974985125051;4691.03833714081;4696.107739529479;4816.54242846929;4824.179889418737;4857.489963553918;4960.454350021567;4966.106100901872;4973.079980203674;4976.527229913152;5012.47369026247;4557.111363284128;4658.906821863611;4862.756862156949;4875.902481950412;4898.804047838046 07:47:57 INFO - 2015-11-19 07:47:57,741 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.0978329780702;565.4825834361557;568.1392690074538;575.2694078520277;577.2639884147711;26856.597151042726;27529.449411011767;35971;36768.26463470729;37095.81452092742;41032.17935641285;41654;41661.95845103866;41671.166576668526;41735.373969390406;6911.827204319907;7970;8132.959335203345;8146.714864979697;8150.959245203795;6999.860002799941;7083.85832283354;7084.964575177142;7085.078939737853;7086.114235720535;10127.49362531874;10377.688669339932;10386.221033422486;10388.480575971209;10389.532471038821;10098.646547370843;10203.38779673222;10203.591856325738;10205.38767673942;10205.591776328938;7175.3900918422;7385.335319821188;7388.963055184743;9850.310478266525;9977.551010204557;27299.181024569294;42253;43188.56811431908;43256.56743432588;43267.350989735176;2730;2743.231895069384;2762.6408566886375;2858.8999385021634;2907.5638654201825;26625.33436664099;26708.19875403741;26713.599296010576;26887.59668604953;27385.863070684518;2797.839742986831;2872.7989040767156;2899.60855284536;2929.340898297887;2983.9403211935855;222459;243971;249899.75050124814;309514.99999999773;315091;44754.77622611866;44962.85260031832;45191;45200.09599808051;45214.54785452169;48479.75760121177;48696.5130348692;48747.26879096816;48805;48807.26789098166;14137.575872723835;14346.354414051393;14349.282535873164;14360.210188439736;14454;11001.504932277907;11070.5571777128;11070.833937490945;11072.280301780358;11081.113510919107;19629;20070.89964550197;20076;20263.696044559343;20321.288754893507;7761.7671469855995;7986.32116270112;8008.679652813822;8036.598170091589;8114.362832079598;774.4965772248083;817.2767101115555;834.6327615849007;936.5551363102608;977.9559919803626;26139.215823525326;29618.703812962027;31816.840915795274;31854;32409.837950810568;871.172386233081;927.5686805635412;934.6448349627099;966.8018056298442;1004.8141093897652;15465.226738663247;15538.611534711497;16715.991121597985;16799.83200168007;16878.915605421895;328657;337286;339425;340084;340128;48824.511754882704;49237.50762492401;49346.259806102935;49350;49357.753211234434;1047.4291511126303;1161.227783523964;1163.5113252433998;1180.7815554122515;1181.645506348092;29991.65037573358;31378;31621.36757264888;31624.683753162175;31784.205394865312;44678.776606116764;45259;45380.09239815251;45389;45462;249076;262305;263032;307313;312575;28035.579466307612;28038.43923121567;28097.859510702314;28472.288192794516;28516.857415713617;38676.950872073;40347.79826100851;40498.39252411157;40776;40857.79571102125;33657;34412;34708.82645586756;35070.649293506736;35225.82387088048;35038;38028;40222.26886137076;40296.395554066126;40662.59337406588;33545;34090.65909340974;34340;34379.312413752086;34458.31083378368;28571.857140714164;30745.538816917317;30917.227069322547;30926.381472369976;31065;23676.763232368146;23992.76007239905;24043.879780600986;24274;24372.51254974926 07:47:57 INFO - 2015-11-19 07:47:57,744 DEBUG : BROWSER_OUTPUT: |2;jquery.html;312.0980366740123;316.2993968360083;320.7177683638398;321.9484882418813;322.63058797676644;12767.680807979805;13129.803052954214;15640.452584159557;16221.351145954162;16323.59191020225;15152.696946061073;15208.847911520881;15338.923305383485;15385.461508847193;15484.535463936072;4753.144434001878;4754.833580824672;4856.611471082322;4856.878578035559;4858.635602329822;3561.2165323628888;3691.3724666806575;4896.216605343146;5615.66306021638;5781.624194427349;5651.802186923458;5678.318601767773;5705.25831641886;5724.971375143118;5730.484256416921;5682.204491371191;5862.648241105548;5864.970675146597;5867.031939729939;5868.6478811271245;5036.420811606676;5036.773345199438;5046.167382381903;5049.3183420238165;5059.241113832954;19295.51761205981;19590.412287631392;19847.60304793896;19882.304119355755;19901.9004904976;1750.2473936207425;1753.105915982845;1756.604763928106;1759.5513144148288;1775.8845675031082;12225.572104976372;12291.262524248574;12398.938005309916;12570.560030398983;12894.161879477897;1634.9591260218472;1717.7251639737708;1721.8794684372099;1779.0748810618406;1811.8097599751968;53317;53500.73249633727;53705;53796.99999999961;54523.45476545223;8749.91250087491;8861.158189971942;9059.864102038475;9064.637414503479;9098.818023639491;11275.097992160607;11289.20975531705;11303.773924521463;11304.321740695585;11309.60416385439;4914.729689867092;5001.299818025479;5040.294358789773;6787.796366109024;6864.759733409307;5138.948610513922;5176.301199338116;5177.326947496801;5187.299714538489;5195.714235716996;2872.35372041289;2893.4068515954177;2911.228524441025;2974.5240761478058;2977.851107444619;1033.4832583708146;1038.0916697889347;1038.3977293169944;1074.9462526873624;1076.741582020325;372.4841095083329;410.6365866208427;442.2040327410648;445.025394386293;450.2435907675137;10083.19334453242;10153.796924061626;10311.432871192157;10478.476076196312;10553.47232638365;354.9627289134655;409.35935261315944;422.18307574842777;422.4782393743724;435.20357745325975;5329.9467005330225;5508.6970216637665;5572.108462645957;5576.414476479992;5626.493615574618;478547;481217;487477;496666;498458;60441.395586043574;64210;66361.33638663648;66625.33870596791;67848.6607566959;475.92385218365587;477.520092307229;482.08644618448545;483.2075396349989;486.25117319327836;9565.856512152184;9579.329446938926;9656.71029869105;9724.70825875225;9913.256505762241;28188.71811281861;30128.548071778503;30450;30695.846520767253;33503.16242093967;34799.4780078294;35691.821540893165;37061.44407833831;37865;39509.604903951746;5754.942450575608;6050.7277172526465;6057.18228039209;6059.182010428536;6061.333253342217;10537.57849686004;10578.576856925636;10844;10949.45252737344;10949.452527373758;9298;9313.767155821159;9505.477198754135;9526.428414295164;9529.714108576754;8505.362097842562;9377.906220937703;9437.433753974783;9509.334346595671;9712.562934667816;9295.953520232355;9355.532223388667;9426.670066547638;9486.430814151174;9861.359011664506;5628.521575666115;5702.629329093762;5743.59794814359;5821.126830975388;5874.177615133799;9586.089321514444;9611.134997850228;9648.083432073941;9710.417374957526;9794.412335259622 07:47:57 INFO - 2015-11-19 07:47:57,746 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1434.4047220403534;1595.5931237534428;1650.0429750744565;1662.1772222749742;1693.4073074423952;5921.348651648321;6446.516511261657;6605.900911486331;6611.272759996408;6613.3717296856785;6808.285130061334;6908.896366554506;6923.238443771181;6926.099607051076;6928.168619765623;1993.4916596267967;2004.26844201866;2015.4961259685078;2016.4253187841468;2017.6368253714325;2033.5932813437298;2055.2806517718827;2060.6702927531596;2064.3187748043183;2069.1206237349143;1985.8808471491684;2011.5272910865936;2020.7069974853637;2022.7876073012342;2024.473636854421;1964.0866996846464;1965.7935916728823;1972.3688419705556;1973.6052789442097;1973.703944408336;2024.7873973232745;2040.0309852819792;2041.428400047989;2042.8774273543486;2045.417056139008;5780.277465316835;5942.108683697436;6787.185537735503;6816.045753594501;6824.931750682479;3599.1002249437643;3669.082729317671;3670.082479380155;3684.4841722158917;3950.0914789598555;2703.7431444012786;2730.262829036169;2746.231055304518;2782.8330300182056;2783.7912156588136;803.7347675267148;806.4435539477741;1656.4864891883556;1660.850523452895;1704.9573760656083;9147.313951453601;9237.815243695155;9259.537023148883;9283.582238799203;9286.071392860727;3642.399004164336;3673.7061035117126;3732.458793474931;3732.682721968663;3747.45661879026;7720.575368354682;7739.961300193576;7748.6125693715085;7755.2244775521995;7765.495242809312;4091.0590564170407;4107.67138628909;4118.711690181718;4123.670106391482;4133.751974881457;3813.103920578662;3820.9044773880873;3821.2357528494413;3824.7131465140224;3827.158025234444;3081.6764239754953;3086.537019447101;3090.5364195370876;3091.412631599989;3122.125804774667;920.9171174594319;935.3405848876525;936.765808547863;944.7732544189345;945.3288165402504;1092.153580974735;1131.7962766701908;1132.9263597866113;1161.2277835239472;1162.831389448542;6660.367265109807;6684.364985326386;6685.866282674319;6724.663766811737;6729.2934241903895;381.8090954522739;382.23552894211576;383.9040239940015;388.99805500972315;389.7973054011898;4789.832355867528;5261.421243663194;5302;5305.60207984395;5312.468753124656;7108.71565137399;7617.542947423172;7796.922030779733;7819.804504887424;7819.843603127905;7980.281774640194;8058.476199047043;8138.755837324889;8164.061132969666;8167.305779008732;6443.323451037667;6588.51758354376;6629.436497897636;6633.1376920999965;6646;6543.476521878333;6564.376384243489;6564.868702626016;6564.901526477011;6603.174603174603;7079.292070793085;7312.122545294386;7370;7409.407247420301;7409.888851667121;7488.850222995618;7738.4969976951315;7750.224977502205;7837.647305871364;7847.568383738949;5885.882282354243;5888.646681199141;5924.7926322578505;5939.91090133657;6021.397860213943;6508.902366464602;6578.80263592093;6583.242927063257;6585.242697089704;6591.769288074895;5825.3592104867585;6121.785737499166;6201.255849298113;6273.780417685359;6288.748450062129;5532;5855.824325270249;5903.439173278532;5963.701814909324;5975.611585246945;5880.764769409347;6239.594426362272;6244.937550624436;6249;6249.593776404519;5702.372738998624;5737;5740.68426236561;5747.971260143672;5772.1341798728845;5747.885042299215;5772;5820.1560773688425;5825.097109947965;5827.912581311199 07:47:57 INFO - 2015-11-19 07:47:57,746 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.7276941366876;282.75117896251294;286.74336468860383;287.22449386656035;290.2294408345842;5251.973740131303;5301.443348448411;5340;5349.037173308803;5422.864428389287;5285.207218917164;5287.947120528794;5291.4708529147065;5297.549708274802;5316.73416329183;4082.3264161413404;4093.447384603085;4099.098198396363;4099.795010249491;4116.608922152391;4101.4668093148;4104.179164167163;4105.3431450967855;4105.979470102645;4109.527404348508;4056.553779084298;4056.574059723731;4059.249038927793;4062.3906414037833;4065.695072869532;3868.70984676149;3958.6635136013474;3981.163955569334;3992.301347264246;3996.360582306846;3408.4205685033603;3409.215880347509;3410.6077801052948;3411.812350320731;3413.4709120086427;5123.077845987721;5124.743762811844;5145.511176438233;5153.072446959546;5153.819616313449;4563.292689633112;4566.246569316058;4566.817327306937;4567.5889169974525;4569.611583015448;5414.187871819258;5588.413216612278;5589.469000444951;5590.357108932443;5595.244641973363;3805.7335986480957;3805.82873770681;3807.276617442677;3808.6572208501366;3814.9618503815163;5610.887782244332;5743.339515955677;5783.392743761929;5880.176775251468;5882.264716910387;3783.9621603784162;3793.279276937373;3871.361225397834;3873.1285460771664;3902.492675952108;3912.8434862605745;3922.1567363016516;3937.5274967004143;3937.783421911765;3938.606139386096;4328.394024836525;4419.889502762392;4438.822447102144;4579.335996280521;4592.471865735416;5571.331440227118;5573.637713548606;5576.275084239104;5582.665040097607;5582.748776305076;1374.4433504430522;1394.7350003499303;1395.888328933683;1395.9720805583831;1396.5670642100981;889.8487257166297;906.6690657909948;910.8815853939078;921.2491819167357;923.7598224461689;4913.508649135058;4915.361003069578;4920.163572192736;4921.803127874917;4927.285543596158;5765.308163020381;5780.971095144498;5791.739371728282;5801.245838041028;5812.21535092757;4891.608671306287;4894.877628059256;4901.803927842846;4905.901881962341;4910.165271903785;3046.329807442359;3093.458644737207;3127.1400364899832;3128.7966282191583;3133.9529907051415;5544.362398324244;5571.220029195916;5581.720913954286;5583.330000399978;5586.413426590149;6052.757889684452;6056.515478761688;6059.303180134253;6062.393760623902;6062.545309101835;5560.888782224333;5561.972190139023;5567.916481252784;5573.21974923503;5580.720963951786;5653.575981801464;5799.101139323411;5850.94149058504;5870.647761134345;5879.617824841372;5740.024195886625;5748;5749.195112684311;5749.798757043483;5753.539716822728;5567.3040869891265;5571.9442805571425;5574.888502229852;5577.609567330248;5581.190727344593;3786.3752480840353;3862.304785138702;3913.745606535566;3914.0801911550193;3929.8821035368983;5567.3040869891265;5721.771129154788;5790.536757059341;5791.986402379651;5799.594028418139;5464.535514481314;5528.198411230269;5531;5533.446655334435;5536;5621.775128994795;5622.7750889963945;5631.408702086222;5633.0705433603;5636.323641162922;5390.38010628767;5496.422875598165;5498.917516237339;5505.724713764215;5509.201165830852;5658.745356458887;5660.207570940154;5660.29246344207;5663.745131469176;5676.659400435987;5517.668939863461;5520.337559492726;5523.944760552504;5525.392206857162;5526.143447765603 07:47:57 INFO - 2015-11-19 07:47:57,747 DEBUG : BROWSER_OUTPUT: |5;yui.html;610.9450149486545;702.2415790945779;713.9643017849106;720.7945735465391;723.1177962885278;11451.541938322467;11756.529738810448;12332.691682707937;12396.752064958719;12409.503619855195;11790.410479476035;11795.351255680935;11854.881451185485;11876.28742275464;11881.10891683125;500.9574186194178;503.9596832253429;773.7407968330588;783.3693876429458;788.9566073865935;781.8319061401797;782.2177822177822;787.4094429178116;787.9960600196991;788.696351904518;615.6429271022819;822.3585603229461;822.4859462835727;822.6585966823761;822.9218224268685;614.2751553167261;806.9596520173997;817.6811043692965;819.3690858039306;819.6229734322219;609.2049874913237;609.3571282297174;609.8079105081885;609.8414412252802;609.9481544068759;11446.370449625267;11539.423028848523;11591.710207244887;11606.593769218036;11652.41737913101;10419.895801041968;10501.527431265611;10826.566937322497;11161.609343673013;11229.66311010671;9128.680496182602;9171.862422063674;9977.102060814488;10179.592816287339;10432.530536125892;2760.254731222559;2764.557670772687;2765.4192619549917;2767.1421859223506;2810;36240.63759362399;36358.091047723756;36581.26837463236;36618.633813662054;37168.25663486715;6131.14164017038;6179.752809887644;6191.721372538156;6230.719617617218;6463.7737679181;10145.746356341151;10147.137493313003;10147.797044059078;10157.765291635827;10170.542325595366;5231.744013983133;5254.747741244975;5283.1546952487415;5335.973320133375;5382.4886635769535;3412.744044196695;3422.9315413692084;3440.1055725511546;3509.6841284284537;3564.7682900611376;2416.637504374358;2449.6080627099577;2450.0322372663054;2451.534208500415;2452.509498100387;361.91133172372935;371.97210209234413;383.96736277416176;389.20407766118353;390.1553137457373;408.6301896783416;414.81540714382413;422.97250678705785;427.04555318862316;462.2996160816366;6851.725930962805;7101.360877520945;7124.43004559634;7255.927440725631;7354.485186037033;427.393101795445;434.0104561599495;476.52585677250664;536.6458137629224;564.3340857787849;3351.916202094967;3396.7282617391043;3490.092575930226;3542.3977923753023;3561.4835848801777;43871.56128438738;44263.55736442659;44684.55315446869;44783.776081120035;45168;42673;42860;42879.57120428818;43027.35458968118;43028.56971430246;38414.60375063506;39590.60409395869;39870.40194397028;39911.800440997606;39920.60079399227;7166.570005799668;7186;7242.275772422716;7316.597587132759;7324.816879578053;29358.706412935597;30146;30177.849110754305;30394.848025760613;30472.39055218839;34675.65324346724;34794.65205348015;34929.65070349264;35316.823415882754;39013;5829.854253643693;5906.084556893688;5942.61373010753;6132.8773424532155;6292.244930608356;8795.076516965883;9061.41100828444;9108.908910911072;9126.908730912606;9458.479783611967;8382.706605268786;8525.275351595184;8532.658693652184;8540.615672294638;8590.14098590161;8876.334274929277;8932.419392739452;8956.865647015431;8999.64001439935;9071.591778369857;8378.11633674224;8908.02011778691;8918.86621700688;8976.775580610276;10744.19418543628;8343.374246931384;8377.916220837713;8458.661653533789;8579.227869491775;8677.305815534868;8314.586520291445;8641.611127499404;8721.127887211229;8898.231558281368;8991.505467199106 07:47:57 INFO - 2015-11-19 07:47:57,747 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:47:57 INFO - 2015-11-19 07:47:57,747 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:47:57 INFO - 2015-11-19 07:47:57,747 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 07:47:57 INFO - 2015-11-19 07:47:57,747 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: __startTimestamp1447948077736__endTimestamp 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4660.12 Median:4748.53 stddev:478.14 (10.1%) stddev-sans-first:453.10 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: Values: 2658.8 2747.1 2748.3 2756.7 2777.2 4525.2 4667.1 4693.5 4751.9 4767.1 4649.6 4683.8 4686.8 4730.9 4788.3 4294.1 4334.1 4370.4 4377.5 4397.4 4433.4 4485.2 4491.8 4492.4 4497.0 4170.5 4190.2 4299.7 4322.7 4333.8 4342.0 4383.4 4391.3 4415.4 4435.9 4137.7 4367.0 4367.8 4372.1 4413.4 4576.7 4594.5 4674.6 4683.4 4705.4 5050.6 5065.6 5067.2 5074.1 5105.8 4839.8 4943.6 5100.0 5107.5 5108.6 4624.5 4664.0 4697.2 4735.6 4770.1 5140.2 5215.5 5217.1 5224.9 5266.5 4639.5 4743.1 5015.5 5024.6 5033.7 4962.1 4964.3 5056.9 5077.4 5094.1 5059.5 5076.0 5080.3 5080.8 5124.1 5063.3 5066.2 5069.5 5072.3 5075.2 4022.8 4088.2 4113.8 4120.9 4176.2 3727.7 3729.0 3758.3 3770.5 3779.8 4408.3 4413.6 4417.3 4441.0 4442.4 4760.3 4870.3 4874.6 4966.8 5138.3 4389.6 4393.3 4394.7 4428.4 4433.7 4523.7 4525.1 4528.7 4529.3 4569.7 4599.1 4721.9 4727.4 4856.2 4864.7 4983.3 5079.5 5084.9 5105.2 5112.9 4801.2 4805.6 4808.5 4813.9 4849.4 4748.5 4861.9 5000.0 5004.9 5043.4 4928.8 4995.8 5081.4 5084.7 5116.8 4953.0 4953.5 4965.0 4969.6 5011.2 4614.1 4716.2 4954.6 4955.9 5003.0 4691.0 4696.1 4816.5 4824.2 4857.5 4960.5 4966.1 4973.1 4976.5 5012.5 4557.1 4658.9 4862.8 4875.9 4898.8 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,748 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45236.34 Median:33601.00 stddev:77850.46 (231.7%) stddev-sans-first:77996.59 07:47:57 INFO - 2015-11-19 07:47:57,749 DEBUG : BROWSER_OUTPUT: Values: 562.1 565.5 568.1 575.3 577.3 26856.6 27529.4 35971.0 36768.3 37095.8 41032.2 41654.0 41662.0 41671.2 41735.4 6911.8 7970.0 8133.0 8146.7 8151.0 6999.9 7083.9 7085.0 7085.1 7086.1 10127.5 10377.7 10386.2 10388.5 10389.5 10098.6 10203.4 10203.6 10205.4 10205.6 7175.4 7385.3 7389.0 9850.3 9977.6 27299.2 42253.0 43188.6 43256.6 43267.4 2730.0 2743.2 2762.6 2858.9 2907.6 26625.3 26708.2 26713.6 26887.6 27385.9 2797.8 2872.8 2899.6 2929.3 2983.9 222459.0 243971.0 249899.8 309515.0 315091.0 44754.8 44962.9 45191.0 45200.1 45214.5 48479.8 48696.5 48747.3 48805.0 48807.3 14137.6 14346.4 14349.3 14360.2 14454.0 11001.5 11070.6 11070.8 11072.3 11081.1 19629.0 20070.9 20076.0 20263.7 20321.3 7761.8 7986.3 8008.7 8036.6 8114.4 774.5 817.3 834.6 936.6 978.0 26139.2 29618.7 31816.8 31854.0 32409.8 871.2 927.6 934.6 966.8 1004.8 15465.2 15538.6 16716.0 16799.8 16878.9 328657.0 337286.0 339425.0 340084.0 340128.0 48824.5 49237.5 49346.3 49350.0 49357.8 1047.4 1161.2 1163.5 1180.8 1181.6 29991.7 31378.0 31621.4 31624.7 31784.2 44678.8 45259.0 45380.1 45389.0 45462.0 249076.0 262305.0 263032.0 307313.0 312575.0 28035.6 28038.4 28097.9 28472.3 28516.9 38677.0 40347.8 40498.4 40776.0 40857.8 33657.0 34412.0 34708.8 35070.6 35225.8 35038.0 38028.0 40222.3 40296.4 40662.6 33545.0 34090.7 34340.0 34379.3 34458.3 28571.9 30745.5 30917.2 30926.4 31065.0 23676.8 23992.8 24043.9 24274.0 24372.5 07:47:57 INFO - 2015-11-19 07:47:57,749 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,750 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24709.36 Median:4856.75 stddev:79862.62 (1644.4%) stddev-sans-first:80065.64 07:47:57 INFO - 2015-11-19 07:47:57,750 DEBUG : BROWSER_OUTPUT: Values: 312.1 316.3 320.7 321.9 322.6 12767.7 13129.8 15640.5 16221.4 16323.6 15152.7 15208.8 15338.9 15385.5 15484.5 4753.1 4754.8 4856.6 4856.9 4858.6 3561.2 3691.4 4896.2 5615.7 5781.6 5651.8 5678.3 5705.3 5725.0 5730.5 5682.2 5862.6 5865.0 5867.0 5868.6 5036.4 5036.8 5046.2 5049.3 5059.2 19295.5 19590.4 19847.6 19882.3 19901.9 1750.2 1753.1 1756.6 1759.6 1775.9 12225.6 12291.3 12398.9 12570.6 12894.2 1635.0 1717.7 1721.9 1779.1 1811.8 53317.0 53500.7 53705.0 53797.0 54523.5 8749.9 8861.2 9059.9 9064.6 9098.8 11275.1 11289.2 11303.8 11304.3 11309.6 4914.7 5001.3 5040.3 6787.8 6864.8 5138.9 5176.3 5177.3 5187.3 5195.7 2872.4 2893.4 2911.2 2974.5 2977.9 1033.5 1038.1 1038.4 1074.9 1076.7 372.5 410.6 442.2 445.0 450.2 10083.2 10153.8 10311.4 10478.5 10553.5 355.0 409.4 422.2 422.5 435.2 5329.9 5508.7 5572.1 5576.4 5626.5 478547.0 481217.0 487477.0 496666.0 498458.0 60441.4 64210.0 66361.3 66625.3 67848.7 475.9 477.5 482.1 483.2 486.3 9565.9 9579.3 9656.7 9724.7 9913.3 28188.7 30128.5 30450.0 30695.8 33503.2 34799.5 35691.8 37061.4 37865.0 39509.6 5754.9 6050.7 6057.2 6059.2 6061.3 10537.6 10578.6 10844.0 10949.5 10949.5 9298.0 9313.8 9505.5 9526.4 9529.7 8505.4 9377.9 9437.4 9509.3 9712.6 9296.0 9355.5 9426.7 9486.4 9861.4 5628.5 5702.6 5743.6 5821.1 5874.2 9586.1 9611.1 9648.1 9710.4 9794.4 07:47:57 INFO - 2015-11-19 07:47:57,750 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,750 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4763.05 Median:5841.87 stddev:2442.64 (41.8%) stddev-sans-first:2436.68 07:47:57 INFO - 2015-11-19 07:47:57,750 DEBUG : BROWSER_OUTPUT: Values: 1434.4 1595.6 1650.0 1662.2 1693.4 5921.3 6446.5 6605.9 6611.3 6613.4 6808.3 6908.9 6923.2 6926.1 6928.2 1993.5 2004.3 2015.5 2016.4 2017.6 2033.6 2055.3 2060.7 2064.3 2069.1 1985.9 2011.5 2020.7 2022.8 2024.5 1964.1 1965.8 1972.4 1973.6 1973.7 2024.8 2040.0 2041.4 2042.9 2045.4 5780.3 5942.1 6787.2 6816.0 6824.9 3599.1 3669.1 3670.1 3684.5 3950.1 2703.7 2730.3 2746.2 2782.8 2783.8 803.7 806.4 1656.5 1660.9 1705.0 9147.3 9237.8 9259.5 9283.6 9286.1 3642.4 3673.7 3732.5 3732.7 3747.5 7720.6 7740.0 7748.6 7755.2 7765.5 4091.1 4107.7 4118.7 4123.7 4133.8 3813.1 3820.9 3821.2 3824.7 3827.2 3081.7 3086.5 3090.5 3091.4 3122.1 920.9 935.3 936.8 944.8 945.3 1092.2 1131.8 1132.9 1161.2 1162.8 6660.4 6684.4 6685.9 6724.7 6729.3 381.8 382.2 383.9 389.0 389.8 4789.8 5261.4 5302.0 5305.6 5312.5 7108.7 7617.5 7796.9 7819.8 7819.8 7980.3 8058.5 8138.8 8164.1 8167.3 6443.3 6588.5 6629.4 6633.1 6646.0 6543.5 6564.4 6564.9 6564.9 6603.2 7079.3 7312.1 7370.0 7409.4 7409.9 7488.9 7738.5 7750.2 7837.6 7847.6 5885.9 5888.6 5924.8 5939.9 6021.4 6508.9 6578.8 6583.2 6585.2 6591.8 5825.4 6121.8 6201.3 6273.8 6288.7 5532.0 5855.8 5903.4 5963.7 5975.6 5880.8 6239.6 6244.9 6249.0 6249.6 5702.4 5737.0 5740.7 5748.0 5772.1 5747.9 5772.0 5820.2 5825.1 5827.9 07:47:57 INFO - 2015-11-19 07:47:57,750 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,750 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4611.28 Median:5309.09 stddev:1393.08 (26.2%) stddev-sans-first:1358.54 07:47:57 INFO - 2015-11-19 07:47:57,751 DEBUG : BROWSER_OUTPUT: Values: 280.7 282.8 286.7 287.2 290.2 5252.0 5301.4 5340.0 5349.0 5422.9 5285.2 5287.9 5291.5 5297.5 5316.7 4082.3 4093.4 4099.1 4099.8 4116.6 4101.5 4104.2 4105.3 4106.0 4109.5 4056.6 4056.6 4059.2 4062.4 4065.7 3868.7 3958.7 3981.2 3992.3 3996.4 3408.4 3409.2 3410.6 3411.8 3413.5 5123.1 5124.7 5145.5 5153.1 5153.8 4563.3 4566.2 4566.8 4567.6 4569.6 5414.2 5588.4 5589.5 5590.4 5595.2 3805.7 3805.8 3807.3 3808.7 3815.0 5610.9 5743.3 5783.4 5880.2 5882.3 3784.0 3793.3 3871.4 3873.1 3902.5 3912.8 3922.2 3937.5 3937.8 3938.6 4328.4 4419.9 4438.8 4579.3 4592.5 5571.3 5573.6 5576.3 5582.7 5582.7 1374.4 1394.7 1395.9 1396.0 1396.6 889.8 906.7 910.9 921.2 923.8 4913.5 4915.4 4920.2 4921.8 4927.3 5765.3 5781.0 5791.7 5801.2 5812.2 4891.6 4894.9 4901.8 4905.9 4910.2 3046.3 3093.5 3127.1 3128.8 3134.0 5544.4 5571.2 5581.7 5583.3 5586.4 6052.8 6056.5 6059.3 6062.4 6062.5 5560.9 5562.0 5567.9 5573.2 5580.7 5653.6 5799.1 5850.9 5870.6 5879.6 5740.0 5748.0 5749.2 5749.8 5753.5 5567.3 5571.9 5574.9 5577.6 5581.2 3786.4 3862.3 3913.7 3914.1 3929.9 5567.3 5721.8 5790.5 5792.0 5799.6 5464.5 5528.2 5531.0 5533.4 5536.0 5621.8 5622.8 5631.4 5633.1 5636.3 5390.4 5496.4 5498.9 5505.7 5509.2 5658.7 5660.2 5660.3 5663.7 5676.7 5517.7 5520.3 5523.9 5525.4 5526.1 07:47:57 INFO - 2015-11-19 07:47:57,751 DEBUG : BROWSER_OUTPUT: 07:47:57 INFO - 2015-11-19 07:47:57,752 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11065.61 Median:488.74 stddev:12903.58 (2640.2%) stddev-sans-first:12915.89 07:47:57 INFO - 2015-11-19 07:47:57,753 DEBUG : BROWSER_OUTPUT: Values: 610.9 702.2 714.0 720.8 723.1 11451.5 11756.5 12332.7 12396.8 12409.5 11790.4 11795.4 11854.9 11876.3 11881.1 501.0 504.0 773.7 783.4 789.0 781.8 782.2 787.4 788.0 788.7 615.6 822.4 822.5 822.7 822.9 614.3 807.0 817.7 819.4 819.6 609.2 609.4 609.8 609.8 609.9 11446.4 11539.4 11591.7 11606.6 11652.4 10419.9 10501.5 10826.6 11161.6 11229.7 9128.7 9171.9 9977.1 10179.6 10432.5 2760.3 2764.6 2765.4 2767.1 2810.0 36240.6 36358.1 36581.3 36618.6 37168.3 6131.1 6179.8 6191.7 6230.7 6463.8 10145.7 10147.1 10147.8 10157.8 10170.5 5231.7 5254.7 5283.2 5336.0 5382.5 3412.7 3422.9 3440.1 3509.7 3564.8 2416.6 2449.6 2450.0 2451.5 2452.5 361.9 372.0 384.0 389.2 390.2 408.6 414.8 423.0 427.0 462.3 6851.7 7101.4 7124.4 7255.9 7354.5 427.4 434.0 476.5 536.6 564.3 3351.9 3396.7 3490.1 3542.4 3561.5 43871.6 44263.6 44684.6 44783.8 45168.0 42673.0 42860.0 42879.6 43027.4 43028.6 38414.6 39590.6 39870.4 39911.8 39920.6 7166.6 7186.0 7242.3 7316.6 7324.8 29358.7 30146.0 30177.8 30394.8 30472.4 34675.7 34794.7 34929.7 35316.8 39013.0 5829.9 5906.1 5942.6 6132.9 6292.2 8795.1 9061.4 9108.9 9126.9 9458.5 8382.7 8525.3 8532.7 8540.6 8590.1 8876.3 8932.4 8956.9 8999.6 9071.6 8378.1 8908.0 8918.9 8976.8 10744.2 8343.4 8377.9 8458.7 8579.2 8677.3 8314.6 8641.6 8721.1 8898.2 8991.5 07:47:57 INFO - 2015-11-19 07:47:57,753 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:47:57 INFO - 2015-11-19 07:47:57,753 DEBUG : BROWSER_OUTPUT: 07:47:58 INFO - 2015-11-19 07:47:58,506 INFO : Browser exited with error code: 0 07:47:58 INFO - 2015-11-19 07:47:58,524 INFO : Completed test dromaeo_css (00:18:36) 07:47:58 INFO - 2015-11-19 07:47:58,524 INFO : Starting test kraken 07:47:58 INFO - 2015-11-19 07:47:58,524 DEBUG : operating with platform_type : linux_ 07:47:58 INFO - 2015-11-19 07:47:58,524 INFO : Initialising browser for kraken test... 07:47:58 INFO - 2015-11-19 07:47:58,530 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppLb9Lw/profile http://localhost:42844/getInfo.html 07:48:02 INFO - 2015-11-19 07:48:02,345 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:48:02 INFO - 2015-11-19 07:48:02,345 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:48:02 INFO - 2015-11-19 07:48:02,345 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:48:02 INFO - 2015-11-19 07:48:02,345 DEBUG : BROWSER_OUTPUT: __metrics 07:48:02 INFO - 2015-11-19 07:48:02,441 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:03 INFO - 2015-11-19 07:48:03,535 INFO : Browser initialized. 07:48:03 INFO - 2015-11-19 07:48:03,535 INFO : Running cycle 1/1 for kraken test... 07:48:03 INFO - 2015-11-19 07:48:03,535 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppLb9Lw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:48:15 INFO - 2015-11-19 07:48:15,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 142094336 07:48:15 INFO - 2015-11-19 07:48:15,589 DEBUG : BROWSER_OUTPUT: 07:48:18 INFO - 2015-11-19 07:48:18,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:18 INFO - 2015-11-19 07:48:18,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 176762880 07:48:18 INFO - 2015-11-19 07:48:18,797 DEBUG : BROWSER_OUTPUT: 07:48:21 INFO - 2015-11-19 07:48:21,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-dft) 07:48:22 INFO - 2015-11-19 07:48:22,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 165765120 07:48:22 INFO - 2015-11-19 07:48:22,122 DEBUG : BROWSER_OUTPUT: 07:48:25 INFO - 2015-11-19 07:48:25,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-fft) 07:48:25 INFO - 2015-11-19 07:48:25,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 153300992 07:48:25 INFO - 2015-11-19 07:48:25,693 DEBUG : BROWSER_OUTPUT: 07:48:27 INFO - 2015-11-19 07:48:27,745 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42844/tests/kraken/driver.html?testName=audio-oscillator) 07:48:28 INFO - 2015-11-19 07:48:28,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 154529792 07:48:28 INFO - 2015-11-19 07:48:28,319 DEBUG : BROWSER_OUTPUT: 07:48:30 INFO - 2015-11-19 07:48:30,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42844/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:31 INFO - 2015-11-19 07:48:31,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 156069888 07:48:31 INFO - 2015-11-19 07:48:31,113 DEBUG : BROWSER_OUTPUT: 07:48:34 INFO - 2015-11-19 07:48:34,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42844/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:34 INFO - 2015-11-19 07:48:34,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 156286976 07:48:34 INFO - 2015-11-19 07:48:34,673 DEBUG : BROWSER_OUTPUT: 07:48:38 INFO - 2015-11-19 07:48:38,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42844/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:38 INFO - 2015-11-19 07:48:38,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 157282304 07:48:38 INFO - 2015-11-19 07:48:38,657 DEBUG : BROWSER_OUTPUT: 07:48:41 INFO - 2015-11-19 07:48:41,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42844/tests/kraken/driver.html?testName=json-parse-financial) 07:48:42 INFO - 2015-11-19 07:48:42,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 155705344 07:48:42 INFO - 2015-11-19 07:48:42,034 DEBUG : BROWSER_OUTPUT: 07:48:43 INFO - 2015-11-19 07:48:43,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42844/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:44 INFO - 2015-11-19 07:48:44,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 165179392 07:48:44 INFO - 2015-11-19 07:48:44,342 DEBUG : BROWSER_OUTPUT: 07:48:46 INFO - 2015-11-19 07:48:46,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:46 INFO - 2015-11-19 07:48:46,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 163581952 07:48:46 INFO - 2015-11-19 07:48:46,827 DEBUG : BROWSER_OUTPUT: 07:48:49 INFO - 2015-11-19 07:48:49,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:49 INFO - 2015-11-19 07:48:49,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 173764608 07:48:49 INFO - 2015-11-19 07:48:49,583 DEBUG : BROWSER_OUTPUT: 07:48:52 INFO - 2015-11-19 07:48:52,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:52 INFO - 2015-11-19 07:48:52,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 178556928 07:48:52 INFO - 2015-11-19 07:48:52,700 DEBUG : BROWSER_OUTPUT: 07:48:55 INFO - 2015-11-19 07:48:55,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:55 INFO - 2015-11-19 07:48:55,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 176427008 07:48:55 INFO - 2015-11-19 07:48:55,899 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42844/tests/kraken/driver.html?testName=ai-astar) 07:48:57 INFO - 2015-11-19 07:48:57,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 235573248 07:48:57 INFO - 2015-11-19 07:48:57,927 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,931 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:48:57 INFO - 2015-11-19 07:48:57,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:48:57 INFO - 2015-11-19 07:48:57,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:48:57 INFO - 2015-11-19 07:48:57,931 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:48:57 INFO - 2015-11-19 07:48:57,931 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;110;114;113;113;102;112;103;114 07:48:57 INFO - 2015-11-19 07:48:57,931 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;132;163;165;133;159;159;139;167;132 07:48:57 INFO - 2015-11-19 07:48:57,932 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;161;160;161;161;162;162;163;165 07:48:57 INFO - 2015-11-19 07:48:57,932 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;86;94;73;72;73;114;94;74 07:48:57 INFO - 2015-11-19 07:48:57,932 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;129;92;93;92;138;93;92;132 07:48:57 INFO - 2015-11-19 07:48:57,932 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;108;109;110;110;111;110;110;109;110 07:48:57 INFO - 2015-11-19 07:48:57,932 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;148;148;148;149;147;148;147;149 07:48:57 INFO - 2015-11-19 07:48:57,932 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;95;95;96;95;95;95 07:48:57 INFO - 2015-11-19 07:48:57,932 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;69;69;69;69;67;69;78;66;66 07:48:57 INFO - 2015-11-19 07:48:57,933 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;70;69;69;70;69;70;69 07:48:57 INFO - 2015-11-19 07:48:57,933 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;84;83;83;82;83;81;83;86;83 07:48:57 INFO - 2015-11-19 07:48:57,933 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;126;127;119;130;122;129;125;128;125 07:48:57 INFO - 2015-11-19 07:48:57,933 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;143;143;148;149;139;151;149;147;142 07:48:57 INFO - 2015-11-19 07:48:57,933 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;72;69;74;70;69;69;68;69 07:48:57 INFO - 2015-11-19 07:48:57,933 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:48:57 INFO - 2015-11-19 07:48:57,933 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:48:57 INFO - 2015-11-19 07:48:57,934 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 07:48:57 INFO - 2015-11-19 07:48:57,934 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:48:57 INFO - 2015-11-19 07:48:57,934 DEBUG : BROWSER_OUTPUT: __startTimestamp1447948137930__endTimestamp 07:48:57 INFO - 2015-11-19 07:48:57,934 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:113.00 stddev:4.43 (3.9%) stddev-sans-first:4.67 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 110.0 114.0 113.0 113.0 102.0 112.0 103.0 114.0 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.60 Median:159.00 stddev:14.71 (9.3%) stddev-sans-first:15.42 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: Values: 157.0 132.0 163.0 165.0 133.0 159.0 159.0 139.0 167.0 132.0 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,942 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.55 (1.0%) stddev-sans-first:1.50 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 161.0 160.0 161.0 161.0 162.0 162.0 163.0 165.0 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.80 Median:74.00 stddev:14.05 (19.0%) stddev-sans-first:14.53 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 86.0 94.0 73.0 72.0 73.0 114.0 94.0 74.0 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.50 Median:92.00 stddev:19.79 (21.5%) stddev-sans-first:20.47 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 129.0 92.0 93.0 92.0 138.0 93.0 92.0 132.0 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: Values: 110.0 108.0 109.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 148.0 148.0 148.0 149.0 147.0 148.0 147.0 149.0 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:48:57 INFO - 2015-11-19 07:48:57,943 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.00 Median:69.00 stddev:3.40 (4.9%) stddev-sans-first:3.59 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 67.0 69.0 78.0 66.0 66.0 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 70.0 69.0 69.0 70.0 69.0 70.0 69.0 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:3.38 (4.1%) stddev-sans-first:1.36 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: Values: 93.0 84.0 83.0 83.0 82.0 83.0 81.0 83.0 86.0 83.0 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.50 stddev:3.58 (2.8%) stddev-sans-first:3.46 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: Values: 121.0 126.0 127.0 119.0 130.0 122.0 129.0 125.0 128.0 125.0 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.50 stddev:4.35 (2.9%) stddev-sans-first:4.03 07:48:57 INFO - 2015-11-19 07:48:57,944 DEBUG : BROWSER_OUTPUT: Values: 139.0 143.0 143.0 148.0 149.0 139.0 151.0 149.0 147.0 142.0 07:48:57 INFO - 2015-11-19 07:48:57,945 DEBUG : BROWSER_OUTPUT: 07:48:57 INFO - 2015-11-19 07:48:57,945 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.81 (2.6%) stddev-sans-first:1.90 07:48:57 INFO - 2015-11-19 07:48:57,945 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 69.0 74.0 70.0 69.0 69.0 68.0 69.0 07:48:57 INFO - 2015-11-19 07:48:57,945 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:48:57 INFO - 2015-11-19 07:48:57,945 DEBUG : BROWSER_OUTPUT: 07:48:58 INFO - 2015-11-19 07:48:58,825 INFO : Browser exited with error code: 0 07:48:58 INFO - 2015-11-19 07:48:58,876 INFO : Completed test kraken (00:01:00) 07:48:58 INFO - 2015-11-19 07:48:58,876 INFO : Starting test v8_7 07:48:58 INFO - 2015-11-19 07:48:58,876 DEBUG : operating with platform_type : linux_ 07:48:58 INFO - 2015-11-19 07:48:58,876 INFO : Initialising browser for v8_7 test... 07:48:58 INFO - 2015-11-19 07:48:58,882 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSyEupC/profile http://localhost:42844/getInfo.html 07:49:02 INFO - 2015-11-19 07:49:02,512 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:49:02 INFO - 2015-11-19 07:49:02,513 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:49:02 INFO - 2015-11-19 07:49:02,513 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:49:02 INFO - 2015-11-19 07:49:02,513 DEBUG : BROWSER_OUTPUT: __metrics 07:49:02 INFO - 2015-11-19 07:49:02,589 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:03 INFO - 2015-11-19 07:49:03,803 INFO : Browser initialized. 07:49:03 INFO - 2015-11-19 07:49:03,803 INFO : Running cycle 1/1 for v8_7 test... 07:49:03 INFO - 2015-11-19 07:49:03,803 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSyEupC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:49:15 INFO - 2015-11-19 07:49:15,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 141869056 07:49:15 INFO - 2015-11-19 07:49:15,793 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42844/tests/v8_7/run.html (next: http://localhost:42844/tests/v8_7/run.html) 07:49:37 INFO - 2015-11-19 07:49:37,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 437968896 07:49:37 INFO - 2015-11-19 07:49:37,469 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,469 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:49:37 INFO - 2015-11-19 07:49:37,469 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:49:37 INFO - 2015-11-19 07:49:37,469 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:49:37 INFO - 2015-11-19 07:49:37,469 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |0;Richards;163.3986928104575 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.16206297083252 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.6455624646693 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2030.4259634888438 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |5;Earley;783.868441660141 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |6;Boyer;12144.578313253012 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |7;RegExp;27567.567567567567 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |8;Splay;610.3343465045592 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: __startTimestamp1447948177462__endTimestamp 07:49:37 INFO - 2015-11-19 07:49:37,470 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.40 Median:163.40 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: Values: 163.4 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.16 Median:193.16 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: Values: 193.2 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.65 Median:282.65 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: Values: 282.6 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: Values: 5045.2 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,471 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2030.43 Median:2030.43 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: Values: 2030.4 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.87 Median:783.87 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: Values: 783.9 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12144.58 Median:12144.58 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: Values: 12144.6 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27567.57 Median:27567.57 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: Values: 27567.6 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.33 Median:610.33 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: Values: 610.3 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: 07:49:37 INFO - 2015-11-19 07:49:37,472 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 07:49:37 INFO - 2015-11-19 07:49:37,473 DEBUG : BROWSER_OUTPUT: Values: 4850.2 07:49:37 INFO - 2015-11-19 07:49:37,473 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:49:37 INFO - 2015-11-19 07:49:37,473 DEBUG : BROWSER_OUTPUT: 07:49:38 INFO - 2015-11-19 07:49:38,390 INFO : Browser exited with error code: 0 07:49:38 INFO - 2015-11-19 07:49:38,404 INFO : Completed test v8_7 (00:00:39) 07:49:38 INFO - 2015-11-19 07:49:38,474 INFO : Completed test suite (00:20:16) 07:49:38 INFO - 2015-11-19 07:49:38,474 DEBUG : Working with test: dromaeo_css 07:49:38 INFO - 2015-11-19 07:49:38,474 DEBUG : Generating results file: dromaeo_css 07:49:38 INFO - 2015-11-19 07:49:38,475 DEBUG : Working with test: kraken 07:49:38 INFO - 2015-11-19 07:49:38,476 DEBUG : Generating results file: kraken 07:49:38 INFO - 2015-11-19 07:49:38,476 INFO : javascript benchmark 07:49:38 INFO - 2015-11-19 07:49:38,476 DEBUG : Working with test: v8_7 07:49:38 INFO - 2015-11-19 07:49:38,476 DEBUG : Generating results file: v8_7 07:49:38 INFO - 2015-11-19 07:49:38,476 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:49:38 INFO - 2015-11-19 07:49:38,537 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 07:49:38 INFO - 2015-11-19 07:49:38,537 DEBUG : process_Request line: dromaeo_css 5949.00 graph.html#tests=[[72,131,35]] 07:49:38 INFO - 2015-11-19 07:49:38,537 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:49:38 INFO - 2015-11-19 07:49:38,574 DEBUG : process_Request line: kraken 1526.30 graph.html#tests=[[232,131,35]] 07:49:38 INFO - 2015-11-19 07:49:38,574 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:49:38 INFO - 2015-11-19 07:49:38,612 DEBUG : process_Request line: v8_7 19692.95 graph.html#tests=[[230,131,35]] 07:49:38 INFO - 2015-11-19 07:49:38,613 INFO : javascript benchmark 07:49:38 INFO - 2015-11-19 07:49:38,617 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2658.8005899557534, 2747.0797282910225, 2748.2579703480046, 2756.7243275672436, 2777.236260028492, 4525.230710779168, 4667.1365797327435, 4693.530646935309, 4751.90496190076, 4767.1419144553965, 4649.558291962258, 4683.812647494096, 4686.765661716918, 4730.858074257778, 4788.257820037891, 4294.141171765652, 4334.089841133366, 4370.4099946507295, 4377.474703035624, 4397.384366188736, 4433.401490798749, 4485.215087359716, 4491.752953587551, 4492.415985921842, 4497.0, 4170.541240463546, 4190.20386126635, 4299.742015479082, 4322.7190232634775, 4333.783310834446, 4342.0, 4383.430154079981, 4391.3193455014525, 4415.448068991376, 4435.911281774379, 4137.689673274516, 4366.978165109154, 4367.825286988548, 4372.060007098489, 4413.3821265022925, 4576.725396476222, 4594.540545945412, 4674.602658774008, 4683.414573178353, 4705.435347758256, 5050.595952323805, 5065.569426598743, 5067.163917953533, 5074.13739664258, 5105.795768169269, 4839.758012099381, 4943.555080042777, 5099.974500127476, 5107.489251074863, 5108.591312694975, 4624.537546245382, 4663.953360466419, 4697.154512187771, 4735.621150307967, 4770.117528257283, 5140.228965655107, 5215.504527069922, 5217.113090774577, 5224.869378265497, 5266.499682530153, 4639.489656137822, 4743.1225223333795, 5015.548600625962, 5024.6231532634465, 5033.723145226974, 4962.082014827196, 4964.304997300381, 5056.898862022739, 5077.390713114376, 5094.057599344133, 5059.544640982329, 5076.035553244872, 5080.263361812516, 5080.847574572768, 5124.077666020077, 5063.291139240509, 5066.16408292635, 5069.5437410632485, 5072.264521644414, 5075.187969924868, 4022.8189731462153, 4088.1619268049976, 4113.814878330482, 4120.876373708794, 4176.227397931392, 3727.7204209684382, 3729.0, 3758.3422900992764, 3770.5098337216536, 3779.7921114338974, 4408.25059739845, 4413.602775750198, 4417.271150260235, 4441.0, 4442.355858400514, 4760.33355330254, 4870.269459581091, 4874.610031197496, 4966.826161084345, 5138.254953031789, 4389.62688171509, 4393.340998850198, 4394.67039971997, 4428.402165707588, 4433.667474939392, 4523.660725445539, 4525.117602067565, 4528.728276303433, 4529.252673308933, 4569.748663823455, 4599.126166028578, 4721.929171062506, 4727.432708075053, 4856.223004319362, 4864.73243971585, 4983.277424773315, 5079.5428411443145, 5084.949150508448, 5105.2342148678, 5112.872178195575, 4801.18379875429, 4805.615550756001, 4808.471068182567, 4813.855584332476, 4849.369581954465, 4748.525147485224, 4861.927071094007, 5000.024995125916, 5004.899902002013, 5043.394792624908, 4928.778204980857, 4995.8001679932395, 5081.364829396325, 5084.669496482717, 5116.846494605168, 4952.975235123801, 4953.529414705597, 4965.006998600222, 4969.627277954096, 5011.223260394645, 4614.123316569841, 4716.221823399101, 4954.5788607968725, 4955.851324460272, 5002.974985125051, 4691.03833714081, 4696.107739529479, 4816.54242846929, 4824.179889418737, 4857.489963553918, 4960.454350021567, 4966.106100901872, 4973.079980203674, 4976.527229913152, 5012.47369026247, 4557.111363284128, 4658.906821863611, 4862.756862156949, 4875.902481950412, 4898.804047838046], "unit": "ms", "name": "dojo.html", "value": 4631.301796809409}, {"lowerIsBetter": false, "replicates": [562.0978329780702, 565.4825834361557, 568.1392690074538, 575.2694078520277, 577.2639884147711, 26856.597151042726, 27529.449411011767, 35971.0, 36768.26463470729, 37095.81452092742, 41032.17935641285, 41654.0, 41661.95845103866, 41671.166576668526, 41735.373969390406, 6911.827204319907, 7970.0, 8132.959335203345, 8146.714864979697, 8150.959245203795, 6999.860002799941, 7083.85832283354, 7084.964575177142, 7085.078939737853, 7086.114235720535, 10127.49362531874, 10377.688669339932, 10386.221033422486, 10388.480575971209, 10389.532471038821, 10098.646547370843, 10203.38779673222, 10203.591856325738, 10205.38767673942, 10205.591776328938, 7175.3900918422, 7385.335319821188, 7388.963055184743, 9850.310478266525, 9977.551010204557, 27299.181024569294, 42253.0, 43188.56811431908, 43256.56743432588, 43267.350989735176, 2730.0, 2743.231895069384, 2762.6408566886375, 2858.8999385021634, 2907.5638654201825, 26625.33436664099, 26708.19875403741, 26713.599296010576, 26887.59668604953, 27385.863070684518, 2797.839742986831, 2872.7989040767156, 2899.60855284536, 2929.340898297887, 2983.9403211935855, 222459.0, 243971.0, 249899.75050124814, 309514.99999999773, 315091.0, 44754.77622611866, 44962.85260031832, 45191.0, 45200.09599808051, 45214.54785452169, 48479.75760121177, 48696.5130348692, 48747.26879096816, 48805.0, 48807.26789098166, 14137.575872723835, 14346.354414051393, 14349.282535873164, 14360.210188439736, 14454.0, 11001.504932277907, 11070.5571777128, 11070.833937490945, 11072.280301780358, 11081.113510919107, 19629.0, 20070.89964550197, 20076.0, 20263.696044559343, 20321.288754893507, 7761.7671469855995, 7986.32116270112, 8008.679652813822, 8036.598170091589, 8114.362832079598, 774.4965772248083, 817.2767101115555, 834.6327615849007, 936.5551363102608, 977.9559919803626, 26139.215823525326, 29618.703812962027, 31816.840915795274, 31854.0, 32409.837950810568, 871.172386233081, 927.5686805635412, 934.6448349627099, 966.8018056298442, 1004.8141093897652, 15465.226738663247, 15538.611534711497, 16715.991121597985, 16799.83200168007, 16878.915605421895, 328657.0, 337286.0, 339425.0, 340084.0, 340128.0, 48824.511754882704, 49237.50762492401, 49346.259806102935, 49350.0, 49357.753211234434, 1047.4291511126303, 1161.227783523964, 1163.5113252433998, 1180.7815554122515, 1181.645506348092, 29991.65037573358, 31378.0, 31621.36757264888, 31624.683753162175, 31784.205394865312, 44678.776606116764, 45259.0, 45380.09239815251, 45389.0, 45462.0, 249076.0, 262305.0, 263032.0, 307313.0, 312575.0, 28035.579466307612, 28038.43923121567, 28097.859510702314, 28472.288192794516, 28516.857415713617, 38676.950872073, 40347.79826100851, 40498.39252411157, 40776.0, 40857.79571102125, 33657.0, 34412.0, 34708.82645586756, 35070.649293506736, 35225.82387088048, 35038.0, 38028.0, 40222.26886137076, 40296.395554066126, 40662.59337406588, 33545.0, 34090.65909340974, 34340.0, 34379.312413752086, 34458.31083378368, 28571.857140714164, 30745.538816917317, 30917.227069322547, 30926.381472369976, 31065.0, 23676.763232368146, 23992.76007239905, 24043.879780600986, 24274.0, 24372.51254974926], "unit": "ms", "name": "ext.html", "value": 17511.291633256125}, {"lowerIsBetter": false, "replicates": [312.0980366740123, 316.2993968360083, 320.7177683638398, 321.9484882418813, 322.63058797676644, 12767.680807979805, 13129.803052954214, 15640.452584159557, 16221.351145954162, 16323.59191020225, 15152.696946061073, 15208.847911520881, 15338.923305383485, 15385.461508847193, 15484.535463936072, 4753.144434001878, 4754.833580824672, 4856.611471082322, 4856.878578035559, 4858.635602329822, 3561.2165323628888, 3691.3724666806575, 4896.216605343146, 5615.66306021638, 5781.624194427349, 5651.802186923458, 5678.318601767773, 5705.25831641886, 5724.971375143118, 5730.484256416921, 5682.204491371191, 5862.648241105548, 5864.970675146597, 5867.031939729939, 5868.6478811271245, 5036.420811606676, 5036.773345199438, 5046.167382381903, 5049.3183420238165, 5059.241113832954, 19295.51761205981, 19590.412287631392, 19847.60304793896, 19882.304119355755, 19901.9004904976, 1750.2473936207425, 1753.105915982845, 1756.604763928106, 1759.5513144148288, 1775.8845675031082, 12225.572104976372, 12291.262524248574, 12398.938005309916, 12570.560030398983, 12894.161879477897, 1634.9591260218472, 1717.7251639737708, 1721.8794684372099, 1779.0748810618406, 1811.8097599751968, 53317.0, 53500.73249633727, 53705.0, 53796.99999999961, 54523.45476545223, 8749.91250087491, 8861.158189971942, 9059.864102038475, 9064.637414503479, 9098.818023639491, 11275.097992160607, 11289.20975531705, 11303.773924521463, 11304.321740695585, 11309.60416385439, 4914.729689867092, 5001.299818025479, 5040.294358789773, 6787.796366109024, 6864.759733409307, 5138.948610513922, 5176.301199338116, 5177.326947496801, 5187.299714538489, 5195.714235716996, 2872.35372041289, 2893.4068515954177, 2911.228524441025, 2974.5240761478058, 2977.851107444619, 1033.4832583708146, 1038.0916697889347, 1038.3977293169944, 1074.9462526873624, 1076.741582020325, 372.4841095083329, 410.6365866208427, 442.2040327410648, 445.025394386293, 450.2435907675137, 10083.19334453242, 10153.796924061626, 10311.432871192157, 10478.476076196312, 10553.47232638365, 354.9627289134655, 409.35935261315944, 422.18307574842777, 422.4782393743724, 435.20357745325975, 5329.9467005330225, 5508.6970216637665, 5572.108462645957, 5576.414476479992, 5626.493615574618, 478547.0, 481217.0, 487477.0, 496666.0, 498458.0, 60441.395586043574, 64210.0, 66361.33638663648, 66625.33870596791, 67848.6607566959, 475.92385218365587, 477.520092307229, 482.08644618448545, 483.2075396349989, 486.25117319327836, 9565.856512152184, 9579.329446938926, 9656.71029869105, 9724.70825875225, 9913.256505762241, 28188.71811281861, 30128.548071778503, 30450.0, 30695.846520767253, 33503.16242093967, 34799.4780078294, 35691.821540893165, 37061.44407833831, 37865.0, 39509.604903951746, 5754.942450575608, 6050.7277172526465, 6057.18228039209, 6059.182010428536, 6061.333253342217, 10537.57849686004, 10578.576856925636, 10844.0, 10949.45252737344, 10949.452527373758, 9298.0, 9313.767155821159, 9505.477198754135, 9526.428414295164, 9529.714108576754, 8505.362097842562, 9377.906220937703, 9437.433753974783, 9509.334346595671, 9712.562934667816, 9295.953520232355, 9355.532223388667, 9426.670066547638, 9486.430814151174, 9861.359011664506, 5628.521575666115, 5702.629329093762, 5743.59794814359, 5821.126830975388, 5874.177615133799, 9586.089321514444, 9611.134997850228, 9648.083432073941, 9710.417374957526, 9794.412335259622], "unit": "ms", "name": "jquery.html", "value": 6687.578026616589}, {"lowerIsBetter": false, "replicates": [1434.4047220403534, 1595.5931237534428, 1650.0429750744565, 1662.1772222749742, 1693.4073074423952, 5921.348651648321, 6446.516511261657, 6605.900911486331, 6611.272759996408, 6613.3717296856785, 6808.285130061334, 6908.896366554506, 6923.238443771181, 6926.099607051076, 6928.168619765623, 1993.4916596267967, 2004.26844201866, 2015.4961259685078, 2016.4253187841468, 2017.6368253714325, 2033.5932813437298, 2055.2806517718827, 2060.6702927531596, 2064.3187748043183, 2069.1206237349143, 1985.8808471491684, 2011.5272910865936, 2020.7069974853637, 2022.7876073012342, 2024.473636854421, 1964.0866996846464, 1965.7935916728823, 1972.3688419705556, 1973.6052789442097, 1973.703944408336, 2024.7873973232745, 2040.0309852819792, 2041.428400047989, 2042.8774273543486, 2045.417056139008, 5780.277465316835, 5942.108683697436, 6787.185537735503, 6816.045753594501, 6824.931750682479, 3599.1002249437643, 3669.082729317671, 3670.082479380155, 3684.4841722158917, 3950.0914789598555, 2703.7431444012786, 2730.262829036169, 2746.231055304518, 2782.8330300182056, 2783.7912156588136, 803.7347675267148, 806.4435539477741, 1656.4864891883556, 1660.850523452895, 1704.9573760656083, 9147.313951453601, 9237.815243695155, 9259.537023148883, 9283.582238799203, 9286.071392860727, 3642.399004164336, 3673.7061035117126, 3732.458793474931, 3732.682721968663, 3747.45661879026, 7720.575368354682, 7739.961300193576, 7748.6125693715085, 7755.2244775521995, 7765.495242809312, 4091.0590564170407, 4107.67138628909, 4118.711690181718, 4123.670106391482, 4133.751974881457, 3813.103920578662, 3820.9044773880873, 3821.2357528494413, 3824.7131465140224, 3827.158025234444, 3081.6764239754953, 3086.537019447101, 3090.5364195370876, 3091.412631599989, 3122.125804774667, 920.9171174594319, 935.3405848876525, 936.765808547863, 944.7732544189345, 945.3288165402504, 1092.153580974735, 1131.7962766701908, 1132.9263597866113, 1161.2277835239472, 1162.831389448542, 6660.367265109807, 6684.364985326386, 6685.866282674319, 6724.663766811737, 6729.2934241903895, 381.8090954522739, 382.23552894211576, 383.9040239940015, 388.99805500972315, 389.7973054011898, 4789.832355867528, 5261.421243663194, 5302.0, 5305.60207984395, 5312.468753124656, 7108.71565137399, 7617.542947423172, 7796.922030779733, 7819.804504887424, 7819.843603127905, 7980.281774640194, 8058.476199047043, 8138.755837324889, 8164.061132969666, 8167.305779008732, 6443.323451037667, 6588.51758354376, 6629.436497897636, 6633.1376920999965, 6646.0, 6543.476521878333, 6564.376384243489, 6564.868702626016, 6564.901526477011, 6603.174603174603, 7079.292070793085, 7312.122545294386, 7370.0, 7409.407247420301, 7409.888851667121, 7488.850222995618, 7738.4969976951315, 7750.224977502205, 7837.647305871364, 7847.568383738949, 5885.882282354243, 5888.646681199141, 5924.7926322578505, 5939.91090133657, 6021.397860213943, 6508.902366464602, 6578.80263592093, 6583.242927063257, 6585.242697089704, 6591.769288074895, 5825.3592104867585, 6121.785737499166, 6201.255849298113, 6273.780417685359, 6288.748450062129, 5532.0, 5855.824325270249, 5903.439173278532, 5963.701814909324, 5975.611585246945, 5880.764769409347, 6239.594426362272, 6244.937550624436, 6249.0, 6249.593776404519, 5702.372738998624, 5737.0, 5740.68426236561, 5747.971260143672, 5772.1341798728845, 5747.885042299215, 5772.0, 5820.1560773688425, 5825.097109947965, 5827.912581311199], "unit": "ms", "name": "mootools.html", "value": 3886.2985073724635}, {"lowerIsBetter": false, "replicates": [280.7276941366876, 282.75117896251294, 286.74336468860383, 287.22449386656035, 290.2294408345842, 5251.973740131303, 5301.443348448411, 5340.0, 5349.037173308803, 5422.864428389287, 5285.207218917164, 5287.947120528794, 5291.4708529147065, 5297.549708274802, 5316.73416329183, 4082.3264161413404, 4093.447384603085, 4099.098198396363, 4099.795010249491, 4116.608922152391, 4101.4668093148, 4104.179164167163, 4105.3431450967855, 4105.979470102645, 4109.527404348508, 4056.553779084298, 4056.574059723731, 4059.249038927793, 4062.3906414037833, 4065.695072869532, 3868.70984676149, 3958.6635136013474, 3981.163955569334, 3992.301347264246, 3996.360582306846, 3408.4205685033603, 3409.215880347509, 3410.6077801052948, 3411.812350320731, 3413.4709120086427, 5123.077845987721, 5124.743762811844, 5145.511176438233, 5153.072446959546, 5153.819616313449, 4563.292689633112, 4566.246569316058, 4566.817327306937, 4567.5889169974525, 4569.611583015448, 5414.187871819258, 5588.413216612278, 5589.469000444951, 5590.357108932443, 5595.244641973363, 3805.7335986480957, 3805.82873770681, 3807.276617442677, 3808.6572208501366, 3814.9618503815163, 5610.887782244332, 5743.339515955677, 5783.392743761929, 5880.176775251468, 5882.264716910387, 3783.9621603784162, 3793.279276937373, 3871.361225397834, 3873.1285460771664, 3902.492675952108, 3912.8434862605745, 3922.1567363016516, 3937.5274967004143, 3937.783421911765, 3938.606139386096, 4328.394024836525, 4419.889502762392, 4438.822447102144, 4579.335996280521, 4592.471865735416, 5571.331440227118, 5573.637713548606, 5576.275084239104, 5582.665040097607, 5582.748776305076, 1374.4433504430522, 1394.7350003499303, 1395.888328933683, 1395.9720805583831, 1396.5670642100981, 889.8487257166297, 906.6690657909948, 910.8815853939078, 921.2491819167357, 923.7598224461689, 4913.508649135058, 4915.361003069578, 4920.163572192736, 4921.803127874917, 4927.285543596158, 5765.308163020381, 5780.971095144498, 5791.739371728282, 5801.245838041028, 5812.21535092757, 4891.608671306287, 4894.877628059256, 4901.803927842846, 4905.901881962341, 4910.165271903785, 3046.329807442359, 3093.458644737207, 3127.1400364899832, 3128.7966282191583, 3133.9529907051415, 5544.362398324244, 5571.220029195916, 5581.720913954286, 5583.330000399978, 5586.413426590149, 6052.757889684452, 6056.515478761688, 6059.303180134253, 6062.393760623902, 6062.545309101835, 5560.888782224333, 5561.972190139023, 5567.916481252784, 5573.21974923503, 5580.720963951786, 5653.575981801464, 5799.101139323411, 5850.94149058504, 5870.647761134345, 5879.617824841372, 5740.024195886625, 5748.0, 5749.195112684311, 5749.798757043483, 5753.539716822728, 5567.3040869891265, 5571.9442805571425, 5574.888502229852, 5577.609567330248, 5581.190727344593, 3786.3752480840353, 3862.304785138702, 3913.745606535566, 3914.0801911550193, 3929.8821035368983, 5567.3040869891265, 5721.771129154788, 5790.536757059341, 5791.986402379651, 5799.594028418139, 5464.535514481314, 5528.198411230269, 5531.0, 5533.446655334435, 5536.0, 5621.775128994795, 5622.7750889963945, 5631.408702086222, 5633.0705433603, 5636.323641162922, 5390.38010628767, 5496.422875598165, 5498.917516237339, 5505.724713764215, 5509.201165830852, 5658.745356458887, 5660.207570940154, 5660.29246344207, 5663.745131469176, 5676.659400435987, 5517.668939863461, 5520.337559492726, 5523.944760552504, 5525.392206857162, 5526.143447765603], "unit": "ms", "name": "prototype.html", "value": 4154.074598618336}, {"lowerIsBetter": false, "replicates": [610.9450149486545, 702.2415790945779, 713.9643017849106, 720.7945735465391, 723.1177962885278, 11451.541938322467, 11756.529738810448, 12332.691682707937, 12396.752064958719, 12409.503619855195, 11790.410479476035, 11795.351255680935, 11854.881451185485, 11876.28742275464, 11881.10891683125, 500.9574186194178, 503.9596832253429, 773.7407968330588, 783.3693876429458, 788.9566073865935, 781.8319061401797, 782.2177822177822, 787.4094429178116, 787.9960600196991, 788.696351904518, 615.6429271022819, 822.3585603229461, 822.4859462835727, 822.6585966823761, 822.9218224268685, 614.2751553167261, 806.9596520173997, 817.6811043692965, 819.3690858039306, 819.6229734322219, 609.2049874913237, 609.3571282297174, 609.8079105081885, 609.8414412252802, 609.9481544068759, 11446.370449625267, 11539.423028848523, 11591.710207244887, 11606.593769218036, 11652.41737913101, 10419.895801041968, 10501.527431265611, 10826.566937322497, 11161.609343673013, 11229.66311010671, 9128.680496182602, 9171.862422063674, 9977.102060814488, 10179.592816287339, 10432.530536125892, 2760.254731222559, 2764.557670772687, 2765.4192619549917, 2767.1421859223506, 2810.0, 36240.63759362399, 36358.091047723756, 36581.26837463236, 36618.633813662054, 37168.25663486715, 6131.14164017038, 6179.752809887644, 6191.721372538156, 6230.719617617218, 6463.7737679181, 10145.746356341151, 10147.137493313003, 10147.797044059078, 10157.765291635827, 10170.542325595366, 5231.744013983133, 5254.747741244975, 5283.1546952487415, 5335.973320133375, 5382.4886635769535, 3412.744044196695, 3422.9315413692084, 3440.1055725511546, 3509.6841284284537, 3564.7682900611376, 2416.637504374358, 2449.6080627099577, 2450.0322372663054, 2451.534208500415, 2452.509498100387, 361.91133172372935, 371.97210209234413, 383.96736277416176, 389.20407766118353, 390.1553137457373, 408.6301896783416, 414.81540714382413, 422.97250678705785, 427.04555318862316, 462.2996160816366, 6851.725930962805, 7101.360877520945, 7124.43004559634, 7255.927440725631, 7354.485186037033, 427.393101795445, 434.0104561599495, 476.52585677250664, 536.6458137629224, 564.3340857787849, 3351.916202094967, 3396.7282617391043, 3490.092575930226, 3542.3977923753023, 3561.4835848801777, 43871.56128438738, 44263.55736442659, 44684.55315446869, 44783.776081120035, 45168.0, 42673.0, 42860.0, 42879.57120428818, 43027.35458968118, 43028.56971430246, 38414.60375063506, 39590.60409395869, 39870.40194397028, 39911.800440997606, 39920.60079399227, 7166.570005799668, 7186.0, 7242.275772422716, 7316.597587132759, 7324.816879578053, 29358.706412935597, 30146.0, 30177.849110754305, 30394.848025760613, 30472.39055218839, 34675.65324346724, 34794.65205348015, 34929.65070349264, 35316.823415882754, 39013.0, 5829.854253643693, 5906.084556893688, 5942.61373010753, 6132.8773424532155, 6292.244930608356, 8795.076516965883, 9061.41100828444, 9108.908910911072, 9126.908730912606, 9458.479783611967, 8382.706605268786, 8525.275351595184, 8532.658693652184, 8540.615672294638, 8590.14098590161, 8876.334274929277, 8932.419392739452, 8956.865647015431, 8999.64001439935, 9071.591778369857, 8378.11633674224, 8908.02011778691, 8918.86621700688, 8976.775580610276, 10744.19418543628, 8343.374246931384, 8377.916220837713, 8458.661653533789, 8579.227869491775, 8677.305815534868, 8314.586520291445, 8641.611127499404, 8721.127887211229, 8898.231558281368, 8991.505467199106], "unit": "ms", "name": "yui.html", "value": 5061.945059955782}], "name": "dromaeo_css", "value": 5949.004023629395}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 110.0, 114.0, 113.0, 113.0, 102.0, 112.0, 103.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [157.0, 132.0, 163.0, 165.0, 133.0, 159.0, 159.0, 139.0, 167.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.6}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 163.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 86.0, 94.0, 73.0, 72.0, 73.0, 114.0, 94.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 129.0, 92.0, 93.0, 92.0, 138.0, 93.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.5}, {"lowerIsBetter": true, "replicates": [110.0, 108.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 67.0, 69.0, 78.0, 66.0, 66.0], "unit": "ms", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [93.0, 84.0, 83.0, 83.0, 82.0, 83.0, 81.0, 83.0, 86.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [121.0, 126.0, 127.0, 119.0, 130.0, 122.0, 129.0, 125.0, 128.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [139.0, 143.0, 143.0, 148.0, 149.0, 139.0, 151.0, 149.0, 147.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 69.0, 74.0, 70.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1526.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.3986928104575], "unit": "score", "name": "Richards", "value": 216.04823999999994}, {"lowerIsBetter": false, "replicates": [193.16206297083252], "unit": "score", "name": "DeltaBlue", "value": 342.292886}, {"lowerIsBetter": false, "replicates": [282.6455624646693], "unit": "score", "name": "Encrypt", "value": 941.7483780000005}, {"lowerIsBetter": false, "replicates": [5045.226130653266], "unit": "score", "name": "Decrypt", "value": 52.75898306772911}, {"lowerIsBetter": false, "replicates": [2030.4259634888438], "unit": "score", "name": "RayTrace", "value": 364.4501268731268}, {"lowerIsBetter": false, "replicates": [783.868441660141], "unit": "score", "name": "Earley", "value": 850.2230279720281}, {"lowerIsBetter": false, "replicates": [12144.578313253012], "unit": "score", "name": "Boyer", "value": 54.87740972222223}, {"lowerIsBetter": false, "replicates": [27567.567567567567], "unit": "score", "name": "RegExp", "value": 33.04553431372551}, {"lowerIsBetter": false, "replicates": [610.3343465045592], "unit": "score", "name": "Splay", "value": 133.51862051792827}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19692.95268714179}]} 07:49:38 INFO - RETURN: dromaeo_css: 5949.00 07:49:38 INFO - RETURN: kraken: 1526.30 07:49:38 INFO - RETURN: v8_7: 19692.95 07:49:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19692.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "5949.00"}}} 07:49:38 INFO - Return code: 0 07:49:38 INFO - # TBPL SUCCESS # 07:49:38 INFO - Running post-action listener: _resource_record_post_action 07:49:38 INFO - Running post-run listener: _resource_record_post_run 07:49:39 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 513871872; Read time: 0; Write time: 377976 07:49:39 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 136282112; Read time: 0; Write time: 145768 07:49:39 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 325910528; Read time: 0; Write time: 209520 07:49:39 INFO - Running post-run listener: _upload_blobber_files 07:49:39 INFO - Blob upload gear active. 07:49:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:49:39 INFO - Copying logs to upload dir... 07:49:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1262.858901 ========= master_lag: 0.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-19 07:49:40.320743) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:49:40.324472) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009957 build_url: 'https://queue.taskcluster.net/v1/task/YHIioV-ZRNCJkVpX258LuQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 07:49:40.347496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:49:40.347809) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6587686cb2da90a5f91b3170000001be-1447946782.213359-180760066 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004644 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 07:49:40.398059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:49:40.398367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 07:49:40.398657) ========= ========= Total master_lag: 0.89 =========