builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1461067755.99 results: success (0) buildid: 20160419023018 builduid: c9ca2d9ca4f542dfb21bcbf547e5800e revision: d4b74afcc60b937f25d54f365be46a8133980209 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:15.994306) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:15.994749) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:15.995037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.011401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.011727) ========= 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=cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 05:09:16-- 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% 37.9M=0s 2016-04-19 05:09:16 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.138526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.139059) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018313 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.192143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.192739) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d4b74afcc60b937f25d54f365be46a8133980209 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d4b74afcc60b937f25d54f365be46a8133980209 --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=cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 05:09:16,335 truncating revision to first 12 chars 2016-04-19 05:09:16,335 Setting DEBUG logging. 2016-04-19 05:09:16,335 attempt 1/10 2016-04-19 05:09:16,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d4b74afcc60b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 05:09:16,697 unpacking tar archive at: fx-team-d4b74afcc60b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683922 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.892440) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.892772) ========= script_repo_revision: d4b74afcc60b937f25d54f365be46a8133980209 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.893199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.893471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 05:09:16.915038) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-19 05:09:16.915321) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:17 INFO - MultiFileLogger online at 20160419 05:09:17 in /builds/slave/test 05:09:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:09:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:17 INFO - {'append_to_log': False, 05:09:17 INFO - 'base_work_dir': '/builds/slave/test', 05:09:17 INFO - 'blob_upload_branch': 'Fx-Team', 05:09:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:17 INFO - 'branch': 'Fx-Team', 05:09:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:17 INFO - 'config_files': ('talos/linux_config.py',), 05:09:17 INFO - 'default_actions': ('clobber', 05:09:17 INFO - 'read-buildbot-config', 05:09:17 INFO - 'download-and-extract', 05:09:17 INFO - 'populate-webroot', 05:09:17 INFO - 'create-virtualenv', 05:09:17 INFO - 'install', 05:09:17 INFO - 'run-tests'), 05:09:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:17 INFO - 'download_minidump_stackwalk': True, 05:09:17 INFO - 'download_symbols': 'ondemand', 05:09:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:17 INFO - 'installer_path': 'installer.exe', 05:09:17 INFO - 'log_level': 'info', 05:09:17 INFO - 'log_name': 'talos', 05:09:17 INFO - 'log_to_console': True, 05:09:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:17 INFO - 'opt_config_files': (), 05:09:17 INFO - 'pip_index': False, 05:09:17 INFO - 'sps_profile': False, 05:09:17 INFO - 'sps_profile_interval': 0, 05:09:17 INFO - 'suite': 'dromaeojs-e10s', 05:09:17 INFO - 'system_bits': '32', 05:09:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:17 INFO - 'title': 'talos-linux64-ix-054', 05:09:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:17 INFO - 'use_talos_json': True, 05:09:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:17 INFO - 'work_dir': 'build'} 05:09:17 INFO - ##### 05:09:17 INFO - ##### Running clobber step. 05:09:17 INFO - ##### 05:09:17 INFO - Running pre-action listener: _resource_record_pre_action 05:09:17 INFO - Running main action method: clobber 05:09:17 INFO - rmtree: /builds/slave/test/build 05:09:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:17 INFO - Running post-action listener: _resource_record_post_action 05:09:17 INFO - ##### 05:09:17 INFO - ##### Running read-buildbot-config step. 05:09:17 INFO - ##### 05:09:17 INFO - Running pre-action listener: _resource_record_pre_action 05:09:17 INFO - Running main action method: read_buildbot_config 05:09:17 INFO - Using buildbot properties: 05:09:17 INFO - { 05:09:17 INFO - "project": "", 05:09:17 INFO - "product": "firefox", 05:09:17 INFO - "script_repo_revision": "production", 05:09:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:09:17 INFO - "repository": "", 05:09:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:09:17 INFO - "buildid": "20160419023018", 05:09:17 INFO - "pgo_build": "True", 05:09:17 INFO - "basedir": "/builds/slave/test", 05:09:17 INFO - "buildnumber": 396, 05:09:17 INFO - "slavename": "talos-linux64-ix-054", 05:09:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:09:17 INFO - "platform": "ubuntu64_hw", 05:09:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:09:17 INFO - "branch": "fx-team", 05:09:17 INFO - "repo_path": "integration/fx-team", 05:09:17 INFO - "revision": "d4b74afcc60b937f25d54f365be46a8133980209", 05:09:17 INFO - "stage_platform": "linux64-pgo", 05:09:17 INFO - "builduid": "c9ca2d9ca4f542dfb21bcbf547e5800e", 05:09:17 INFO - "slavebuilddir": "test" 05:09:17 INFO - } 05:09:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:09:17 INFO - Running post-action listener: _resource_record_post_action 05:09:17 INFO - ##### 05:09:17 INFO - ##### Running download-and-extract step. 05:09:17 INFO - ##### 05:09:17 INFO - Running pre-action listener: _resource_record_pre_action 05:09:17 INFO - Running main action method: download_and_extract 05:09:17 INFO - mkdir: /builds/slave/test/build/tests 05:09:17 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')]} 05:09:17 INFO - https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:09:20 INFO - Downloaded 1361 bytes. 05:09:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:09:20 INFO - Using the following test package requirements: 05:09:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:09:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:09:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'jsshell-linux-x86_64.zip'], 05:09:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:09:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:09:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:09:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:09:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:09:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:09:20 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')]} 05:09:20 INFO - https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:09:21 INFO - Downloaded 23780832 bytes. 05:09:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:23 INFO - Return code: 0 05:09:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:09:23 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')]} 05:09:23 INFO - https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:09:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:09:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:09:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:09:24 INFO - Downloaded 23780832 bytes. 05:09:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:09:25 INFO - Return code: 0 05:09:25 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')]} 05:09:25 INFO - https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:09:27 INFO - Downloaded 10845952 bytes. 05:09:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:09:27 INFO - Return code: 0 05:09:27 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')]} 05:09:27 INFO - https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:09:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:09:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:09:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:09:30 INFO - Downloaded 58253924 bytes. 05:09:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:09:30 INFO - mkdir: /builds/slave/test/properties 05:09:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:30 INFO - Contents: 05:09:30 INFO - build_url:https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:09:31 INFO - Running post-action listener: _resource_record_post_action 05:09:31 INFO - Running post-action listener: set_extra_try_arguments 05:09:31 INFO - ##### 05:09:31 INFO - ##### Running populate-webroot step. 05:09:31 INFO - ##### 05:09:31 INFO - Running pre-action listener: _resource_record_pre_action 05:09:31 INFO - Running main action method: populate_webroot 05:09:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:31 INFO - '--tppagecycles', 05:09:31 INFO - '7'], 05:09:31 INFO - 'tests': ['tsvgm']}}, 05:09:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['damp', 'tps']}, 05:09:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'tests': ['damp', 'tps']}, 05:09:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['dromaeo_dom']}, 05:09:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['a11yr', 05:09:31 INFO - 'ts_paint', 05:09:31 INFO - 'tpaint', 05:09:31 INFO - 'sessionrestore', 05:09:31 INFO - 'sessionrestore_no_auto_restore', 05:09:31 INFO - 'tabpaint']}, 05:09:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:31 INFO - 'ts_paint', 05:09:31 INFO - 'tpaint', 05:09:31 INFO - 'sessionrestore', 05:09:31 INFO - 'sessionrestore_no_auto_restore', 05:09:31 INFO - 'tabpaint']}, 05:09:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:31 INFO - 'ts_paint', 05:09:31 INFO - 'tpaint', 05:09:31 INFO - 'sessionrestore', 05:09:31 INFO - 'sessionrestore_no_auto_restore', 05:09:31 INFO - 'tabpaint']}, 05:09:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:31 INFO - 'ts_paint', 05:09:31 INFO - 'tpaint', 05:09:31 INFO - 'sessionrestore', 05:09:31 INFO - 'sessionrestore_no_auto_restore', 05:09:31 INFO - 'tabpaint']}, 05:09:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['a11yr', 05:09:31 INFO - 'ts_paint', 05:09:31 INFO - 'tpaint', 05:09:31 INFO - 'sessionrestore', 05:09:31 INFO - 'sessionrestore_no_auto_restore', 05:09:31 INFO - 'tabpaint']}, 05:09:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['a11yr', 05:09:31 INFO - 'ts_paint', 05:09:31 INFO - 'tpaint', 05:09:31 INFO - 'sessionrestore', 05:09:31 INFO - 'sessionrestore_no_auto_restore', 05:09:31 INFO - 'tabpaint']}, 05:09:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['tsvgx', 05:09:31 INFO - 'tsvgr_opacity', 05:09:31 INFO - 'tart', 05:09:31 INFO - 'tscrollx', 05:09:31 INFO - 'cart']}, 05:09:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:31 INFO - 'tsvgr_opacity', 05:09:31 INFO - 'tart', 05:09:31 INFO - 'tscrollx', 05:09:31 INFO - 'cart']}, 05:09:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'talos_options': ['--disable-e10s'], 05:09:31 INFO - 'tests': ['tp5o']}, 05:09:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'tests': ['tp5o']}, 05:09:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'talos_options': ['--disable-e10s', 05:09:31 INFO - '--xperf_path', 05:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:31 INFO - 'tests': ['tp5n']}, 05:09:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:31 INFO - 'talos_options': ['--xperf_path', 05:09:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:31 INFO - 'tests': ['tp5n']}}, 05:09:31 INFO - 'talos.zip': {'path': '', 05:09:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:31 INFO - Running post-action listener: _resource_record_post_action 05:09:31 INFO - ##### 05:09:31 INFO - ##### Running create-virtualenv step. 05:09:31 INFO - ##### 05:09:31 INFO - Running pre-action listener: _resource_record_pre_action 05:09:31 INFO - Running main action method: create_virtualenv 05:09:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:31 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 05:09:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:31 INFO - Using real prefix '/usr' 05:09:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:31 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:33 INFO - Installing pip.................done. 05:09:33 INFO - Return code: 0 05:09:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:33 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')]} 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 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')]} 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:33 INFO - Using env: {'DISPLAY': ':0', 05:09:33 INFO - 'HOME': '/home/cltbld', 05:09:33 INFO - 'LANG': 'en_US.UTF-8', 05:09:33 INFO - 'LANGUAGE': 'en_US:en', 05:09:33 INFO - 'LOGNAME': 'cltbld', 05:09:33 INFO - 'MAIL': '/var/mail/cltbld', 05:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:33 INFO - 'MOZ_NO_REMOTE': '1', 05:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:33 INFO - 'NO_EM_RESTART': '1', 05:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:33 INFO - 'PWD': '/builds/slave/test', 05:09:33 INFO - 'SHELL': '/bin/bash', 05:09:33 INFO - 'SHLVL': '1', 05:09:33 INFO - 'TERM': 'linux', 05:09:33 INFO - 'TMOUT': '86400', 05:09:33 INFO - 'USER': 'cltbld', 05:09:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:33 INFO - '_': '/tools/buildbot/bin/python'} 05:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:33 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 05:09:33 INFO - Cleaning up... 05:09:33 INFO - Return code: 0 05:09:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:09:33 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')]} 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 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')]} 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:33 INFO - Using env: {'DISPLAY': ':0', 05:09:33 INFO - 'HOME': '/home/cltbld', 05:09:33 INFO - 'LANG': 'en_US.UTF-8', 05:09:33 INFO - 'LANGUAGE': 'en_US:en', 05:09:33 INFO - 'LOGNAME': 'cltbld', 05:09:33 INFO - 'MAIL': '/var/mail/cltbld', 05:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:33 INFO - 'MOZ_NO_REMOTE': '1', 05:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:33 INFO - 'NO_EM_RESTART': '1', 05:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:33 INFO - 'PWD': '/builds/slave/test', 05:09:33 INFO - 'SHELL': '/bin/bash', 05:09:33 INFO - 'SHLVL': '1', 05:09:33 INFO - 'TERM': 'linux', 05:09:33 INFO - 'TMOUT': '86400', 05:09:33 INFO - 'USER': 'cltbld', 05:09:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:33 INFO - '_': '/tools/buildbot/bin/python'} 05:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:34 INFO - Downloading/unpacking psutil>=0.7.1 05:09:34 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 05:09:34 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 05:09:34 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 05:09:34 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 05:09:34 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 05:09:34 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 05:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:36 INFO - Installing collected packages: psutil 05:09:36 INFO - Running setup.py install for psutil 05:09:36 INFO - building 'psutil._psutil_linux' extension 05:09:36 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 05:09:36 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 05:09:36 INFO - building 'psutil._psutil_posix' extension 05:09:36 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 05:09:36 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 05:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:36 INFO - Successfully installed psutil 05:09:36 INFO - Cleaning up... 05:09:36 INFO - Return code: 0 05:09:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:09:36 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')]} 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:36 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')]} 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:36 INFO - Using env: {'DISPLAY': ':0', 05:09:36 INFO - 'HOME': '/home/cltbld', 05:09:36 INFO - 'LANG': 'en_US.UTF-8', 05:09:36 INFO - 'LANGUAGE': 'en_US:en', 05:09:36 INFO - 'LOGNAME': 'cltbld', 05:09:36 INFO - 'MAIL': '/var/mail/cltbld', 05:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:36 INFO - 'MOZ_NO_REMOTE': '1', 05:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:36 INFO - 'NO_EM_RESTART': '1', 05:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:36 INFO - 'PWD': '/builds/slave/test', 05:09:36 INFO - 'SHELL': '/bin/bash', 05:09:36 INFO - 'SHLVL': '1', 05:09:36 INFO - 'TERM': 'linux', 05:09:36 INFO - 'TMOUT': '86400', 05:09:36 INFO - 'USER': 'cltbld', 05:09:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:36 INFO - '_': '/tools/buildbot/bin/python'} 05:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:09:36 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 05:09:36 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 05:09:36 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 05:09:36 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 05:09:36 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 05:09:36 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 05:09:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:09:38 INFO - Installing collected packages: mozsystemmonitor 05:09:38 INFO - Running setup.py install for mozsystemmonitor 05:09:38 INFO - Successfully installed mozsystemmonitor 05:09:38 INFO - Cleaning up... 05:09:38 INFO - Return code: 0 05:09:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:38 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')]} 05:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:38 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')]} 05:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:38 INFO - Using env: {'DISPLAY': ':0', 05:09:38 INFO - 'HOME': '/home/cltbld', 05:09:38 INFO - 'LANG': 'en_US.UTF-8', 05:09:38 INFO - 'LANGUAGE': 'en_US:en', 05:09:38 INFO - 'LOGNAME': 'cltbld', 05:09:38 INFO - 'MAIL': '/var/mail/cltbld', 05:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:38 INFO - 'MOZ_NO_REMOTE': '1', 05:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:38 INFO - 'NO_EM_RESTART': '1', 05:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:38 INFO - 'PWD': '/builds/slave/test', 05:09:38 INFO - 'SHELL': '/bin/bash', 05:09:38 INFO - 'SHLVL': '1', 05:09:38 INFO - 'TERM': 'linux', 05:09:38 INFO - 'TMOUT': '86400', 05:09:38 INFO - 'USER': 'cltbld', 05:09:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:38 INFO - '_': '/tools/buildbot/bin/python'} 05:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:39 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:39 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 05:09:39 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 05:09:39 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 05:09:39 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 05:09:39 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 05:09:39 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 05:09:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:40 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 05:09:40 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 05:09:40 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 05:09:40 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 05:09:40 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 05:09:40 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 05:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:41 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 05:09:41 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 05:09:41 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 05:09:41 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 05:09:41 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 05:09:41 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 05:09:41 INFO - Downloading docopt-0.6.1.tar.gz 05:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:41 INFO - Running setup.py install for blobuploader 05:09:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:41 INFO - Running setup.py install for requests 05:09:42 INFO - Running setup.py install for docopt 05:09:42 INFO - Successfully installed blobuploader requests docopt 05:09:42 INFO - Cleaning up... 05:09:42 INFO - Return code: 0 05:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:42 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')]} 05:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 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')]} 05:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 05:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 05:09:42 INFO - Using env: {'DISPLAY': ':0', 05:09:42 INFO - 'HOME': '/home/cltbld', 05:09:42 INFO - 'LANG': 'en_US.UTF-8', 05:09:42 INFO - 'LANGUAGE': 'en_US:en', 05:09:42 INFO - 'LOGNAME': 'cltbld', 05:09:42 INFO - 'MAIL': '/var/mail/cltbld', 05:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:42 INFO - 'MOZ_NO_REMOTE': '1', 05:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:42 INFO - 'NO_EM_RESTART': '1', 05:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:42 INFO - 'PWD': '/builds/slave/test', 05:09:42 INFO - 'SHELL': '/bin/bash', 05:09:42 INFO - 'SHLVL': '1', 05:09:42 INFO - 'TERM': 'linux', 05:09:42 INFO - 'TMOUT': '86400', 05:09:42 INFO - 'USER': 'cltbld', 05:09:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:42 INFO - '_': '/tools/buildbot/bin/python'} 05:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:42 INFO - Running setup.py (path:/tmp/pip-sW3O0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:42 INFO - Running setup.py (path:/tmp/pip-gUdU4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:42 INFO - Running setup.py (path:/tmp/pip-JkYzcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:42 INFO - Running setup.py (path:/tmp/pip-B9mx47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:42 INFO - Running setup.py (path:/tmp/pip-b71Ibj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:42 INFO - Running setup.py (path:/tmp/pip-7MUzZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:42 INFO - Running setup.py (path:/tmp/pip-fO7HIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:42 INFO - Running setup.py (path:/tmp/pip-iD8Vpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:43 INFO - Running setup.py (path:/tmp/pip-JVtLcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:43 INFO - Running setup.py (path:/tmp/pip-8VZm4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:43 INFO - Running setup.py (path:/tmp/pip-2IuM3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:43 INFO - Running setup.py (path:/tmp/pip-lcC6FV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:43 INFO - Running setup.py (path:/tmp/pip-Sto1Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:43 INFO - Running setup.py (path:/tmp/pip-f2RgoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:43 INFO - Running setup.py (path:/tmp/pip-1FVXeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:43 INFO - Running setup.py (path:/tmp/pip-K4BHjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:43 INFO - Running setup.py (path:/tmp/pip-A9qgLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:43 INFO - Running setup.py install for manifestparser 05:09:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:43 INFO - Running setup.py install for mozcrash 05:09:43 INFO - Running setup.py install for mozdebug 05:09:43 INFO - Running setup.py install for mozdevice 05:09:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Running setup.py install for mozfile 05:09:44 INFO - Running setup.py install for mozhttpd 05:09:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Running setup.py install for mozinfo 05:09:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Running setup.py install for mozInstall 05:09:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Running setup.py install for mozleak 05:09:44 INFO - Running setup.py install for mozlog 05:09:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Running setup.py install for moznetwork 05:09:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:44 INFO - Running setup.py install for mozprocess 05:09:44 INFO - Running setup.py install for mozprofile 05:09:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:45 INFO - Running setup.py install for mozrunner 05:09:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:45 INFO - Running setup.py install for mozscreenshot 05:09:45 INFO - Running setup.py install for moztest 05:09:45 INFO - Running setup.py install for mozversion 05:09:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:45 INFO - Cleaning up... 05:09:45 INFO - Return code: 0 05:09:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:45 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')]} 05:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:45 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')]} 05:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:45 INFO - Using env: {'DISPLAY': ':0', 05:09:45 INFO - 'HOME': '/home/cltbld', 05:09:45 INFO - 'LANG': 'en_US.UTF-8', 05:09:45 INFO - 'LANGUAGE': 'en_US:en', 05:09:45 INFO - 'LOGNAME': 'cltbld', 05:09:45 INFO - 'MAIL': '/var/mail/cltbld', 05:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:45 INFO - 'MOZ_NO_REMOTE': '1', 05:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:45 INFO - 'NO_EM_RESTART': '1', 05:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:45 INFO - 'PWD': '/builds/slave/test', 05:09:45 INFO - 'SHELL': '/bin/bash', 05:09:45 INFO - 'SHLVL': '1', 05:09:45 INFO - 'TERM': 'linux', 05:09:45 INFO - 'TMOUT': '86400', 05:09:45 INFO - 'USER': 'cltbld', 05:09:45 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:45 INFO - '_': '/tools/buildbot/bin/python'} 05:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:45 INFO - Running setup.py (path:/tmp/pip-M5A9hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:45 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)) 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:45 INFO - Running setup.py (path:/tmp/pip-FDjzBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:45 INFO - Running setup.py (path:/tmp/pip-q_hWtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:45 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)) 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:45 INFO - Running setup.py (path:/tmp/pip-HZhJTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:45 INFO - Running setup.py (path:/tmp/pip-EQxMkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:46 INFO - Running setup.py (path:/tmp/pip-gZ4UO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:46 INFO - Running setup.py (path:/tmp/pip-kahPTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:46 INFO - Running setup.py (path:/tmp/pip-IGYr3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:46 INFO - Running setup.py (path:/tmp/pip-WBfWpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:46 INFO - Running setup.py (path:/tmp/pip-YcVNrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:46 INFO - Running setup.py (path:/tmp/pip-uF_Vsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:46 INFO - Running setup.py (path:/tmp/pip-T03aO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:46 INFO - Running setup.py (path:/tmp/pip-MQtFY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:46 INFO - Running setup.py (path:/tmp/pip-thLxKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:46 INFO - Running setup.py (path:/tmp/pip-2qv86X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:46 INFO - Running setup.py (path:/tmp/pip-nH2zE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:46 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)) 05:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:46 INFO - Running setup.py (path:/tmp/pip-iL0AU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:46 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)) 05:09:46 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:46 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:46 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)) 05:09:46 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:46 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:46 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 05:09:46 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 05:09:46 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 05:09:46 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 05:09:46 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 05:09:46 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 05:09:48 INFO - Downloading blessings-1.6.tar.gz 05:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:48 INFO - Installing collected packages: blessings 05:09:48 INFO - Running setup.py install for blessings 05:09:48 INFO - Successfully installed blessings 05:09:48 INFO - Cleaning up... 05:09:49 INFO - Return code: 0 05:09:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:49 INFO - Reading from file tmpfile_stdout 05:09:49 INFO - Current package versions: 05:09:49 INFO - argparse == 1.2.1 05:09:49 INFO - blessings == 1.6 05:09:49 INFO - blobuploader == 1.2.4 05:09:49 INFO - docopt == 0.6.1 05:09:49 INFO - manifestparser == 1.1 05:09:49 INFO - mozInstall == 1.12 05:09:49 INFO - mozcrash == 0.17 05:09:49 INFO - mozdebug == 0.1 05:09:49 INFO - mozdevice == 0.48 05:09:49 INFO - mozfile == 1.2 05:09:49 INFO - mozhttpd == 0.7 05:09:49 INFO - mozinfo == 0.9 05:09:49 INFO - mozleak == 0.1 05:09:49 INFO - mozlog == 3.1 05:09:49 INFO - moznetwork == 0.27 05:09:49 INFO - mozprocess == 0.22 05:09:49 INFO - mozprofile == 0.28 05:09:49 INFO - mozrunner == 6.11 05:09:49 INFO - mozscreenshot == 0.1 05:09:49 INFO - mozsystemmonitor == 0.0 05:09:49 INFO - moztest == 0.7 05:09:49 INFO - mozversion == 1.4 05:09:49 INFO - psutil == 3.1.1 05:09:49 INFO - requests == 1.2.3 05:09:49 INFO - wsgiref == 0.1.2 05:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:49 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')]} 05:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:49 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')]} 05:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 05:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 05:09:49 INFO - Using env: {'DISPLAY': ':0', 05:09:49 INFO - 'HOME': '/home/cltbld', 05:09:49 INFO - 'LANG': 'en_US.UTF-8', 05:09:49 INFO - 'LANGUAGE': 'en_US:en', 05:09:49 INFO - 'LOGNAME': 'cltbld', 05:09:49 INFO - 'MAIL': '/var/mail/cltbld', 05:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:49 INFO - 'MOZ_NO_REMOTE': '1', 05:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:49 INFO - 'NO_EM_RESTART': '1', 05:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:49 INFO - 'PWD': '/builds/slave/test', 05:09:49 INFO - 'SHELL': '/bin/bash', 05:09:49 INFO - 'SHLVL': '1', 05:09:49 INFO - 'TERM': 'linux', 05:09:49 INFO - 'TMOUT': '86400', 05:09:49 INFO - 'USER': 'cltbld', 05:09:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:49 INFO - '_': '/tools/buildbot/bin/python'} 05:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:49 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 2)) 05:09:49 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 3)) 05:09:49 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 4)) 05:09:49 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 5)) 05:09:49 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 6)) 05:09:49 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 7)) 05:09:49 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 8)) 05:09:49 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 9)) 05:09:49 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:49 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 4)) 05:09:49 INFO - Cleaning up... 05:09:49 INFO - Return code: 0 05:09:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:49 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')]} 05:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:49 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')]} 05:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 05:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 05:09:49 INFO - Using env: {'DISPLAY': ':0', 05:09:49 INFO - 'HOME': '/home/cltbld', 05:09:49 INFO - 'LANG': 'en_US.UTF-8', 05:09:49 INFO - 'LANGUAGE': 'en_US:en', 05:09:49 INFO - 'LOGNAME': 'cltbld', 05:09:49 INFO - 'MAIL': '/var/mail/cltbld', 05:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:49 INFO - 'MOZ_NO_REMOTE': '1', 05:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:49 INFO - 'NO_EM_RESTART': '1', 05:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:49 INFO - 'PWD': '/builds/slave/test', 05:09:49 INFO - 'SHELL': '/bin/bash', 05:09:49 INFO - 'SHLVL': '1', 05:09:49 INFO - 'TERM': 'linux', 05:09:49 INFO - 'TMOUT': '86400', 05:09:49 INFO - 'USER': 'cltbld', 05:09:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:49 INFO - '_': '/tools/buildbot/bin/python'} 05:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:49 INFO - Downloading/unpacking jsonschema 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:49 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 05:09:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:51 INFO - Downloading/unpacking functools32 (from jsonschema) 05:09:51 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 05:09:51 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 05:09:51 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 05:09:51 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 05:09:51 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 05:09:51 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 05:09:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:51 INFO - warning: no files found matching '*.txt' 05:09:51 INFO - no previously-included directories found matching 'build' 05:09:51 INFO - no previously-included directories found matching 'dist' 05:09:51 INFO - no previously-included directories found matching '.git*' 05:09:51 INFO - Installing collected packages: jsonschema, functools32 05:09:51 INFO - Running setup.py install for functools32 05:09:51 INFO - warning: no files found matching '*.txt' 05:09:51 INFO - no previously-included directories found matching 'build' 05:09:51 INFO - no previously-included directories found matching 'dist' 05:09:51 INFO - no previously-included directories found matching '.git*' 05:09:52 INFO - Successfully installed jsonschema functools32 05:09:52 INFO - Cleaning up... 05:09:52 INFO - Return code: 0 05:09:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c2f904f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', '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 05:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test/build 05:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 flake8 05:09:52 INFO - Using env: {'DISPLAY': ':0', 05:09:52 INFO - 'HOME': '/home/cltbld', 05:09:52 INFO - 'LANG': 'en_US.UTF-8', 05:09:52 INFO - 'LANGUAGE': 'en_US:en', 05:09:52 INFO - 'LOGNAME': 'cltbld', 05:09:52 INFO - 'MAIL': '/var/mail/cltbld', 05:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:52 INFO - 'MOZ_NO_REMOTE': '1', 05:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:52 INFO - 'NO_EM_RESTART': '1', 05:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:52 INFO - 'PWD': '/builds/slave/test', 05:09:52 INFO - 'SHELL': '/bin/bash', 05:09:52 INFO - 'SHLVL': '1', 05:09:52 INFO - 'TERM': 'linux', 05:09:52 INFO - 'TMOUT': '86400', 05:09:52 INFO - 'USER': 'cltbld', 05:09:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:52 INFO - '_': '/tools/buildbot/bin/python'} 05:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:52 INFO - Downloading/unpacking flake8 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:09:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:09:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:54 INFO - no previously-included directories found matching 'docs/_build' 05:09:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:09:54 INFO - Running setup.py install for pep8 05:09:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:55 INFO - no previously-included directories found matching 'docs/_build' 05:09:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:09:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:09:55 INFO - Cleaning up... 05:09:55 INFO - Return code: 0 05:09:55 INFO - Running post-action listener: _resource_record_post_action 05:09:55 INFO - Running post-action listener: _start_resource_monitoring 05:09:55 INFO - Starting resource monitoring. 05:09:55 INFO - ##### 05:09:55 INFO - ##### Running install step. 05:09:55 INFO - ##### 05:09:55 INFO - Running pre-action listener: _resource_record_pre_action 05:09:55 INFO - Running main action method: install 05:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:55 INFO - Reading from file tmpfile_stdout 05:09:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:55 INFO - Reading from file tmpfile_stdout 05:09:55 INFO - Output received: 05:09:55 INFO - Usage: mozinstall [options] installer 05:09:55 INFO - Options: 05:09:55 INFO - -h, --help show this help message and exit 05:09:55 INFO - -d DEST, --destination=DEST 05:09:55 INFO - Directory to install application into. [default: 05:09:55 INFO - "/builds/slave/test"] 05:09:55 INFO - --app=APP Application being installed. [default: firefox] 05:09:55 INFO - mkdir: /builds/slave/test/build/application 05:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:10:11 INFO - Reading from file tmpfile_stdout 05:10:11 INFO - Output received: 05:10:11 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:11 INFO - Running post-action listener: _resource_record_post_action 05:10:11 INFO - ##### 05:10:11 INFO - ##### Running run-tests step. 05:10:11 INFO - ##### 05:10:11 INFO - Running pre-action listener: _resource_record_pre_action 05:10:11 INFO - Running main action method: run_tests 05:10:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:11 INFO - Python 2.7.3 05:10:11 INFO - Return code: 0 05:10:11 INFO - grabbing minidump binary from tooltool 05:10:11 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')]} 05:10:11 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 0x1428410>, '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 0x1429310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14297a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:11 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 05:10:11 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 05:10:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:12 INFO - Return code: 0 05:10:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:10:13 INFO - Return code: 0 05:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:10:13 INFO - Using env: {'DISPLAY': ':0', 05:10:13 INFO - 'HOME': '/home/cltbld', 05:10:13 INFO - 'LANG': 'en_US.UTF-8', 05:10:13 INFO - 'LANGUAGE': 'en_US:en', 05:10:13 INFO - 'LOGNAME': 'cltbld', 05:10:13 INFO - 'MAIL': '/var/mail/cltbld', 05:10:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:13 INFO - 'MOZ_NO_REMOTE': '1', 05:10:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:13 INFO - 'NO_EM_RESTART': '1', 05:10:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:13 INFO - 'PWD': '/builds/slave/test', 05:10:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:13 INFO - 'SHELL': '/bin/bash', 05:10:13 INFO - 'SHLVL': '1', 05:10:13 INFO - 'TERM': 'linux', 05:10:13 INFO - 'TMOUT': '86400', 05:10:13 INFO - 'USER': 'cltbld', 05:10:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071', 05:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:13 INFO - '_': '/tools/buildbot/bin/python'} 05:10:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:10:13 INFO - mozversion application_buildid: 20160419023018 05:10:13 INFO - mozversion application_changeset: d4b74afcc60b937f25d54f365be46a8133980209 05:10:13 INFO - mozversion application_display_name: Nightly 05:10:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:13 INFO - mozversion application_name: Firefox 05:10:13 INFO - mozversion application_remotingname: firefox 05:10:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:13 INFO - mozversion application_vendor: Mozilla 05:10:13 INFO - mozversion application_version: 48.0a1 05:10:13 INFO - mozversion platform_buildid: 20160419023018 05:10:13 INFO - mozversion platform_changeset: d4b74afcc60b937f25d54f365be46a8133980209 05:10:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:13 INFO - mozversion platform_version: 48.0a1 05:10:13 INFO - using testdate: 1461067813 05:10:13 INFO - actual date: 1461067813 05:10:13 INFO - starting webserver on 'localhost:42242' 05:10:13 INFO - SUITE-START | Running 2 tests 05:10:13 INFO - TEST-START | dromaeo_css 05:10:13 INFO - operating with platform_type : linux_ 05:10:13 INFO - Initialising browser for dromaeo_css test... 05:10:13 INFO - TEST-INFO | started process 22352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiUB7aj/profile http://localhost:42242/getInfo.html) 05:10:17 INFO - PROCESS | 22352 | 05:10:17 INFO - PROCESS | 22352 | (process:22421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:10:17 INFO - PROCESS | 22352 | __metrics Screen width/height:1600/1200 05:10:17 INFO - PROCESS | 22352 | colorDepth:24 05:10:17 INFO - PROCESS | 22352 | Browser inner width/height: 1024/697 05:10:17 INFO - PROCESS | 22352 | __metrics 05:10:18 ERROR - PROCESS | 22352 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:10:19 INFO - TEST-INFO | 22352: exit 0 05:10:19 INFO - Browser initialized. 05:10:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:19 INFO - TEST-INFO | started process 22472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiUB7aj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:21 INFO - PROCESS | 22472 | 05:10:21 INFO - PROCESS | 22472 | (process:22533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:10:31 INFO - PROCESS | 22472 | RSS: Main: 163381248 05:10:31 INFO - PROCESS | 22472 | 05:11:20 INFO - PROCESS | 22472 | 1461067880847 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] 05:13:27 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:42242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42242/tests/dromaeo/cssquery-ext.html) 05:13:29 INFO - PROCESS | 22472 | RSS: Main: 168083456 05:13:29 INFO - PROCESS | 22472 | 05:16:30 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:42242/tests/dromaeo/cssquery-ext.html (next: http://localhost:42242/tests/dromaeo/cssquery-jquery.html) 05:16:31 INFO - PROCESS | 22472 | RSS: Main: 165007360 05:16:31 INFO - PROCESS | 22472 | 05:19:33 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:42242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42242/tests/dromaeo/cssquery-mootools.html) 05:19:33 INFO - PROCESS | 22472 | RSS: Main: 166223872 05:19:33 INFO - PROCESS | 22472 | 05:22:35 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:42242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42242/tests/dromaeo/cssquery-prototype.html) 05:22:36 INFO - PROCESS | 22472 | RSS: Main: 164139008 05:22:36 INFO - PROCESS | 22472 | 05:25:38 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:42242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42242/tests/dromaeo/cssquery-yui.html) 05:25:39 INFO - PROCESS | 22472 | RSS: Main: 165015552 05:25:39 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:42242/tests/dromaeo/cssquery-yui.html (next: http://localhost:42242/tests/dromaeo/cssquery-dojo.html) 05:28:41 INFO - PROCESS | 22472 | RSS: Main: 167477248 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | __start_tp_report 05:28:41 INFO - PROCESS | 22472 | _x_x_mozilla_page_load 05:28:41 INFO - PROCESS | 22472 | _x_x_mozilla_page_load_details 05:28:41 INFO - PROCESS | 22472 | |i|pagename|runs| 05:28:41 INFO - PROCESS | 22472 | |0;dojo.html;3120.6411262704787;3155.558221848941;3164.6518882922887;3177.9205519861985;3201.5837941067657;5164.638475306725;5253.947460525394;5258.2638430619745;5290.788368465262;5292.629515933886;5319.175527793198;5328.946710532893;5360.249565060894;5406.513413792758;5416.620836541444;4878.853634390974;4904.754762261872;4956.801727930896;4985.725785081819;4999.200127979524;512.4993882383649;4816.951830481686;4871.439784424783;4875.536824001714;4877.756112194394;4933.851984440473;4934.506549345055;4936.210206367;4949.8020079196785;4971.45314015458;4929.260610908356;4945.258211268302;4953.455119936804;4956.330895329121;4963.751812409365;4887.682300650482;4906.043321552299;4937.259411088329;4954.157793175169;4986.10250154972;5226.398964119099;5226.425093239741;5242.2136679498;5248.160294352923;5268.4994925482015;5609.747561359749;5622.381538030813;5652.576056795716;5656.321241451011;5718.199452076713;5686.232358631614;5692.459216374438;5701.971490142523;5750.65496070233;5753.683547404891;5403;5405.702686352249;5409.918851217235;5415.593830462731;5421.2952316199035;5663.6035477517;5798.768049278066;5846.590738648339;5868.383819698955;5885.646861188342;5726.3128424588485;5732.3407808101765;5738.282714660668;5742.684152371659;5748.856278593069;5747.626404283708;5750.396208398058;5761.222234998306;5771.105478650816;5787.88424231513;5535.225068490415;5759.481646651821;5760;5828.6211396259105;5848.736806843703;5690.971545142248;5699.344575373802;5701;5705.857353566194;5706.885862282731;4267.637250833652;4272.487301523837;4280.079782846703;4285.292926667127;4312.633426158749;3794.127350709297;3840.8655697050467;3880.20455806559;3883.262180185756;3935.763854168759;5442.2380866678695;5477.917831232535;5488.506034456838;5537.501624853782;5560.221568980346;5645.858853528613;5696.857578560486;5713.285839270091;5720.256366672389;5724.570657200727;5423.349198096174;5468.863278417992;5526.58550608706;5599.636023658449;5611.298587676541;4880.389951256093;4925.75371231437;4926.975365123151;4943.184374578154;4957.281194226889;5840.065589505743;5865.853353666107;5896.64620122794;5930.851728706817;5937.940620593825;5746.482816546531;5853.765849366063;5881.676507792113;5906.2026626406605;5928.822135335947;5913.881722365442;5967.8209653710455;5980.132880732356;5985.910211346921;5989.610675306091;5509.311336082989;5689.943100568941;5690.573207009574;5691.658500489818;5736.770529178786;5738.5696072795545;5776.277965254343;5784.913226301693;5792.623479473821;5811.79658711943;5633.295838020247;5677.971610141923;5681.715914204356;5686.9715651421475;5690.573207009574;5609.411011843697;5614.522765564972;5636.661800291996;5666.801661941812;5680.971595141998;5558.249636299048;5567.192757050286;5582.665040097607;5599.80400685974;5606.747696353592;5641.971790141023;5643.604947653625;5645.125005624135;5682.744276507485;5698.373178950395;5454.509094181542;5454.91817622728;5518.586106041983;5578.079616863172;5594.916076258941 05:28:41 INFO - PROCESS | 22472 | |1;ext.html;598.7186022569393;650.4406210658833;657.7862194786693;662.6752891083369;678.2132726037797;36169.63830361696;37555.43666845;37675.62324376756;37778.811105944435;37874.81062594687;41329.79335103328;42450.15099698004;42496.3625545617;42556.78721606395;42617.147657046844;8568.057513673506;8765.342599305046;8783.604737786814;8786.6924657637;8789.912100879006;8693.652253909837;8746.781330466725;8813.074627164151;8814.823703525957;8844.248238899701;8791.912080879205;8879.556022198896;8892.911070889306;8909.06454822244;8928.508932008737;8773.385862989593;8863.867041994376;8872.645094196225;8877.778055548632;8892.777680557972;8721.651133954634;8776.297896168291;8806.603702833389;8850.291976641918;8851.247643950272;33404.331913361595;39208.21583568341;39544.60455395438;39806.20387592261;39827.20345593101;3423.3324501722172;3579.624139465345;3753.568339640949;4010.966945467704;4217.852375166885;28065;28114.859425702944;28299.292517687223;28448.146555603365;29355.559666604804;4137.234611596864;4180.665546756282;4193.643540299047;4206.915861682749;4223.239816832969;194903;196904;196939;198819;247458;35228.647713522536;35675.10812229715;35684;35723.82138089293;36303.4554481683;35573.82213088918;35602.28795424077;35616.28767424637;35657;36053.45919811205;15267.465638702592;15445.536633901002;15474;15505.457308994131;15528.456504022304;12198.329091899854;12230.816537751942;12247.448864801105;12273.140880138304;12310.630681079581;8565.186307300797;8712.910886139232;8779.078196789245;8792.208701216921;8812.250958668585;3293.75296852737;3380.273241253093;3397.5073614325784;3409.761316707856;3411.334789716031;1069.486854844722;1100.944952752359;1146.4840821630132;1231.2181764579557;1240.5347994502063;32317;32470.35059298801;32712.836435818146;33074.503882441786;33144.17139571482;1124.8087825069758;1189.3458597771191;1253.8307328510534;1261.2306493039239;1280.9103362764517;16692.582685432717;17487;17566.10085491265;17677.469675909742;17731.758776885494;514462;520665;521338;522161;526123;58864.70567647134;59762.10356844651;60529.69735151296;60597;60797.39202608006;1388.9166650001032;1443.458702986401;1451.1873350923518;1463.6926245488353;1565.8199307079603;31433;31483.212919676276;31720.524192136676;32182.19544511406;32753;51212.231816522035;55415.72292138675;57398;57411.71294143503;57586.7120664394;406074;415448;415501;418439;419905;44444.333334999355;44921.32618010798;45313.09373812439;45370.319445207686;46553.53446465492;50216;50299.74850125872;50402;51185.48814511807;51779.741101294254;41283.587164127974;41407.171856563305;42623;43559.78220108879;43839.34240986324;42412.36381454342;43107.13785724205;43254.56745432506;43929.34105988477;44133.77933110314;38323.42514862335;43792.562074378846;44572;44811.10377792361;46900.7654961723;35232.823835880656;35383.115422113624;35846.28307433889;35928;36130.45804312885;28163.295917601405;28223.57664635073;28703;28892;29049.12852614425 05:28:41 INFO - PROCESS | 22472 | |2;jquery.html;392.2821237136041;401.80713257636313;402.73017078557365;403.68915934730256;406.3843277434687;14098.506552270646;14540.927295363535;17216.483505494838;17828.55428614287;17841;15014.249287535635;15705;15722.213889305545;15961.840381596181;17700;5473.781048758055;5594.300712410949;5613.775448982035;5624.240727501796;5662.405447428023;4862.2220444728855;5588.86027849303;5630.7184640768;5635.267415236034;5645.15322701594;5521.254630624854;5550;5575.581831362664;5586.776528938837;5695.686737229451;5554.638948468337;5721.4564616361795;5753.482186603226;5764.82705518833;5777.104548794943;4938.432080310774;5024.824131155392;5099.286099946011;5105.438401775802;5138.897222055575;21524.784752152435;22045.889770551206;22343;22389.432739708227;22654.320370388916;2379.060271192869;2429.4047958250167;2474.9133780317784;2632.6182703507884;2819.5863941232883;13967.930160349235;14290.714185716228;14412.783808242884;14526.346314415876;14543.27283635814;1943.0673276827201;2011.6177926193977;2028.0974966140075;2044.5910817836493;2050.1901748809137;76080;77183.61408192923;77331.22668773352;77930.83103753506;77997.61001195015;9974.251931105051;10019.198464122852;10444.42555659446;10483.947580262049;10567.207459440573;14610.634734131732;14685.55943321702;14720.926395367955;14781.187034713193;14802.925985370004;8179.918200817916;8274.586270686563;8361.540115293596;8420.536870472182;8459.23866851974;7975.680972761141;8017.278444939983;8078.515289082674;8115.1479094694205;8265.876011859827;6279.905801412982;6328.6835658216905;6369.108324834527;6388.520860935449;6392;1880.7555017847592;1890.2439024390353;1897.8956157411476;1906.6282074995243;1950.0834607734341;967.9370840895319;1025.195221750922;1071.9035286824223;1081.3403823667556;1184.7215904262491;18607.720884186747;18960.715589266172;19042.238310467703;19135.80864191368;19232.903835480734;1011.9526290289515;1025.266934142092;1079.8164312066967;1103.834424836281;1151.7581307925261;10596.629117980989;11054.668359949053;11104.222704410613;11237.83143252852;11244.943775281236;493463;502579;505510;532606;553773;74449.6277518609;76498;76525;77473.22526774772;77608.61195694098;1025.8922813104666;1072.1690689715376;1086.2504871638703;1086.8587083679072;1088.031651829872;17375.47873563795;17441.215145318238;17507.216844965107;17549.824501754818;17619.295228190727;36953.44569831401;37789;38292.234155317296;39066.60933390629;39441.40837887491;53163.20255196098;55061.449385505635;55746;55776;55852;8229.683250679862;8406.789830254293;8413.915860841313;8453.450525715809;8686.435381700168;12467.625971220878;13072.803907941197;13119.868801312246;13247.536336228186;13427.395767190304;11576.652700419001;11593.768124637292;11798.174127810971;12017.63947081589;12182.695432614255;11096.722581935515;11460.312381257152;11486.908743669339;11505.597304094317;11577.768444631229;11236.83144752813;11382;11699.532018719156;12093.213941093802;12160.45277962476;8332.875006875023;8468.322534197127;8485.95757021211;8520.786980325542;8619.1811777881;10604.257701961098;12019.338936358234;12081.939590301992;12104.515819367127;12141.575044873387 05:28:41 INFO - PROCESS | 22472 | |3;mootools.html;1524.5807402964183;1543.845615438456;1720.432257355073;1775.1834156288107;1821.3807305516123;7214.35070843624;7665.310122089011;7695.576743279117;7904.881426778596;7931.246531579505;7714.922850771491;7726.343260822837;7805.180456052118;7809.375249980002;7815.687372505107;2268.7050683411176;2295.8163346932206;2303.1593468384085;2303.5968705476557;2305.5158416732506;2249.966250506244;2252;2297.1041293895396;2301.9309420717404;2306.031466783955;2254.4927391336983;2262.7963483286503;2282.338121944634;2301.0680674326923;2305.2162264829954;2209.0501084533644;2216.0692509146115;2226.6882636430914;2232.386093824195;2234.597772400967;2210.071769856664;2212.424769559926;2212.668099785029;2213.103693004336;2217.9889100554556;7875.133735289113;7882.251186137308;7884.487508311941;7902.130765615835;7930.801729956797;4708.858734237979;4883.096627123993;4911.582515486152;4920.163572192736;4924.8276310328965;3099.3336432667083;3206.903792886217;3272.96727032729;3275.050235431722;3328.650491698361;1153.9826902596467;1171.912106592009;1175.1480176871785;1185.1052455396207;1200.0519589524265;10722.463876806129;10773.084287835465;10818.404987725671;10855;10899.673009809718;4244.427002354704;4381.255186618282;4452.042810795694;4539.6368290536675;4553.317002449659;8350.582470876432;8390.160983901562;8413.95793021031;8422.957885210535;8433.578321083922;4849.806007759721;4863.95136048635;4872.317875497433;4887.315775791392;4907.68100073494;4074.083331250445;4598.218302888517;4613.63090952723;4614.515475875052;4672.649551283599;3529.735269854771;3611.0972256935765;3682.9815850920572;3691.3540130477595;3698.9260214795554;1128.2609890521721;1137.5734099712608;1154.3997121496775;1154.4285578638628;1155.6128696886637;1012.8278192707257;1026.1585499890018;1029.897010298964;1034.2605037398296;1036.300497164411;5699.515541178963;5758.395368486333;5842.357340692521;5900.586958912835;5930.22907022093;951.0251991708554;977.8728765260613;1022.5909636145601;1027.6968294353185;1044.7231483656838;4030.9596904031173;4048.8380464781667;4072.3687828386646;4094.0636077686877;4095.5494895561465;9213.170814626716;9607.279454040974;9884.11043006133;9912.504374781376;9935.254855885838;9631.470269135265;9721.173700235418;9733.610655573839;9755.65855195079;9767.218622510181;7356.668949897267;7517.661705223278;7522.548647081193;7581.317681408589;7661.502002369828;5618.831435056954;5662.915056274242;5789.421057894346;5864.706764661835;5873.442023007808;8923.821523569623;8966.910330896608;8982.461052336881;9007.369484136048;9223.400478968846;9174.816503669756;9280.164785169367;9317.86023209639;9327.906720932704;9367.11012453843;6260.092286618506;6623.4038936495945;6623.569467984566;6715.697793599202;6852.794416167523;7501.0998680156545;7562.810929726801;7570.697172113274;7582;7635.923640763522;6764.898526522008;6977.33715297046;7055.082839230867;7149.9285007149265;7247.818804529718;6894.931050689429;7006;7092.361687447948;7130;7132.179799323144;6467.708953097028;6523.217213934168;6554.868902622016;6623.072769812134;6648.202215734143;5142.151544995184;5160.845174644766;5169.560587350117;5171.379434467888;5173.922391164211;5067.898642027065;5114.488551144856;5116.846494605168;5160.819371321985;5182.481751824787 05:28:41 INFO - PROCESS | 22472 | |4;prototype.html;323.876926767828;325.69059393576094;326.1845386533666;339.44331296673454;347.3885960709152;6028.276606807184;6055.608034826241;6059.697015149236;6107.480864126549;6127.142200091991;5962.731677074531;5963.791267305645;5993.700314984244;5998.940010599904;6006.279246490416;4275.060191438129;4367.344898265262;4488.7531185784765;4561.612262957636;4573.611243044345;4605.470370907355;4613.1926912790295;4614.607758340545;4659.184642687533;4663.370444989917;4567.885802854922;4578.542145785428;4603.10239503297;4606.262997920333;4619.769011549426;4280.850170244058;4423.911521769579;4453.4433195850515;4601.815927362902;4619.653525985547;3774.433834924756;3791.791451470168;3809.2000679857265;3811.1424929390664;3822.7132965027454;5749.540036797046;5765.048766953448;5778.768849246025;5786.132080188006;5806.1000544915605;4938.604911607063;5111.1566591512355;5117.309163262987;5170.819021334235;5174.146265866128;6094.177286066369;6176.197094377702;6188.783392581283;6207.193064901579;6223.1287619733275;4284.67864910133;4296.978515107405;4302.677299202573;4306.5262821089655;4323.697341186118;6192.442680158807;6227.252729672468;6295.779647712354;6401.775937842153;6625.238097618739;4403.713758605681;4418.403515525363;4451.818608881625;4463.4420697412825;4480.551944805494;4488.1472520221705;4509.12072145935;4525.52481989393;4530.433695788027;4530.818767249273;5115.64190506661;5220.843374698765;5233.790648374099;5238.135707608279;5297.788088476418;6374.649394283266;6385.936140638627;6397.808065758035;6404.967975160094;6413.326600706859;1611.508489910565;1623.7320842061165;1627.3083939325738;1631.4779270633521;1640.3192675039725;1047.5181416548473;1063.994680026595;1071.036067539221;1107.307932542161;1122.7305446692899;6049.215481432988;6064.151018857364;6077.908831367533;6090.634561926298;6115.938840611626;6465.838354041092;6490.643014634241;6510.837229069311;6518.511111666644;6525.575837570543;5951.702414879239;6176.135341052256;6201.875962480725;6212.161358216673;6218.409251121137;3475.6003059648465;3511.2977404519197;3514.121469632592;3514.8594056237466;3519.9120021999656;6455.7740479083;6786.762463313859;6839.1451068616425;6847.863042739117;6854.554453960476;6675.399214070757;6692.83267918306;6712.463002959849;6712.630805305657;6739.090222819955;6551.21385433751;6790.49071319653;6807.21717002551;6816.352446517573;6864.2106157791495;6494;6508.9349106508325;6540.444062254762;6544.149260596092;6606.339366063356;6152.477039451696;6331.556791024584;6459.192600924885;6481.416672499309;6488.70800813974;6681.231658359156;6797.150356205474;6824.692888819915;6827.419669328163;6858.828529286808;4233.3861590068655;4243.42713733642;4244.7877606118955;4271.124419494058;4318.395424640616;6373.362663733589;6599.5050371223315;6612.603243805387;6612.636305003271;6619.371159739817;6400.519961003037;6407.8718425630295;6426.42162205385;6442.549021568632;6446.226452825691;6115.235595550556;6400.167978162809;6401.583897046677;6417;6427.678616069272;6197.411245931629;6292.539103492969;6314.747410103728;6337.6197428154455;6360;6198.442140207223;6377.4579160771855;6443.291237963914;6455.806325810233;6480.740770369321;6297.370262973666;6298.338674439118;6309.2744334400295;6316.62100273985;6327.462165715966 05:28:41 INFO - PROCESS | 22472 | |5;yui.html;834.8872902158208;859.8194379180376;865.1348651348651;866.6533386645341;875.6628697951287;14533.636659083528;14854.628634284149;14888.25558722065;14891.925540372311;15040.774388384169;12439.813402798942;14068.296585170752;14068.437262509513;14073.929630351833;14114.29428528572;805.2913436176171;823;827.6192951242435;830.5224495914842;833.791552111972;816.5508970066439;822.0628483528782;826.0747962282252;831.8086840026798;832.7043899415711;877.692807517367;879.5953861223845;881.066069965835;883.4875772052194;884.2086332732201;863.8142799298149;870.1429092344036;873.3013589128672;877.8595424732013;879.463527248378;643.4144928115393;643.7135474713755;645.1129696667083;647.1489990662265;647.9578827376253;14135.858641413557;14222.715545689132;14229.14625122496;14247.857521424758;14282.07166534172;13765;13765.862341376558;13768;13856.722865542733;13874.098183618033;10943.288686235448;11099.778004439946;11455.484503197376;11465.025472834819;12107.636770896886;3715.9071023224365;3748.6879592142805;3762.435634654796;3770.076331298822;3799.202167544819;49626;52475.21287180695;52826.207606885924;53010;55621.443785562034;10210.540525676362;10341.534630941625;10567.260291779656;10723.624673136403;10969.561217551369;17625.57939658303;17747.645047098984;17799.19903604341;17863.73204401935;18491.260349585868;7874.251946065229;7951.721689740832;7996.480228785111;8057.959710201529;8156.388270879707;4641.280601506772;4645.86062418128;4696.8590942271785;4703.365045718852;4786.258129989787;2936.0751363320487;3006.053093275611;3016.3213277012937;3017.5171972484295;3032.5602787596117;595.1519085303426;607.441154138194;613.7207570555387;614.3058344071171;619.9039148931832;627.1502114634695;634.5336177909234;724.3734169942961;725.2783480436999;735.6432130416744;8781.341399394943;9005.14451127155;9227.953860230657;9427.811443771086;9479.47862867549;600.6066026752484;678.0947435174098;691.6610860678231;703.4513079797766;752.5747952406873;4355.063661312833;4381.7151885128005;4439.511653718088;4513.074819661962;4525.04973955473;58746;59758.103628445606;59789.402105978384;59876;60506;52070;53099.20351194735;53169;54035.72982135143;54212.76553196433;47541.762291189014;47995;48565.08609483442;48694.26958595624;49942.50057499451;8438.367122465717;8505;8511.104035660202;8677.522736249566;8736.475811451333;32282.35435291328;33350.332993339514;33729.325413491104;33951;34292.48561271533;39831;39998.20003599853;40794.79602601968;42288;46240.768796155804;11793.29240245588;11916.76166476683;12008.699782505508;12057.15599907998;12122.75754484923;13402.731945360843;13477.865221347662;13522.594322170351;13795.379207935466;14578.635534111732;12555;12556.372181391076;12730;12828.55100071493;13524.661883452993;11685.182037257311;11690.532378704756;11909.344986025506;11982.880171198176;12424.130310878152;12891.613251602466;13064.608061758163;13073.084884058024;13106.148100373444;13177.934110329386;9847.950760246153;9876.654317098866;10074.597016119273;10108.444035578113;10437.11284540792;10432.374057556572;10880.009578878711;10927;10942.288751231144;10959.506822192861 05:28:41 INFO - PROCESS | 22472 | __end_tp_report 05:28:41 INFO - PROCESS | 22472 | __start_cc_report 05:28:41 INFO - PROCESS | 22472 | _x_x_mozilla_cycle_collect,333 05:28:41 INFO - PROCESS | 22472 | __end_cc_report 05:28:41 INFO - PROCESS | 22472 | __startTimestamp1461068921820__endTimestamp 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | ------- Summary: start ------- 05:28:41 INFO - PROCESS | 22472 | Number of tests: 6 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | [#0] dojo.html Cycles:165 Average:5314.74 Median:5594.92 stddev:713.24 (12.7%) stddev-sans-first:694.34 05:28:41 INFO - PROCESS | 22472 | Values: 3120.6 3155.6 3164.7 3177.9 3201.6 5164.6 5253.9 5258.3 5290.8 5292.6 5319.2 5328.9 5360.2 5406.5 5416.6 4878.9 4904.8 4956.8 4985.7 4999.2 512.5 4817.0 4871.4 4875.5 4877.8 4933.9 4934.5 4936.2 4949.8 4971.5 4929.3 4945.3 4953.5 4956.3 4963.8 4887.7 4906.0 4937.3 4954.2 4986.1 5226.4 5226.4 5242.2 5248.2 5268.5 5609.7 5622.4 5652.6 5656.3 5718.2 5686.2 5692.5 5702.0 5750.7 5753.7 5403.0 5405.7 5409.9 5415.6 5421.3 5663.6 5798.8 5846.6 5868.4 5885.6 5726.3 5732.3 5738.3 5742.7 5748.9 5747.6 5750.4 5761.2 5771.1 5787.9 5535.2 5759.5 5760.0 5828.6 5848.7 5691.0 5699.3 5701.0 5705.9 5706.9 4267.6 4272.5 4280.1 4285.3 4312.6 3794.1 3840.9 3880.2 3883.3 3935.8 5442.2 5477.9 5488.5 5537.5 5560.2 5645.9 5696.9 5713.3 5720.3 5724.6 5423.3 5468.9 5526.6 5599.6 5611.3 4880.4 4925.8 4927.0 4943.2 4957.3 5840.1 5865.9 5896.6 5930.9 5937.9 5746.5 5853.8 5881.7 5906.2 5928.8 5913.9 5967.8 5980.1 5985.9 5989.6 5509.3 5689.9 5690.6 5691.7 5736.8 5738.6 5776.3 5784.9 5792.6 5811.8 5633.3 5678.0 5681.7 5687.0 5690.6 5609.4 5614.5 5636.7 5666.8 5681.0 5558.2 5567.2 5582.7 5599.8 5606.7 5642.0 5643.6 5645.1 5682.7 5698.4 5454.5 5454.9 5518.6 5578.1 5594.9 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | [#1] ext.html Cycles:180 Average:54036.44 Median:223678.79 stddev:107309.44 (48.0%) stddev-sans-first:107535.47 05:28:41 INFO - PROCESS | 22472 | Values: 598.7 650.4 657.8 662.7 678.2 36169.6 37555.4 37675.6 37778.8 37874.8 41329.8 42450.2 42496.4 42556.8 42617.1 8568.1 8765.3 8783.6 8786.7 8789.9 8693.7 8746.8 8813.1 8814.8 8844.2 8791.9 8879.6 8892.9 8909.1 8928.5 8773.4 8863.9 8872.6 8877.8 8892.8 8721.7 8776.3 8806.6 8850.3 8851.2 33404.3 39208.2 39544.6 39806.2 39827.2 3423.3 3579.6 3753.6 4011.0 4217.9 28065.0 28114.9 28299.3 28448.1 29355.6 4137.2 4180.7 4193.6 4206.9 4223.2 194903.0 196904.0 196939.0 198819.0 247458.0 35228.6 35675.1 35684.0 35723.8 36303.5 35573.8 35602.3 35616.3 35657.0 36053.5 15267.5 15445.5 15474.0 15505.5 15528.5 12198.3 12230.8 12247.4 12273.1 12310.6 8565.2 8712.9 8779.1 8792.2 8812.3 3293.8 3380.3 3397.5 3409.8 3411.3 1069.5 1100.9 1146.5 1231.2 1240.5 32317.0 32470.4 32712.8 33074.5 33144.2 1124.8 1189.3 1253.8 1261.2 1280.9 16692.6 17487.0 17566.1 17677.5 17731.8 514462.0 520665.0 521338.0 522161.0 526123.0 58864.7 59762.1 60529.7 60597.0 60797.4 1388.9 1443.5 1451.2 1463.7 1565.8 31433.0 31483.2 31720.5 32182.2 32753.0 51212.2 55415.7 57398.0 57411.7 57586.7 406074.0 415448.0 415501.0 418439.0 419905.0 44444.3 44921.3 45313.1 45370.3 46553.5 50216.0 50299.7 50402.0 51185.5 51779.7 41283.6 41407.2 42623.0 43559.8 43839.3 42412.4 43107.1 43254.6 43929.3 44133.8 38323.4 43792.6 44572.0 44811.1 46900.8 35232.8 35383.1 35846.3 35928.0 36130.5 28163.3 28223.6 28703.0 28892.0 29049.1 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | [#2] jquery.html Cycles:180 Average:28980.58 Median:22366.22 stddev:84898.71 (379.6%) stddev-sans-first:85109.73 05:28:41 INFO - PROCESS | 22472 | Values: 392.3 401.8 402.7 403.7 406.4 14098.5 14540.9 17216.5 17828.6 17841.0 15014.2 15705.0 15722.2 15961.8 17700.0 5473.8 5594.3 5613.8 5624.2 5662.4 4862.2 5588.9 5630.7 5635.3 5645.2 5521.3 5550.0 5575.6 5586.8 5695.7 5554.6 5721.5 5753.5 5764.8 5777.1 4938.4 5024.8 5099.3 5105.4 5138.9 21524.8 22045.9 22343.0 22389.4 22654.3 2379.1 2429.4 2474.9 2632.6 2819.6 13967.9 14290.7 14412.8 14526.3 14543.3 1943.1 2011.6 2028.1 2044.6 2050.2 76080.0 77183.6 77331.2 77930.8 77997.6 9974.3 10019.2 10444.4 10483.9 10567.2 14610.6 14685.6 14720.9 14781.2 14802.9 8179.9 8274.6 8361.5 8420.5 8459.2 7975.7 8017.3 8078.5 8115.1 8265.9 6279.9 6328.7 6369.1 6388.5 6392.0 1880.8 1890.2 1897.9 1906.6 1950.1 967.9 1025.2 1071.9 1081.3 1184.7 18607.7 18960.7 19042.2 19135.8 19232.9 1012.0 1025.3 1079.8 1103.8 1151.8 10596.6 11054.7 11104.2 11237.8 11244.9 493463.0 502579.0 505510.0 532606.0 553773.0 74449.6 76498.0 76525.0 77473.2 77608.6 1025.9 1072.2 1086.3 1086.9 1088.0 17375.5 17441.2 17507.2 17549.8 17619.3 36953.4 37789.0 38292.2 39066.6 39441.4 53163.2 55061.4 55746.0 55776.0 55852.0 8229.7 8406.8 8413.9 8453.5 8686.4 12467.6 13072.8 13119.9 13247.5 13427.4 11576.7 11593.8 11798.2 12017.6 12182.7 11096.7 11460.3 11486.9 11505.6 11577.8 11236.8 11382.0 11699.5 12093.2 12160.5 8332.9 8468.3 8486.0 8520.8 8619.2 10604.3 12019.3 12081.9 12104.5 12141.6 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | [#3] mootools.html Cycles:180 Average:5320.33 Median:5129.50 stddev:2838.09 (55.3%) stddev-sans-first:2831.72 05:28:41 INFO - PROCESS | 22472 | Values: 1524.6 1543.8 1720.4 1775.2 1821.4 7214.4 7665.3 7695.6 7904.9 7931.2 7714.9 7726.3 7805.2 7809.4 7815.7 2268.7 2295.8 2303.2 2303.6 2305.5 2250.0 2252.0 2297.1 2301.9 2306.0 2254.5 2262.8 2282.3 2301.1 2305.2 2209.1 2216.1 2226.7 2232.4 2234.6 2210.1 2212.4 2212.7 2213.1 2218.0 7875.1 7882.3 7884.5 7902.1 7930.8 4708.9 4883.1 4911.6 4920.2 4924.8 3099.3 3206.9 3273.0 3275.1 3328.7 1154.0 1171.9 1175.1 1185.1 1200.1 10722.5 10773.1 10818.4 10855.0 10899.7 4244.4 4381.3 4452.0 4539.6 4553.3 8350.6 8390.2 8414.0 8423.0 8433.6 4849.8 4864.0 4872.3 4887.3 4907.7 4074.1 4598.2 4613.6 4614.5 4672.6 3529.7 3611.1 3683.0 3691.4 3698.9 1128.3 1137.6 1154.4 1154.4 1155.6 1012.8 1026.2 1029.9 1034.3 1036.3 5699.5 5758.4 5842.4 5900.6 5930.2 951.0 977.9 1022.6 1027.7 1044.7 4031.0 4048.8 4072.4 4094.1 4095.5 9213.2 9607.3 9884.1 9912.5 9935.3 9631.5 9721.2 9733.6 9755.7 9767.2 7356.7 7517.7 7522.5 7581.3 7661.5 5618.8 5662.9 5789.4 5864.7 5873.4 8923.8 8966.9 8982.5 9007.4 9223.4 9174.8 9280.2 9317.9 9327.9 9367.1 6260.1 6623.4 6623.6 6715.7 6852.8 7501.1 7562.8 7570.7 7582.0 7635.9 6764.9 6977.3 7055.1 7149.9 7247.8 6894.9 7006.0 7092.4 7130.0 7132.2 6467.7 6523.2 6554.9 6623.1 6648.2 5142.2 5160.8 5169.6 5171.4 5173.9 5067.9 5114.5 5116.8 5160.8 5182.5 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | [#4] prototype.html Cycles:180 Average:5281.65 Median:6071.03 stddev:1610.99 (26.5%) stddev-sans-first:1571.95 05:28:41 INFO - PROCESS | 22472 | Values: 323.9 325.7 326.2 339.4 347.4 6028.3 6055.6 6059.7 6107.5 6127.1 5962.7 5963.8 5993.7 5998.9 6006.3 4275.1 4367.3 4488.8 4561.6 4573.6 4605.5 4613.2 4614.6 4659.2 4663.4 4567.9 4578.5 4603.1 4606.3 4619.8 4280.9 4423.9 4453.4 4601.8 4619.7 3774.4 3791.8 3809.2 3811.1 3822.7 5749.5 5765.0 5778.8 5786.1 5806.1 4938.6 5111.2 5117.3 5170.8 5174.1 6094.2 6176.2 6188.8 6207.2 6223.1 4284.7 4297.0 4302.7 4306.5 4323.7 6192.4 6227.3 6295.8 6401.8 6625.2 4403.7 4418.4 4451.8 4463.4 4480.6 4488.1 4509.1 4525.5 4530.4 4530.8 5115.6 5220.8 5233.8 5238.1 5297.8 6374.6 6385.9 6397.8 6405.0 6413.3 1611.5 1623.7 1627.3 1631.5 1640.3 1047.5 1064.0 1071.0 1107.3 1122.7 6049.2 6064.2 6077.9 6090.6 6115.9 6465.8 6490.6 6510.8 6518.5 6525.6 5951.7 6176.1 6201.9 6212.2 6218.4 3475.6 3511.3 3514.1 3514.9 3519.9 6455.8 6786.8 6839.1 6847.9 6854.6 6675.4 6692.8 6712.5 6712.6 6739.1 6551.2 6790.5 6807.2 6816.4 6864.2 6494.0 6508.9 6540.4 6544.1 6606.3 6152.5 6331.6 6459.2 6481.4 6488.7 6681.2 6797.2 6824.7 6827.4 6858.8 4233.4 4243.4 4244.8 4271.1 4318.4 6373.4 6599.5 6612.6 6612.6 6619.4 6400.5 6407.9 6426.4 6442.5 6446.2 6115.2 6400.2 6401.6 6417.0 6427.7 6197.4 6292.5 6314.7 6337.6 6360.0 6198.4 6377.5 6443.3 6455.8 6480.7 6297.4 6298.3 6309.3 6316.6 6327.5 05:28:41 INFO - PROCESS | 22472 | 05:28:41 INFO - PROCESS | 22472 | [#5] yui.html Cycles:180 Average:14422.25 Median:4519.06 stddev:16401.86 (362.9%) stddev-sans-first:16416.13 05:28:41 INFO - PROCESS | 22472 | Values: 834.9 859.8 865.1 866.7 875.7 14533.6 14854.6 14888.3 14891.9 15040.8 12439.8 14068.3 14068.4 14073.9 14114.3 805.3 823.0 827.6 830.5 833.8 816.6 822.1 826.1 831.8 832.7 877.7 879.6 881.1 883.5 884.2 863.8 870.1 873.3 877.9 879.5 643.4 643.7 645.1 647.1 648.0 14135.9 14222.7 14229.1 14247.9 14282.1 13765.0 13765.9 13768.0 13856.7 13874.1 10943.3 11099.8 11455.5 11465.0 12107.6 3715.9 3748.7 3762.4 3770.1 3799.2 49626.0 52475.2 52826.2 53010.0 55621.4 10210.5 10341.5 10567.3 10723.6 10969.6 17625.6 17747.6 17799.2 17863.7 18491.3 7874.3 7951.7 7996.5 8058.0 8156.4 4641.3 4645.9 4696.9 4703.4 4786.3 2936.1 3006.1 3016.3 3017.5 3032.6 595.2 607.4 613.7 614.3 619.9 627.2 634.5 724.4 725.3 735.6 8781.3 9005.1 9228.0 9427.8 9479.5 600.6 678.1 691.7 703.5 752.6 4355.1 4381.7 4439.5 4513.1 4525.0 58746.0 59758.1 59789.4 59876.0 60506.0 52070.0 53099.2 53169.0 54035.7 54212.8 47541.8 47995.0 48565.1 48694.3 49942.5 8438.4 8505.0 8511.1 8677.5 8736.5 32282.4 33350.3 33729.3 33951.0 34292.5 39831.0 39998.2 40794.8 42288.0 46240.8 11793.3 11916.8 12008.7 12057.2 12122.8 13402.7 13477.9 13522.6 13795.4 14578.6 12555.0 12556.4 12730.0 12828.6 13524.7 11685.2 11690.5 11909.3 11982.9 12424.1 12891.6 13064.6 13073.1 13106.1 13177.9 9848.0 9876.7 10074.6 10108.4 10437.1 10432.4 10880.0 10927.0 10942.3 10959.5 05:28:41 INFO - PROCESS | 22472 | -------- Summary: end -------- 05:28:41 INFO - PROCESS | 22472 | 05:28:42 INFO - TEST-INFO | 22472: exit 0 05:28:42 INFO - TEST-OK | dromaeo_css | took 1109294ms 05:28:42 INFO - TEST-START | kraken 05:28:42 INFO - operating with platform_type : linux_ 05:28:42 INFO - Initialising browser for kraken test... 05:28:42 INFO - TEST-INFO | started process 22711 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwkVn7h/profile http://localhost:42242/getInfo.html) 05:28:46 INFO - PROCESS | 22711 | 05:28:46 INFO - PROCESS | 22711 | (process:22780): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:28:46 INFO - PROCESS | 22711 | __metrics Screen width/height:1600/1200 05:28:46 INFO - PROCESS | 22711 | colorDepth:24 05:28:46 INFO - PROCESS | 22711 | Browser inner width/height: 1024/697 05:28:46 INFO - PROCESS | 22711 | __metrics 05:28:47 ERROR - PROCESS | 22711 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:28:48 INFO - TEST-INFO | 22711: exit 0 05:28:48 INFO - Browser initialized. 05:28:48 INFO - Running cycle 1/1 for kraken test... 05:28:48 INFO - TEST-INFO | started process 22831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwkVn7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:50 INFO - PROCESS | 22831 | 05:28:50 INFO - PROCESS | 22831 | (process:22892): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:00 INFO - PROCESS | 22831 | RSS: Main: 163852288 05:29:00 INFO - PROCESS | 22831 | 05:29:02 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42242/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:03 INFO - PROCESS | 22831 | RSS: Main: 167821312 05:29:03 INFO - PROCESS | 22831 | 05:29:06 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42242/tests/kraken/driver.html?testName=audio-dft) 05:29:07 INFO - PROCESS | 22831 | RSS: Main: 171220992 05:29:07 INFO - PROCESS | 22831 | 05:29:09 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42242/tests/kraken/driver.html?testName=audio-fft) 05:29:10 INFO - PROCESS | 22831 | RSS: Main: 161062912 05:29:10 INFO - PROCESS | 22831 | 05:29:12 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42242/tests/kraken/driver.html?testName=audio-oscillator) 05:29:13 INFO - PROCESS | 22831 | RSS: Main: 161959936 05:29:13 INFO - PROCESS | 22831 | 05:29:15 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:16 INFO - PROCESS | 22831 | RSS: Main: 163090432 05:29:16 INFO - PROCESS | 22831 | 05:29:19 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42242/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:19 INFO - PROCESS | 22831 | RSS: Main: 163315712 05:29:19 INFO - PROCESS | 22831 | 05:29:23 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42242/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:23 INFO - PROCESS | 22831 | RSS: Main: 163438592 05:29:23 INFO - PROCESS | 22831 | 05:29:26 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42242/tests/kraken/driver.html?testName=json-parse-financial) 05:29:27 INFO - PROCESS | 22831 | RSS: Main: 166449152 05:29:27 INFO - PROCESS | 22831 | 05:29:28 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:29 INFO - PROCESS | 22831 | RSS: Main: 166363136 05:29:29 INFO - PROCESS | 22831 | 05:29:31 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:31 INFO - PROCESS | 22831 | RSS: Main: 166010880 05:29:31 INFO - PROCESS | 22831 | 05:29:33 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:34 INFO - PROCESS | 22831 | RSS: Main: 166121472 05:29:34 INFO - PROCESS | 22831 | 05:29:37 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:37 INFO - PROCESS | 22831 | RSS: Main: 167276544 05:29:37 INFO - PROCESS | 22831 | 05:29:40 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:41 INFO - PROCESS | 22831 | RSS: Main: 166866944 05:29:41 INFO - PROCESS | 22831 | 05:29:42 INFO - PROCESS | 22831 | Cycle 1(1): loaded http://localhost:42242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42242/tests/kraken/driver.html?testName=ai-astar) 05:29:43 INFO - PROCESS | 22831 | RSS: Main: 168501248 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | __start_tp_report 05:29:43 INFO - PROCESS | 22831 | _x_x_mozilla_page_load 05:29:43 INFO - PROCESS | 22831 | _x_x_mozilla_page_load_details 05:29:43 INFO - PROCESS | 22831 | |i|pagename|runs| 05:29:43 INFO - PROCESS | 22831 | |0;ai-astar;112;105;111;112;111;124;111;113;112;114 05:29:43 INFO - PROCESS | 22831 | |1;audio-beat-detection;163;127;159;184;135;152;176;127;188;126 05:29:43 INFO - PROCESS | 22831 | |2;audio-dft;161;164;161;161;162;164;175;163;166;163 05:29:43 INFO - PROCESS | 22831 | |3;audio-fft;84;76;76;146;78;77;79;78;175;77 05:29:43 INFO - PROCESS | 22831 | |4;audio-oscillator;93;92;151;93;92;93;155;94;92;137 05:29:43 INFO - PROCESS | 22831 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;118;118;118 05:29:43 INFO - PROCESS | 22831 | |6;imaging-darkroom;146;148;147;147;147;148;147;147;146;147 05:29:43 INFO - PROCESS | 22831 | |7;imaging-desaturate;96;96;95;95;96;95;96;96;95;96 05:29:43 INFO - PROCESS | 22831 | |8;json-parse-financial;61;65;57;59;56;57;57;74;54;54 05:29:43 INFO - PROCESS | 22831 | |9;json-stringify-tinderbox;60;61;61;61;62;61;61;63;61;61 05:29:43 INFO - PROCESS | 22831 | |10;stanford-crypto-aes;77;77;76;84;79;77;78;77;79;78 05:29:43 INFO - PROCESS | 22831 | |11;stanford-crypto-ccm;130;123;133;125;135;132;129;129;159;129 05:29:43 INFO - PROCESS | 22831 | |12;stanford-crypto-pbkdf2;171;166;164;163;175;164;166;168;165;162 05:29:43 INFO - PROCESS | 22831 | |13;stanford-crypto-sha256-iterative;69;69;73;71;76;68;67;69;75;66 05:29:43 INFO - PROCESS | 22831 | __end_tp_report 05:29:43 INFO - PROCESS | 22831 | __start_cc_report 05:29:43 INFO - PROCESS | 22831 | _x_x_mozilla_cycle_collect,847 05:29:43 INFO - PROCESS | 22831 | __end_cc_report 05:29:43 INFO - PROCESS | 22831 | __startTimestamp1461068983141__endTimestamp 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | ------- Summary: start ------- 05:29:43 INFO - PROCESS | 22831 | Number of tests: 14 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:4.70 (4.2%) stddev-sans-first:4.98 05:29:43 INFO - PROCESS | 22831 | Values: 112.0 105.0 111.0 112.0 111.0 124.0 111.0 113.0 112.0 114.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:161.00 stddev:24.16 (15.0%) stddev-sans-first:25.39 05:29:43 INFO - PROCESS | 22831 | Values: 163.0 127.0 159.0 184.0 135.0 152.0 176.0 127.0 188.0 126.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:4.19 (2.6%) stddev-sans-first:4.30 05:29:43 INFO - PROCESS | 22831 | Values: 161.0 164.0 161.0 161.0 162.0 164.0 175.0 163.0 166.0 163.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#3] audio-fft Cycles:10 Average:94.60 Median:77.50 stddev:35.47 (45.8%) stddev-sans-first:37.42 05:29:43 INFO - PROCESS | 22831 | Values: 84.0 76.0 76.0 146.0 78.0 77.0 79.0 78.0 175.0 77.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.50 stddev:26.92 (29.1%) stddev-sans-first:27.91 05:29:43 INFO - PROCESS | 22831 | Values: 93.0 92.0 151.0 93.0 92.0 93.0 155.0 94.0 92.0 137.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:29:43 INFO - PROCESS | 22831 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 05:29:43 INFO - PROCESS | 22831 | Values: 146.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 147.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:29:43 INFO - PROCESS | 22831 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:58.00 stddev:6.10 (10.5%) stddev-sans-first:6.44 05:29:43 INFO - PROCESS | 22831 | Values: 61.0 65.0 57.0 59.0 56.0 57.0 57.0 74.0 54.0 54.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 05:29:43 INFO - PROCESS | 22831 | Values: 60.0 61.0 61.0 61.0 62.0 61.0 61.0 63.0 61.0 61.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.00 stddev:2.25 (2.9%) stddev-sans-first:2.35 05:29:43 INFO - PROCESS | 22831 | Values: 77.0 77.0 76.0 84.0 79.0 77.0 78.0 77.0 79.0 78.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:131.00 stddev:9.99 (7.6%) stddev-sans-first:10.56 05:29:43 INFO - PROCESS | 22831 | Values: 130.0 123.0 133.0 125.0 135.0 132.0 129.0 129.0 159.0 129.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.00 stddev:3.98 (2.4%) stddev-sans-first:3.86 05:29:43 INFO - PROCESS | 22831 | Values: 171.0 166.0 164.0 163.0 175.0 164.0 166.0 168.0 165.0 162.0 05:29:43 INFO - PROCESS | 22831 | 05:29:43 INFO - PROCESS | 22831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:3.37 (4.8%) stddev-sans-first:3.54 05:29:43 INFO - PROCESS | 22831 | Values: 69.0 69.0 73.0 71.0 76.0 68.0 67.0 69.0 75.0 66.0 05:29:43 INFO - PROCESS | 22831 | -------- Summary: end -------- 05:29:43 INFO - PROCESS | 22831 | 05:29:44 INFO - TEST-INFO | 22831: exit 0 05:29:44 INFO - TEST-OK | kraken | took 61584ms 05:29:44 INFO - SUITE-END | took 1170s 05:29:44 INFO - Completed test suite (00:19:31) 05:29:44 INFO - javascript benchmark 05:29:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.6411262704787, 3155.558221848941, 3164.6518882922887, 3177.9205519861985, 3201.5837941067657, 5164.638475306725, 5253.947460525394, 5258.2638430619745, 5290.788368465262, 5292.629515933886, 5319.175527793198, 5328.946710532893, 5360.249565060894, 5406.513413792758, 5416.620836541444, 4878.853634390974, 4904.754762261872, 4956.801727930896, 4985.725785081819, 4999.200127979524, 512.4993882383649, 4816.951830481686, 4871.439784424783, 4875.536824001714, 4877.756112194394, 4933.851984440473, 4934.506549345055, 4936.210206367, 4949.8020079196785, 4971.45314015458, 4929.260610908356, 4945.258211268302, 4953.455119936804, 4956.330895329121, 4963.751812409365, 4887.682300650482, 4906.043321552299, 4937.259411088329, 4954.157793175169, 4986.10250154972, 5226.398964119099, 5226.425093239741, 5242.2136679498, 5248.160294352923, 5268.4994925482015, 5609.747561359749, 5622.381538030813, 5652.576056795716, 5656.321241451011, 5718.199452076713, 5686.232358631614, 5692.459216374438, 5701.971490142523, 5750.65496070233, 5753.683547404891, 5403.0, 5405.702686352249, 5409.918851217235, 5415.593830462731, 5421.2952316199035, 5663.6035477517, 5798.768049278066, 5846.590738648339, 5868.383819698955, 5885.646861188342, 5726.3128424588485, 5732.3407808101765, 5738.282714660668, 5742.684152371659, 5748.856278593069, 5747.626404283708, 5750.396208398058, 5761.222234998306, 5771.105478650816, 5787.88424231513, 5535.225068490415, 5759.481646651821, 5760.0, 5828.6211396259105, 5848.736806843703, 5690.971545142248, 5699.344575373802, 5701.0, 5705.857353566194, 5706.885862282731, 4267.637250833652, 4272.487301523837, 4280.079782846703, 4285.292926667127, 4312.633426158749, 3794.127350709297, 3840.8655697050467, 3880.20455806559, 3883.262180185756, 3935.763854168759, 5442.2380866678695, 5477.917831232535, 5488.506034456838, 5537.501624853782, 5560.221568980346, 5645.858853528613, 5696.857578560486, 5713.285839270091, 5720.256366672389, 5724.570657200727, 5423.349198096174, 5468.863278417992, 5526.58550608706, 5599.636023658449, 5611.298587676541, 4880.389951256093, 4925.75371231437, 4926.975365123151, 4943.184374578154, 4957.281194226889, 5840.065589505743, 5865.853353666107, 5896.64620122794, 5930.851728706817, 5937.940620593825, 5746.482816546531, 5853.765849366063, 5881.676507792113, 5906.2026626406605, 5928.822135335947, 5913.881722365442, 5967.8209653710455, 5980.132880732356, 5985.910211346921, 5989.610675306091, 5509.311336082989, 5689.943100568941, 5690.573207009574, 5691.658500489818, 5736.770529178786, 5738.5696072795545, 5776.277965254343, 5784.913226301693, 5792.623479473821, 5811.79658711943, 5633.295838020247, 5677.971610141923, 5681.715914204356, 5686.9715651421475, 5690.573207009574, 5609.411011843697, 5614.522765564972, 5636.661800291996, 5666.801661941812, 5680.971595141998, 5558.249636299048, 5567.192757050286, 5582.665040097607, 5599.80400685974, 5606.747696353592, 5641.971790141023, 5643.604947653625, 5645.125005624135, 5682.744276507485, 5698.373178950395, 5454.509094181542, 5454.91817622728, 5518.586106041983, 5578.079616863172, 5594.916076258941], "value": 5268.568538000134, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.7186022569393, 650.4406210658833, 657.7862194786693, 662.6752891083369, 678.2132726037797, 36169.63830361696, 37555.43666845, 37675.62324376756, 37778.811105944435, 37874.81062594687, 41329.79335103328, 42450.15099698004, 42496.3625545617, 42556.78721606395, 42617.147657046844, 8568.057513673506, 8765.342599305046, 8783.604737786814, 8786.6924657637, 8789.912100879006, 8693.652253909837, 8746.781330466725, 8813.074627164151, 8814.823703525957, 8844.248238899701, 8791.912080879205, 8879.556022198896, 8892.911070889306, 8909.06454822244, 8928.508932008737, 8773.385862989593, 8863.867041994376, 8872.645094196225, 8877.778055548632, 8892.777680557972, 8721.651133954634, 8776.297896168291, 8806.603702833389, 8850.291976641918, 8851.247643950272, 33404.331913361595, 39208.21583568341, 39544.60455395438, 39806.20387592261, 39827.20345593101, 3423.3324501722172, 3579.624139465345, 3753.568339640949, 4010.966945467704, 4217.852375166885, 28065.0, 28114.859425702944, 28299.292517687223, 28448.146555603365, 29355.559666604804, 4137.234611596864, 4180.665546756282, 4193.643540299047, 4206.915861682749, 4223.239816832969, 194903.0, 196904.0, 196939.0, 198819.0, 247458.0, 35228.647713522536, 35675.10812229715, 35684.0, 35723.82138089293, 36303.4554481683, 35573.82213088918, 35602.28795424077, 35616.28767424637, 35657.0, 36053.45919811205, 15267.465638702592, 15445.536633901002, 15474.0, 15505.457308994131, 15528.456504022304, 12198.329091899854, 12230.816537751942, 12247.448864801105, 12273.140880138304, 12310.630681079581, 8565.186307300797, 8712.910886139232, 8779.078196789245, 8792.208701216921, 8812.250958668585, 3293.75296852737, 3380.273241253093, 3397.5073614325784, 3409.761316707856, 3411.334789716031, 1069.486854844722, 1100.944952752359, 1146.4840821630132, 1231.2181764579557, 1240.5347994502063, 32317.0, 32470.35059298801, 32712.836435818146, 33074.503882441786, 33144.17139571482, 1124.8087825069758, 1189.3458597771191, 1253.8307328510534, 1261.2306493039239, 1280.9103362764517, 16692.582685432717, 17487.0, 17566.10085491265, 17677.469675909742, 17731.758776885494, 514462.0, 520665.0, 521338.0, 522161.0, 526123.0, 58864.70567647134, 59762.10356844651, 60529.69735151296, 60597.0, 60797.39202608006, 1388.9166650001032, 1443.458702986401, 1451.1873350923518, 1463.6926245488353, 1565.8199307079603, 31433.0, 31483.212919676276, 31720.524192136676, 32182.19544511406, 32753.0, 51212.231816522035, 55415.72292138675, 57398.0, 57411.71294143503, 57586.7120664394, 406074.0, 415448.0, 415501.0, 418439.0, 419905.0, 44444.333334999355, 44921.32618010798, 45313.09373812439, 45370.319445207686, 46553.53446465492, 50216.0, 50299.74850125872, 50402.0, 51185.48814511807, 51779.741101294254, 41283.587164127974, 41407.171856563305, 42623.0, 43559.78220108879, 43839.34240986324, 42412.36381454342, 43107.13785724205, 43254.56745432506, 43929.34105988477, 44133.77933110314, 38323.42514862335, 43792.562074378846, 44572.0, 44811.10377792361, 46900.7654961723, 35232.823835880656, 35383.115422113624, 35846.28307433889, 35928.0, 36130.45804312885, 28163.295917601405, 28223.57664635073, 28703.0, 28892.0, 29049.12852614425], "value": 18789.684107779587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2821237136041, 401.80713257636313, 402.73017078557365, 403.68915934730256, 406.3843277434687, 14098.506552270646, 14540.927295363535, 17216.483505494838, 17828.55428614287, 17841.0, 15014.249287535635, 15705.0, 15722.213889305545, 15961.840381596181, 17700.0, 5473.781048758055, 5594.300712410949, 5613.775448982035, 5624.240727501796, 5662.405447428023, 4862.2220444728855, 5588.86027849303, 5630.7184640768, 5635.267415236034, 5645.15322701594, 5521.254630624854, 5550.0, 5575.581831362664, 5586.776528938837, 5695.686737229451, 5554.638948468337, 5721.4564616361795, 5753.482186603226, 5764.82705518833, 5777.104548794943, 4938.432080310774, 5024.824131155392, 5099.286099946011, 5105.438401775802, 5138.897222055575, 21524.784752152435, 22045.889770551206, 22343.0, 22389.432739708227, 22654.320370388916, 2379.060271192869, 2429.4047958250167, 2474.9133780317784, 2632.6182703507884, 2819.5863941232883, 13967.930160349235, 14290.714185716228, 14412.783808242884, 14526.346314415876, 14543.27283635814, 1943.0673276827201, 2011.6177926193977, 2028.0974966140075, 2044.5910817836493, 2050.1901748809137, 76080.0, 77183.61408192923, 77331.22668773352, 77930.83103753506, 77997.61001195015, 9974.251931105051, 10019.198464122852, 10444.42555659446, 10483.947580262049, 10567.207459440573, 14610.634734131732, 14685.55943321702, 14720.926395367955, 14781.187034713193, 14802.925985370004, 8179.918200817916, 8274.586270686563, 8361.540115293596, 8420.536870472182, 8459.23866851974, 7975.680972761141, 8017.278444939983, 8078.515289082674, 8115.1479094694205, 8265.876011859827, 6279.905801412982, 6328.6835658216905, 6369.108324834527, 6388.520860935449, 6392.0, 1880.7555017847592, 1890.2439024390353, 1897.8956157411476, 1906.6282074995243, 1950.0834607734341, 967.9370840895319, 1025.195221750922, 1071.9035286824223, 1081.3403823667556, 1184.7215904262491, 18607.720884186747, 18960.715589266172, 19042.238310467703, 19135.80864191368, 19232.903835480734, 1011.9526290289515, 1025.266934142092, 1079.8164312066967, 1103.834424836281, 1151.7581307925261, 10596.629117980989, 11054.668359949053, 11104.222704410613, 11237.83143252852, 11244.943775281236, 493463.0, 502579.0, 505510.0, 532606.0, 553773.0, 74449.6277518609, 76498.0, 76525.0, 77473.22526774772, 77608.61195694098, 1025.8922813104666, 1072.1690689715376, 1086.2504871638703, 1086.8587083679072, 1088.031651829872, 17375.47873563795, 17441.215145318238, 17507.216844965107, 17549.824501754818, 17619.295228190727, 36953.44569831401, 37789.0, 38292.234155317296, 39066.60933390629, 39441.40837887491, 53163.20255196098, 55061.449385505635, 55746.0, 55776.0, 55852.0, 8229.683250679862, 8406.789830254293, 8413.915860841313, 8453.450525715809, 8686.435381700168, 12467.625971220878, 13072.803907941197, 13119.868801312246, 13247.536336228186, 13427.395767190304, 11576.652700419001, 11593.768124637292, 11798.174127810971, 12017.63947081589, 12182.695432614255, 11096.722581935515, 11460.312381257152, 11486.908743669339, 11505.597304094317, 11577.768444631229, 11236.83144752813, 11382.0, 11699.532018719156, 12093.213941093802, 12160.45277962476, 8332.875006875023, 8468.322534197127, 8485.95757021211, 8520.786980325542, 8619.1811777881, 10604.257701961098, 12019.338936358234, 12081.939590301992, 12104.515819367127, 12141.575044873387], "value": 9219.86645219884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.5807402964183, 1543.845615438456, 1720.432257355073, 1775.1834156288107, 1821.3807305516123, 7214.35070843624, 7665.310122089011, 7695.576743279117, 7904.881426778596, 7931.246531579505, 7714.922850771491, 7726.343260822837, 7805.180456052118, 7809.375249980002, 7815.687372505107, 2268.7050683411176, 2295.8163346932206, 2303.1593468384085, 2303.5968705476557, 2305.5158416732506, 2249.966250506244, 2252.0, 2297.1041293895396, 2301.9309420717404, 2306.031466783955, 2254.4927391336983, 2262.7963483286503, 2282.338121944634, 2301.0680674326923, 2305.2162264829954, 2209.0501084533644, 2216.0692509146115, 2226.6882636430914, 2232.386093824195, 2234.597772400967, 2210.071769856664, 2212.424769559926, 2212.668099785029, 2213.103693004336, 2217.9889100554556, 7875.133735289113, 7882.251186137308, 7884.487508311941, 7902.130765615835, 7930.801729956797, 4708.858734237979, 4883.096627123993, 4911.582515486152, 4920.163572192736, 4924.8276310328965, 3099.3336432667083, 3206.903792886217, 3272.96727032729, 3275.050235431722, 3328.650491698361, 1153.9826902596467, 1171.912106592009, 1175.1480176871785, 1185.1052455396207, 1200.0519589524265, 10722.463876806129, 10773.084287835465, 10818.404987725671, 10855.0, 10899.673009809718, 4244.427002354704, 4381.255186618282, 4452.042810795694, 4539.6368290536675, 4553.317002449659, 8350.582470876432, 8390.160983901562, 8413.95793021031, 8422.957885210535, 8433.578321083922, 4849.806007759721, 4863.95136048635, 4872.317875497433, 4887.315775791392, 4907.68100073494, 4074.083331250445, 4598.218302888517, 4613.63090952723, 4614.515475875052, 4672.649551283599, 3529.735269854771, 3611.0972256935765, 3682.9815850920572, 3691.3540130477595, 3698.9260214795554, 1128.2609890521721, 1137.5734099712608, 1154.3997121496775, 1154.4285578638628, 1155.6128696886637, 1012.8278192707257, 1026.1585499890018, 1029.897010298964, 1034.2605037398296, 1036.300497164411, 5699.515541178963, 5758.395368486333, 5842.357340692521, 5900.586958912835, 5930.22907022093, 951.0251991708554, 977.8728765260613, 1022.5909636145601, 1027.6968294353185, 1044.7231483656838, 4030.9596904031173, 4048.8380464781667, 4072.3687828386646, 4094.0636077686877, 4095.5494895561465, 9213.170814626716, 9607.279454040974, 9884.11043006133, 9912.504374781376, 9935.254855885838, 9631.470269135265, 9721.173700235418, 9733.610655573839, 9755.65855195079, 9767.218622510181, 7356.668949897267, 7517.661705223278, 7522.548647081193, 7581.317681408589, 7661.502002369828, 5618.831435056954, 5662.915056274242, 5789.421057894346, 5864.706764661835, 5873.442023007808, 8923.821523569623, 8966.910330896608, 8982.461052336881, 9007.369484136048, 9223.400478968846, 9174.816503669756, 9280.164785169367, 9317.86023209639, 9327.906720932704, 9367.11012453843, 6260.092286618506, 6623.4038936495945, 6623.569467984566, 6715.697793599202, 6852.794416167523, 7501.0998680156545, 7562.810929726801, 7570.697172113274, 7582.0, 7635.923640763522, 6764.898526522008, 6977.33715297046, 7055.082839230867, 7149.9285007149265, 7247.818804529718, 6894.931050689429, 7006.0, 7092.361687447948, 7130.0, 7132.179799323144, 6467.708953097028, 6523.217213934168, 6554.868902622016, 6623.072769812134, 6648.202215734143, 5142.151544995184, 5160.845174644766, 5169.560587350117, 5171.379434467888, 5173.922391164211, 5067.898642027065, 5114.488551144856, 5116.846494605168, 5160.819371321985, 5182.481751824787], "value": 4372.272283508674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.876926767828, 325.69059393576094, 326.1845386533666, 339.44331296673454, 347.3885960709152, 6028.276606807184, 6055.608034826241, 6059.697015149236, 6107.480864126549, 6127.142200091991, 5962.731677074531, 5963.791267305645, 5993.700314984244, 5998.940010599904, 6006.279246490416, 4275.060191438129, 4367.344898265262, 4488.7531185784765, 4561.612262957636, 4573.611243044345, 4605.470370907355, 4613.1926912790295, 4614.607758340545, 4659.184642687533, 4663.370444989917, 4567.885802854922, 4578.542145785428, 4603.10239503297, 4606.262997920333, 4619.769011549426, 4280.850170244058, 4423.911521769579, 4453.4433195850515, 4601.815927362902, 4619.653525985547, 3774.433834924756, 3791.791451470168, 3809.2000679857265, 3811.1424929390664, 3822.7132965027454, 5749.540036797046, 5765.048766953448, 5778.768849246025, 5786.132080188006, 5806.1000544915605, 4938.604911607063, 5111.1566591512355, 5117.309163262987, 5170.819021334235, 5174.146265866128, 6094.177286066369, 6176.197094377702, 6188.783392581283, 6207.193064901579, 6223.1287619733275, 4284.67864910133, 4296.978515107405, 4302.677299202573, 4306.5262821089655, 4323.697341186118, 6192.442680158807, 6227.252729672468, 6295.779647712354, 6401.775937842153, 6625.238097618739, 4403.713758605681, 4418.403515525363, 4451.818608881625, 4463.4420697412825, 4480.551944805494, 4488.1472520221705, 4509.12072145935, 4525.52481989393, 4530.433695788027, 4530.818767249273, 5115.64190506661, 5220.843374698765, 5233.790648374099, 5238.135707608279, 5297.788088476418, 6374.649394283266, 6385.936140638627, 6397.808065758035, 6404.967975160094, 6413.326600706859, 1611.508489910565, 1623.7320842061165, 1627.3083939325738, 1631.4779270633521, 1640.3192675039725, 1047.5181416548473, 1063.994680026595, 1071.036067539221, 1107.307932542161, 1122.7305446692899, 6049.215481432988, 6064.151018857364, 6077.908831367533, 6090.634561926298, 6115.938840611626, 6465.838354041092, 6490.643014634241, 6510.837229069311, 6518.511111666644, 6525.575837570543, 5951.702414879239, 6176.135341052256, 6201.875962480725, 6212.161358216673, 6218.409251121137, 3475.6003059648465, 3511.2977404519197, 3514.121469632592, 3514.8594056237466, 3519.9120021999656, 6455.7740479083, 6786.762463313859, 6839.1451068616425, 6847.863042739117, 6854.554453960476, 6675.399214070757, 6692.83267918306, 6712.463002959849, 6712.630805305657, 6739.090222819955, 6551.21385433751, 6790.49071319653, 6807.21717002551, 6816.352446517573, 6864.2106157791495, 6494.0, 6508.9349106508325, 6540.444062254762, 6544.149260596092, 6606.339366063356, 6152.477039451696, 6331.556791024584, 6459.192600924885, 6481.416672499309, 6488.70800813974, 6681.231658359156, 6797.150356205474, 6824.692888819915, 6827.419669328163, 6858.828529286808, 4233.3861590068655, 4243.42713733642, 4244.7877606118955, 4271.124419494058, 4318.395424640616, 6373.362663733589, 6599.5050371223315, 6612.603243805387, 6612.636305003271, 6619.371159739817, 6400.519961003037, 6407.8718425630295, 6426.42162205385, 6442.549021568632, 6446.226452825691, 6115.235595550556, 6400.167978162809, 6401.583897046677, 6417.0, 6427.678616069272, 6197.411245931629, 6292.539103492969, 6314.747410103728, 6337.6197428154455, 6360.0, 6198.442140207223, 6377.4579160771855, 6443.291237963914, 6455.806325810233, 6480.740770369321, 6297.370262973666, 6298.338674439118, 6309.2744334400295, 6316.62100273985, 6327.462165715966], "value": 4759.727173873228, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.8872902158208, 859.8194379180376, 865.1348651348651, 866.6533386645341, 875.6628697951287, 14533.636659083528, 14854.628634284149, 14888.25558722065, 14891.925540372311, 15040.774388384169, 12439.813402798942, 14068.296585170752, 14068.437262509513, 14073.929630351833, 14114.29428528572, 805.2913436176171, 823.0, 827.6192951242435, 830.5224495914842, 833.791552111972, 816.5508970066439, 822.0628483528782, 826.0747962282252, 831.8086840026798, 832.7043899415711, 877.692807517367, 879.5953861223845, 881.066069965835, 883.4875772052194, 884.2086332732201, 863.8142799298149, 870.1429092344036, 873.3013589128672, 877.8595424732013, 879.463527248378, 643.4144928115393, 643.7135474713755, 645.1129696667083, 647.1489990662265, 647.9578827376253, 14135.858641413557, 14222.715545689132, 14229.14625122496, 14247.857521424758, 14282.07166534172, 13765.0, 13765.862341376558, 13768.0, 13856.722865542733, 13874.098183618033, 10943.288686235448, 11099.778004439946, 11455.484503197376, 11465.025472834819, 12107.636770896886, 3715.9071023224365, 3748.6879592142805, 3762.435634654796, 3770.076331298822, 3799.202167544819, 49626.0, 52475.21287180695, 52826.207606885924, 53010.0, 55621.443785562034, 10210.540525676362, 10341.534630941625, 10567.260291779656, 10723.624673136403, 10969.561217551369, 17625.57939658303, 17747.645047098984, 17799.19903604341, 17863.73204401935, 18491.260349585868, 7874.251946065229, 7951.721689740832, 7996.480228785111, 8057.959710201529, 8156.388270879707, 4641.280601506772, 4645.86062418128, 4696.8590942271785, 4703.365045718852, 4786.258129989787, 2936.0751363320487, 3006.053093275611, 3016.3213277012937, 3017.5171972484295, 3032.5602787596117, 595.1519085303426, 607.441154138194, 613.7207570555387, 614.3058344071171, 619.9039148931832, 627.1502114634695, 634.5336177909234, 724.3734169942961, 725.2783480436999, 735.6432130416744, 8781.341399394943, 9005.14451127155, 9227.953860230657, 9427.811443771086, 9479.47862867549, 600.6066026752484, 678.0947435174098, 691.6610860678231, 703.4513079797766, 752.5747952406873, 4355.063661312833, 4381.7151885128005, 4439.511653718088, 4513.074819661962, 4525.04973955473, 58746.0, 59758.103628445606, 59789.402105978384, 59876.0, 60506.0, 52070.0, 53099.20351194735, 53169.0, 54035.72982135143, 54212.76553196433, 47541.762291189014, 47995.0, 48565.08609483442, 48694.26958595624, 49942.50057499451, 8438.367122465717, 8505.0, 8511.104035660202, 8677.522736249566, 8736.475811451333, 32282.35435291328, 33350.332993339514, 33729.325413491104, 33951.0, 34292.48561271533, 39831.0, 39998.20003599853, 40794.79602601968, 42288.0, 46240.768796155804, 11793.29240245588, 11916.76166476683, 12008.699782505508, 12057.15599907998, 12122.75754484923, 13402.731945360843, 13477.865221347662, 13522.594322170351, 13795.379207935466, 14578.635534111732, 12555.0, 12556.372181391076, 12730.0, 12828.55100071493, 13524.661883452993, 11685.182037257311, 11690.532378704756, 11909.344986025506, 11982.880171198176, 12424.130310878152, 12891.613251602466, 13064.608061758163, 13073.084884058024, 13106.148100373444, 13177.934110329386, 9847.950760246153, 9876.654317098866, 10074.597016119273, 10108.444035578113, 10437.11284540792, 10432.374057556572, 10880.009578878711, 10927.0, 10942.288751231144, 10959.506822192861], "value": 6662.006542648009, "unit": "score"}], "name": "dromaeo_css", "value": 7085.632398660662, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 112.0, 111.0, 124.0, 111.0, 113.0, 112.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 127.0, 159.0, 184.0, 135.0, 152.0, 176.0, 127.0, 188.0, 126.0], "value": 153.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 161.0, 162.0, 164.0, 175.0, 163.0, 166.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 76.0, 146.0, 78.0, 77.0, 79.0, 78.0, 175.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 151.0, 93.0, 92.0, 93.0, 155.0, 94.0, 92.0, 137.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 57.0, 59.0, 56.0, 57.0, 57.0, 74.0, 54.0, 54.0], "value": 59.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 84.0, 79.0, 77.0, 78.0, 77.0, 79.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 133.0, 125.0, 135.0, 132.0, 129.0, 129.0, 159.0, 129.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 164.0, 163.0, 175.0, 164.0, 166.0, 168.0, 165.0, 162.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 73.0, 71.0, 76.0, 68.0, 67.0, 69.0, 75.0, 66.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1562.3000000000002, "alertThreshold": 2.0}]} 05:29:44 INFO - Return code: 0 05:29:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:29:44 ERROR - # TBPL SUCCESS # 05:29:44 INFO - Running post-action listener: _resource_record_post_action 05:29:44 INFO - Running post-run listener: _resource_record_post_run 05:29:45 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543801344; Read time: 16; Write time: 557156 05:29:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 242233344; Read time: 0; Write time: 371144 05:29:45 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290574336; Read time: 16; Write time: 183768 05:29:45 INFO - Running post-run listener: _upload_blobber_files 05:29:45 INFO - Blob upload gear active. 05:29:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:29:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:46 INFO - (blobuploader) - INFO - Done attempting. 05:29:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:47 INFO - (blobuploader) - INFO - Done attempting. 05:29:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:47 INFO - Return code: 0 05:29:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6626bbcdac4ba3f0d9fe57563af5b58d2ced9de86e742768d1e318c26264e51a54b9a10946a65dfb42d4321c1611b551ca90d05814790d57db46ecb1dec04c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/558174fe400d7c86e2271c88a6a5e0a972a2206016b5eea7d87202f2326302fe18dcdd5436cb0094570d6235f70b45a43eff94c018eb7e3ec4cc5c0fbc1de3b5"} 05:29:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:47 INFO - Contents: 05:29:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6626bbcdac4ba3f0d9fe57563af5b58d2ced9de86e742768d1e318c26264e51a54b9a10946a65dfb42d4321c1611b551ca90d05814790d57db46ecb1dec04c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/558174fe400d7c86e2271c88a6a5e0a972a2206016b5eea7d87202f2326302fe18dcdd5436cb0094570d6235f70b45a43eff94c018eb7e3ec4cc5c0fbc1de3b5"} 05:29:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:47 INFO - Copying logs to upload dir... 05:29:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.606491 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-19 05:29:47.539602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 05:29:47.544670) ========= 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=cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6626bbcdac4ba3f0d9fe57563af5b58d2ced9de86e742768d1e318c26264e51a54b9a10946a65dfb42d4321c1611b551ca90d05814790d57db46ecb1dec04c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/558174fe400d7c86e2271c88a6a5e0a972a2206016b5eea7d87202f2326302fe18dcdd5436cb0094570d6235f70b45a43eff94c018eb7e3ec4cc5c0fbc1de3b5"} build_url:https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/dyamRau-QSO6wIBz8UJN_w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6626bbcdac4ba3f0d9fe57563af5b58d2ced9de86e742768d1e318c26264e51a54b9a10946a65dfb42d4321c1611b551ca90d05814790d57db46ecb1dec04c56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/558174fe400d7c86e2271c88a6a5e0a972a2206016b5eea7d87202f2326302fe18dcdd5436cb0094570d6235f70b45a43eff94c018eb7e3ec4cc5c0fbc1de3b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 05:29:47.572231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:29:47.572557) ========= 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=cbe409c6de289db6ac707de3000001d4-1461066397.256832-181771071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 05:29:47.657332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 05:29:47.657874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 05:29:47.660910) ========= ========= Total master_lag: 0.18 =========