builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1461939332.82 results: success (0) buildid: 20160429063004 builduid: 23f900474d4e4b66937eca49b23be124 revision: 0af3c129a3665692271cda977178286d5937e326 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:32.817319) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:32.817950) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:32.818312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:32.838343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:32.838879) ========= 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=41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 07:15:33-- 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% 45.9M=0s 2016-04-29 07:15:33 (45.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121317 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:32.976598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:32.976950) ========= 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=41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018714 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:33.030026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:33.030477) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0af3c129a3665692271cda977178286d5937e326 --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 0af3c129a3665692271cda977178286d5937e326 --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=41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 07:15:33,358 truncating revision to first 12 chars 2016-04-29 07:15:33,358 Setting DEBUG logging. 2016-04-29 07:15:33,358 attempt 1/10 2016-04-29 07:15:33,358 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0af3c129a366?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 07:15:33,596 unpacking tar archive at: fx-team-0af3c129a366/testing/mozharness/ program finished with exit code 0 elapsedTime=0.498985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:33.544898) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:33.545271) ========= script_repo_revision: 0af3c129a3665692271cda977178286d5937e326 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:33.545748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:33.546032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 07:15:33.557575) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-29 07:15:33.558136) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:33 INFO - MultiFileLogger online at 20160429 07:15:33 in /builds/slave/test 07:15:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:15:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:33 INFO - {'append_to_log': False, 07:15:33 INFO - 'base_work_dir': '/builds/slave/test', 07:15:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:15:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:33 INFO - 'branch': 'Fx-Team-Non-PGO', 07:15:33 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:33 INFO - 'config_files': ('talos/linux_config.py',), 07:15:33 INFO - 'default_actions': ('clobber', 07:15:33 INFO - 'read-buildbot-config', 07:15:33 INFO - 'download-and-extract', 07:15:33 INFO - 'populate-webroot', 07:15:33 INFO - 'create-virtualenv', 07:15:33 INFO - 'install', 07:15:33 INFO - 'run-tests'), 07:15:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:33 INFO - 'download_minidump_stackwalk': True, 07:15:33 INFO - 'download_symbols': 'ondemand', 07:15:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:33 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:33 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:33 INFO - 'installer_path': 'installer.exe', 07:15:33 INFO - 'log_level': 'info', 07:15:33 INFO - 'log_name': 'talos', 07:15:33 INFO - 'log_to_console': True, 07:15:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:33 INFO - 'opt_config_files': (), 07:15:33 INFO - 'pip_index': False, 07:15:33 INFO - 'sps_profile': False, 07:15:33 INFO - 'sps_profile_interval': 0, 07:15:33 INFO - 'suite': 'dromaeojs-e10s', 07:15:33 INFO - 'system_bits': '32', 07:15:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:33 INFO - 'title': 'talos-linux64-ix-026', 07:15:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:33 INFO - 'use_talos_json': True, 07:15:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:33 INFO - 'work_dir': 'build'} 07:15:33 INFO - ##### 07:15:33 INFO - ##### Running clobber step. 07:15:33 INFO - ##### 07:15:33 INFO - Running pre-action listener: _resource_record_pre_action 07:15:33 INFO - Running main action method: clobber 07:15:33 INFO - rmtree: /builds/slave/test/build 07:15:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:34 INFO - Running post-action listener: _resource_record_post_action 07:15:34 INFO - ##### 07:15:34 INFO - ##### Running read-buildbot-config step. 07:15:34 INFO - ##### 07:15:34 INFO - Running pre-action listener: _resource_record_pre_action 07:15:34 INFO - Running main action method: read_buildbot_config 07:15:34 INFO - Using buildbot properties: 07:15:34 INFO - { 07:15:34 INFO - "project": "", 07:15:34 INFO - "product": "firefox", 07:15:34 INFO - "script_repo_revision": "production", 07:15:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:15:34 INFO - "repository": "", 07:15:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:15:34 INFO - "buildid": "20160429063004", 07:15:34 INFO - "pgo_build": "False", 07:15:34 INFO - "basedir": "/builds/slave/test", 07:15:34 INFO - "buildnumber": 1235, 07:15:34 INFO - "slavename": "talos-linux64-ix-026", 07:15:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:15:34 INFO - "platform": "ubuntu64_hw", 07:15:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:15:34 INFO - "branch": "fx-team", 07:15:34 INFO - "repo_path": "integration/fx-team", 07:15:34 INFO - "revision": "0af3c129a3665692271cda977178286d5937e326", 07:15:34 INFO - "stage_platform": "linux64", 07:15:34 INFO - "builduid": "23f900474d4e4b66937eca49b23be124", 07:15:34 INFO - "slavebuilddir": "test" 07:15:34 INFO - } 07:15:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:15:34 INFO - Running post-action listener: _resource_record_post_action 07:15:34 INFO - ##### 07:15:34 INFO - ##### Running download-and-extract step. 07:15:34 INFO - ##### 07:15:34 INFO - Running pre-action listener: _resource_record_pre_action 07:15:34 INFO - Running main action method: download_and_extract 07:15:34 INFO - mkdir: /builds/slave/test/build/tests 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:34 INFO - https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:15:35 INFO - Downloaded 1361 bytes. 07:15:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:35 INFO - Using the following test package requirements: 07:15:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:15:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:15:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'jsshell-linux-x86_64.zip'], 07:15:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:15:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:15:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:15:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:15:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:15:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:35 INFO - https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:15:36 INFO - Downloaded 22301146 bytes. 07:15:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:15:37 INFO - Return code: 0 07:15:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:37 INFO - https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:15:38 INFO - Downloaded 22301146 bytes. 07:15:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:15:40 INFO - Return code: 0 07:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:40 INFO - https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:15:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:15:41 INFO - Downloaded 10840145 bytes. 07:15:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:15:41 INFO - Return code: 0 07:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:41 INFO - https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:15:44 INFO - Downloaded 54854343 bytes. 07:15:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:44 INFO - mkdir: /builds/slave/test/properties 07:15:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:44 INFO - Contents: 07:15:44 INFO - build_url:https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:45 INFO - Running post-action listener: _resource_record_post_action 07:15:45 INFO - Running post-action listener: set_extra_try_arguments 07:15:45 INFO - ##### 07:15:45 INFO - ##### Running populate-webroot step. 07:15:45 INFO - ##### 07:15:45 INFO - Running pre-action listener: _resource_record_pre_action 07:15:45 INFO - Running main action method: populate_webroot 07:15:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:45 INFO - '--tppagecycles', 07:15:45 INFO - '7'], 07:15:45 INFO - 'tests': ['tsvgm']}}, 07:15:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['damp', 'tps']}, 07:15:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'tests': ['damp', 'tps']}, 07:15:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['dromaeo_dom']}, 07:15:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['a11yr', 07:15:45 INFO - 'ts_paint', 07:15:45 INFO - 'tpaint', 07:15:45 INFO - 'sessionrestore', 07:15:45 INFO - 'sessionrestore_no_auto_restore', 07:15:45 INFO - 'tabpaint']}, 07:15:45 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:45 INFO - 'ts_paint', 07:15:45 INFO - 'tpaint', 07:15:45 INFO - 'sessionrestore', 07:15:45 INFO - 'sessionrestore_no_auto_restore', 07:15:45 INFO - 'tabpaint']}, 07:15:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:45 INFO - 'ts_paint', 07:15:45 INFO - 'tpaint', 07:15:45 INFO - 'sessionrestore', 07:15:45 INFO - 'sessionrestore_no_auto_restore', 07:15:45 INFO - 'tabpaint']}, 07:15:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:45 INFO - 'ts_paint', 07:15:45 INFO - 'tpaint', 07:15:45 INFO - 'sessionrestore', 07:15:45 INFO - 'sessionrestore_no_auto_restore', 07:15:45 INFO - 'tabpaint']}, 07:15:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['a11yr', 07:15:45 INFO - 'ts_paint', 07:15:45 INFO - 'tpaint', 07:15:45 INFO - 'sessionrestore', 07:15:45 INFO - 'sessionrestore_no_auto_restore', 07:15:45 INFO - 'tabpaint']}, 07:15:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['a11yr', 07:15:45 INFO - 'ts_paint', 07:15:45 INFO - 'tpaint', 07:15:45 INFO - 'sessionrestore', 07:15:45 INFO - 'sessionrestore_no_auto_restore', 07:15:45 INFO - 'tabpaint']}, 07:15:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['tsvgx', 07:15:45 INFO - 'tsvgr_opacity', 07:15:45 INFO - 'tart', 07:15:45 INFO - 'tscrollx', 07:15:45 INFO - 'cart']}, 07:15:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:45 INFO - 'tsvgr_opacity', 07:15:45 INFO - 'tart', 07:15:45 INFO - 'tscrollx', 07:15:45 INFO - 'cart']}, 07:15:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'talos_options': ['--disable-e10s'], 07:15:45 INFO - 'tests': ['tp5o']}, 07:15:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'tests': ['tp5o']}, 07:15:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'talos_options': ['--disable-e10s', 07:15:45 INFO - '--xperf_path', 07:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:45 INFO - 'tests': ['tp5n']}, 07:15:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:45 INFO - 'talos_options': ['--xperf_path', 07:15:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:45 INFO - 'tests': ['tp5n']}}, 07:15:45 INFO - 'talos.zip': {'path': '', 07:15:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:45 INFO - Running post-action listener: _resource_record_post_action 07:15:45 INFO - ##### 07:15:45 INFO - ##### Running create-virtualenv step. 07:15:45 INFO - ##### 07:15:45 INFO - Running pre-action listener: _resource_record_pre_action 07:15:45 INFO - Running main action method: create_virtualenv 07:15:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:15:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:45 INFO - Using real prefix '/usr' 07:15:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:47 INFO - Installing pip.................done. 07:15:47 INFO - Return code: 0 07:15:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:47 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:47 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 07:15:47 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 07:15:47 INFO - Using env: {'DISPLAY': ':0', 07:15:47 INFO - 'HOME': '/home/cltbld', 07:15:47 INFO - 'LANG': 'en_US.UTF-8', 07:15:47 INFO - 'LANGUAGE': 'en_US:en', 07:15:47 INFO - 'LOGNAME': 'cltbld', 07:15:47 INFO - 'MAIL': '/var/mail/cltbld', 07:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:47 INFO - 'MOZ_NO_REMOTE': '1', 07:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:47 INFO - 'NO_EM_RESTART': '1', 07:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:47 INFO - 'PWD': '/builds/slave/test', 07:15:47 INFO - 'SHELL': '/bin/bash', 07:15:47 INFO - 'SHLVL': '1', 07:15:47 INFO - 'TERM': 'linux', 07:15:47 INFO - 'TMOUT': '86400', 07:15:47 INFO - 'USER': 'cltbld', 07:15:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:47 INFO - '_': '/tools/buildbot/bin/python'} 07:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:15:47 INFO - Cleaning up... 07:15:47 INFO - Return code: 0 07:15:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:47 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:47 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 07:15:47 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 07:15:47 INFO - Using env: {'DISPLAY': ':0', 07:15:47 INFO - 'HOME': '/home/cltbld', 07:15:47 INFO - 'LANG': 'en_US.UTF-8', 07:15:47 INFO - 'LANGUAGE': 'en_US:en', 07:15:47 INFO - 'LOGNAME': 'cltbld', 07:15:47 INFO - 'MAIL': '/var/mail/cltbld', 07:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:47 INFO - 'MOZ_NO_REMOTE': '1', 07:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:47 INFO - 'NO_EM_RESTART': '1', 07:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:47 INFO - 'PWD': '/builds/slave/test', 07:15:47 INFO - 'SHELL': '/bin/bash', 07:15:47 INFO - 'SHLVL': '1', 07:15:47 INFO - 'TERM': 'linux', 07:15:47 INFO - 'TMOUT': '86400', 07:15:47 INFO - 'USER': 'cltbld', 07:15:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:47 INFO - '_': '/tools/buildbot/bin/python'} 07:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:47 INFO - Downloading/unpacking psutil>=0.7.1 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:49 INFO - Installing collected packages: psutil 07:15:49 INFO - Running setup.py install for psutil 07:15:50 INFO - building 'psutil._psutil_linux' extension 07:15:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:15:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:15:50 INFO - building 'psutil._psutil_posix' extension 07:15:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:15:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:15:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:50 INFO - Successfully installed psutil 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:50 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 07:15:50 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 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:15:52 INFO - Installing collected packages: mozsystemmonitor 07:15:52 INFO - Running setup.py install for mozsystemmonitor 07:15:52 INFO - Successfully installed mozsystemmonitor 07:15:52 INFO - Cleaning up... 07:15:53 INFO - Return code: 0 07:15:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:53 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:53 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 07:15:53 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 07:15:53 INFO - Using env: {'DISPLAY': ':0', 07:15:53 INFO - 'HOME': '/home/cltbld', 07:15:53 INFO - 'LANG': 'en_US.UTF-8', 07:15:53 INFO - 'LANGUAGE': 'en_US:en', 07:15:53 INFO - 'LOGNAME': 'cltbld', 07:15:53 INFO - 'MAIL': '/var/mail/cltbld', 07:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:53 INFO - 'MOZ_NO_REMOTE': '1', 07:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:53 INFO - 'NO_EM_RESTART': '1', 07:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:53 INFO - 'PWD': '/builds/slave/test', 07:15:53 INFO - 'SHELL': '/bin/bash', 07:15:53 INFO - 'SHLVL': '1', 07:15:53 INFO - 'TERM': 'linux', 07:15:53 INFO - 'TMOUT': '86400', 07:15:53 INFO - 'USER': 'cltbld', 07:15:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:53 INFO - '_': '/tools/buildbot/bin/python'} 07:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:55 INFO - Downloading docopt-0.6.1.tar.gz 07:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:55 INFO - Running setup.py install for blobuploader 07:15:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:55 INFO - Running setup.py install for requests 07:15:56 INFO - Running setup.py install for docopt 07:15:56 INFO - Successfully installed blobuploader requests docopt 07:15:56 INFO - Cleaning up... 07:15:56 INFO - Return code: 0 07:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:56 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:56 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 07:15:56 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 07:15:56 INFO - Using env: {'DISPLAY': ':0', 07:15:56 INFO - 'HOME': '/home/cltbld', 07:15:56 INFO - 'LANG': 'en_US.UTF-8', 07:15:56 INFO - 'LANGUAGE': 'en_US:en', 07:15:56 INFO - 'LOGNAME': 'cltbld', 07:15:56 INFO - 'MAIL': '/var/mail/cltbld', 07:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:56 INFO - 'MOZ_NO_REMOTE': '1', 07:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:56 INFO - 'NO_EM_RESTART': '1', 07:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:56 INFO - 'PWD': '/builds/slave/test', 07:15:56 INFO - 'SHELL': '/bin/bash', 07:15:56 INFO - 'SHLVL': '1', 07:15:56 INFO - 'TERM': 'linux', 07:15:56 INFO - 'TMOUT': '86400', 07:15:56 INFO - 'USER': 'cltbld', 07:15:56 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:56 INFO - '_': '/tools/buildbot/bin/python'} 07:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:56 INFO - Running setup.py (path:/tmp/pip-X8lgN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:56 INFO - Running setup.py (path:/tmp/pip-mfsclI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:56 INFO - Running setup.py (path:/tmp/pip-DElcjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:56 INFO - Running setup.py (path:/tmp/pip-WDQoyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:56 INFO - Running setup.py (path:/tmp/pip-lpga3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:57 INFO - Running setup.py (path:/tmp/pip-1PCAjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:57 INFO - Running setup.py (path:/tmp/pip-BHP0mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:57 INFO - Running setup.py (path:/tmp/pip-NiEft9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:57 INFO - Running setup.py (path:/tmp/pip-X3NReN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:57 INFO - Running setup.py (path:/tmp/pip-HtI32Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:57 INFO - Running setup.py (path:/tmp/pip-H48onT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:57 INFO - Running setup.py (path:/tmp/pip-fhitb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:57 INFO - Running setup.py (path:/tmp/pip-tfP6el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:57 INFO - Running setup.py (path:/tmp/pip-IpUFL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:57 INFO - Running setup.py (path:/tmp/pip-4gsGwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:57 INFO - Running setup.py (path:/tmp/pip-FY8QWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:57 INFO - Running setup.py (path:/tmp/pip-2L75iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:57 INFO - Running setup.py install for manifestparser 07:15:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Running setup.py install for mozcrash 07:15:58 INFO - Running setup.py install for mozdebug 07:15:58 INFO - Running setup.py install for mozdevice 07:15:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for mozfile 07:15:58 INFO - Running setup.py install for mozhttpd 07:15:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for mozinfo 07:15:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for mozInstall 07:15:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for mozleak 07:15:58 INFO - Running setup.py install for mozlog 07:15:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:58 INFO - Running setup.py install for moznetwork 07:15:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozprocess 07:15:59 INFO - Running setup.py install for mozprofile 07:15:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozrunner 07:15:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Running setup.py install for mozscreenshot 07:15:59 INFO - Running setup.py install for moztest 07:15:59 INFO - Running setup.py install for mozversion 07:15:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:59 INFO - Cleaning up... 07:15:59 INFO - Return code: 0 07:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:59 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:15:59 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 07:15:59 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 07:15:59 INFO - Using env: {'DISPLAY': ':0', 07:15:59 INFO - 'HOME': '/home/cltbld', 07:15:59 INFO - 'LANG': 'en_US.UTF-8', 07:15:59 INFO - 'LANGUAGE': 'en_US:en', 07:15:59 INFO - 'LOGNAME': 'cltbld', 07:15:59 INFO - 'MAIL': '/var/mail/cltbld', 07:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:59 INFO - 'MOZ_NO_REMOTE': '1', 07:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:59 INFO - 'NO_EM_RESTART': '1', 07:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:59 INFO - 'PWD': '/builds/slave/test', 07:15:59 INFO - 'SHELL': '/bin/bash', 07:15:59 INFO - 'SHLVL': '1', 07:15:59 INFO - 'TERM': 'linux', 07:15:59 INFO - 'TMOUT': '86400', 07:15:59 INFO - 'USER': 'cltbld', 07:15:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:59 INFO - '_': '/tools/buildbot/bin/python'} 07:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:59 INFO - Running setup.py (path:/tmp/pip-Lyomwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:59 INFO - Running setup.py (path:/tmp/pip-igntKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:00 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)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:00 INFO - Running setup.py (path:/tmp/pip-kKCNqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:00 INFO - Running setup.py (path:/tmp/pip-nzMZrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:00 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)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:00 INFO - Running setup.py (path:/tmp/pip-u4VEuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:00 INFO - Running setup.py (path:/tmp/pip-Y4Dp6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:00 INFO - Running setup.py (path:/tmp/pip-0AyJMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:00 INFO - Running setup.py (path:/tmp/pip-QAIu5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:00 INFO - Running setup.py (path:/tmp/pip-QipoBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:00 INFO - Running setup.py (path:/tmp/pip-DChfKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:00 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)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:00 INFO - Running setup.py (path:/tmp/pip-uNvDXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:00 INFO - Running setup.py (path:/tmp/pip-A2i6jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:00 INFO - Running setup.py (path:/tmp/pip-a0zNyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:00 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)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:00 INFO - Running setup.py (path:/tmp/pip-eYsVD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:00 INFO - Running setup.py (path:/tmp/pip-lIt8Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:00 INFO - Running setup.py (path:/tmp/pip-rrlI0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:01 INFO - Running setup.py (path:/tmp/pip-EnFBpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:16:01 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)) 07:16:01 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)) 07:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:16:01 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)) 07:16:01 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)) 07:16:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:02 INFO - Downloading blessings-1.6.tar.gz 07:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:03 INFO - Installing collected packages: blessings 07:16:03 INFO - Running setup.py install for blessings 07:16:03 INFO - Successfully installed blessings 07:16:03 INFO - Cleaning up... 07:16:03 INFO - Return code: 0 07:16:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:03 INFO - Reading from file tmpfile_stdout 07:16:03 INFO - Current package versions: 07:16:03 INFO - argparse == 1.2.1 07:16:03 INFO - blessings == 1.6 07:16:03 INFO - blobuploader == 1.2.4 07:16:03 INFO - docopt == 0.6.1 07:16:03 INFO - manifestparser == 1.1 07:16:03 INFO - mozInstall == 1.12 07:16:03 INFO - mozcrash == 0.17 07:16:03 INFO - mozdebug == 0.1 07:16:03 INFO - mozdevice == 0.48 07:16:03 INFO - mozfile == 1.2 07:16:03 INFO - mozhttpd == 0.7 07:16:03 INFO - mozinfo == 0.9 07:16:03 INFO - mozleak == 0.1 07:16:03 INFO - mozlog == 3.1 07:16:03 INFO - moznetwork == 0.27 07:16:03 INFO - mozprocess == 0.22 07:16:03 INFO - mozprofile == 0.28 07:16:03 INFO - mozrunner == 6.11 07:16:03 INFO - mozscreenshot == 0.1 07:16:03 INFO - mozsystemmonitor == 0.0 07:16:03 INFO - moztest == 0.7 07:16:03 INFO - mozversion == 1.4 07:16:03 INFO - psutil == 3.1.1 07:16:03 INFO - requests == 1.2.3 07:16:03 INFO - wsgiref == 0.1.2 07:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:03 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:03 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 07:16:03 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 07:16:03 INFO - Using env: {'DISPLAY': ':0', 07:16:03 INFO - 'HOME': '/home/cltbld', 07:16:03 INFO - 'LANG': 'en_US.UTF-8', 07:16:03 INFO - 'LANGUAGE': 'en_US:en', 07:16:03 INFO - 'LOGNAME': 'cltbld', 07:16:03 INFO - 'MAIL': '/var/mail/cltbld', 07:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:03 INFO - 'MOZ_NO_REMOTE': '1', 07:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:03 INFO - 'NO_EM_RESTART': '1', 07:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:03 INFO - 'PWD': '/builds/slave/test', 07:16:03 INFO - 'SHELL': '/bin/bash', 07:16:03 INFO - 'SHLVL': '1', 07:16:03 INFO - 'TERM': 'linux', 07:16:03 INFO - 'TMOUT': '86400', 07:16:03 INFO - 'USER': 'cltbld', 07:16:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:03 INFO - '_': '/tools/buildbot/bin/python'} 07:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 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)) 07:16:03 INFO - Cleaning up... 07:16:03 INFO - Return code: 0 07:16:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:03 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:03 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 07:16:03 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 07:16:03 INFO - Using env: {'DISPLAY': ':0', 07:16:03 INFO - 'HOME': '/home/cltbld', 07:16:03 INFO - 'LANG': 'en_US.UTF-8', 07:16:03 INFO - 'LANGUAGE': 'en_US:en', 07:16:03 INFO - 'LOGNAME': 'cltbld', 07:16:03 INFO - 'MAIL': '/var/mail/cltbld', 07:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:03 INFO - 'MOZ_NO_REMOTE': '1', 07:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:03 INFO - 'NO_EM_RESTART': '1', 07:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:03 INFO - 'PWD': '/builds/slave/test', 07:16:03 INFO - 'SHELL': '/bin/bash', 07:16:03 INFO - 'SHLVL': '1', 07:16:03 INFO - 'TERM': 'linux', 07:16:03 INFO - 'TMOUT': '86400', 07:16:03 INFO - 'USER': 'cltbld', 07:16:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:03 INFO - '_': '/tools/buildbot/bin/python'} 07:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:03 INFO - Downloading/unpacking jsonschema 07:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:05 INFO - Downloading/unpacking functools32 (from jsonschema) 07:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:05 INFO - warning: no files found matching '*.txt' 07:16:05 INFO - no previously-included directories found matching 'build' 07:16:05 INFO - no previously-included directories found matching 'dist' 07:16:05 INFO - no previously-included directories found matching '.git*' 07:16:05 INFO - Installing collected packages: jsonschema, functools32 07:16:06 INFO - Running setup.py install for functools32 07:16:06 INFO - warning: no files found matching '*.txt' 07:16:06 INFO - no previously-included directories found matching 'build' 07:16:06 INFO - no previously-included directories found matching 'dist' 07:16:06 INFO - no previously-included directories found matching '.git*' 07:16:06 INFO - Successfully installed jsonschema functools32 07:16:06 INFO - Cleaning up... 07:16:06 INFO - Return code: 0 07:16:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:06 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 0x7fbf15b13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, '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': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:06 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 07:16:06 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 07:16:06 INFO - Using env: {'DISPLAY': ':0', 07:16:06 INFO - 'HOME': '/home/cltbld', 07:16:06 INFO - 'LANG': 'en_US.UTF-8', 07:16:06 INFO - 'LANGUAGE': 'en_US:en', 07:16:06 INFO - 'LOGNAME': 'cltbld', 07:16:06 INFO - 'MAIL': '/var/mail/cltbld', 07:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:06 INFO - 'MOZ_NO_REMOTE': '1', 07:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:06 INFO - 'NO_EM_RESTART': '1', 07:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:06 INFO - 'PWD': '/builds/slave/test', 07:16:06 INFO - 'SHELL': '/bin/bash', 07:16:06 INFO - 'SHLVL': '1', 07:16:06 INFO - 'TERM': 'linux', 07:16:06 INFO - 'TMOUT': '86400', 07:16:06 INFO - 'USER': 'cltbld', 07:16:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:06 INFO - '_': '/tools/buildbot/bin/python'} 07:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:06 INFO - Downloading/unpacking flake8 07:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:16:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:16:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:08 INFO - no previously-included directories found matching 'docs/_build' 07:16:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:16:09 INFO - Running setup.py install for pep8 07:16:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:16:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:16:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:16:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:16:09 INFO - no previously-included directories found matching 'docs/_build' 07:16:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:16:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:16:09 INFO - Cleaning up... 07:16:09 INFO - Return code: 0 07:16:09 INFO - Running post-action listener: _resource_record_post_action 07:16:09 INFO - Running post-action listener: _start_resource_monitoring 07:16:09 INFO - Starting resource monitoring. 07:16:09 INFO - ##### 07:16:09 INFO - ##### Running install step. 07:16:09 INFO - ##### 07:16:09 INFO - Running pre-action listener: _resource_record_pre_action 07:16:09 INFO - Running main action method: install 07:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:09 INFO - Reading from file tmpfile_stdout 07:16:09 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:09 INFO - Reading from file tmpfile_stdout 07:16:09 INFO - Output received: 07:16:09 INFO - Usage: mozinstall [options] installer 07:16:09 INFO - Options: 07:16:09 INFO - -h, --help show this help message and exit 07:16:09 INFO - -d DEST, --destination=DEST 07:16:09 INFO - Directory to install application into. [default: 07:16:09 INFO - "/builds/slave/test"] 07:16:09 INFO - --app=APP Application being installed. [default: firefox] 07:16:09 INFO - mkdir: /builds/slave/test/build/application 07:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:16:25 INFO - Reading from file tmpfile_stdout 07:16:25 INFO - Output received: 07:16:25 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:25 INFO - Running post-action listener: _resource_record_post_action 07:16:25 INFO - ##### 07:16:25 INFO - ##### Running run-tests step. 07:16:25 INFO - ##### 07:16:25 INFO - Running pre-action listener: _resource_record_pre_action 07:16:25 INFO - Running main action method: run_tests 07:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:25 INFO - Python 2.7.3 07:16:25 INFO - Return code: 0 07:16:25 INFO - grabbing minidump binary from tooltool 07:16: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')]} 07:16:25 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 0x2874410>, '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 0x2875310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28757a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:16:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:16:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:25 INFO - Return code: 0 07:16:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:16:26 INFO - Return code: 0 07:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 07:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 07:16:26 INFO - Using env: {'DISPLAY': ':0', 07:16:26 INFO - 'HOME': '/home/cltbld', 07:16:26 INFO - 'LANG': 'en_US.UTF-8', 07:16:26 INFO - 'LANGUAGE': 'en_US:en', 07:16:26 INFO - 'LOGNAME': 'cltbld', 07:16:26 INFO - 'MAIL': '/var/mail/cltbld', 07:16:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:26 INFO - 'MOZ_NO_REMOTE': '1', 07:16:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:26 INFO - 'NO_EM_RESTART': '1', 07:16:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:26 INFO - 'PWD': '/builds/slave/test', 07:16:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:26 INFO - 'SHELL': '/bin/bash', 07:16:26 INFO - 'SHLVL': '1', 07:16:26 INFO - 'TERM': 'linux', 07:16:26 INFO - 'TMOUT': '86400', 07:16:26 INFO - 'USER': 'cltbld', 07:16:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043', 07:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:26 INFO - '_': '/tools/buildbot/bin/python'} 07:16:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 07:16:26 INFO - mozversion application_buildid: 20160429063004 07:16:26 INFO - mozversion application_changeset: 0af3c129a3665692271cda977178286d5937e326 07:16:26 INFO - mozversion application_display_name: Nightly 07:16:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:26 INFO - mozversion application_name: Firefox 07:16:26 INFO - mozversion application_remotingname: firefox 07:16:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:16:26 INFO - mozversion application_vendor: Mozilla 07:16:26 INFO - mozversion application_version: 49.0a1 07:16:26 INFO - mozversion platform_buildid: 20160429063004 07:16:26 INFO - mozversion platform_changeset: 0af3c129a3665692271cda977178286d5937e326 07:16:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:16:26 INFO - mozversion platform_version: 49.0a1 07:16:26 INFO - using testdate: 1461939386 07:16:26 INFO - actual date: 1461939386 07:16:26 INFO - starting webserver on 'localhost:45561' 07:16:26 INFO - SUITE-START | Running 2 tests 07:16:26 INFO - TEST-START | dromaeo_css 07:16:26 INFO - operating with platform_type : linux_ 07:16:26 INFO - Initialising browser for dromaeo_css test... 07:16:26 INFO - TEST-INFO | started process 5463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXAKF3/profile http://localhost:45561/getInfo.html) 07:16:30 INFO - PROCESS | 5463 | 07:16:30 INFO - PROCESS | 5463 | (process:5533): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:16:31 INFO - PROCESS | 5463 | __metrics Screen width/height:1600/1200 07:16:31 INFO - PROCESS | 5463 | colorDepth:24 07:16:31 INFO - PROCESS | 5463 | Browser inner width/height: 1024/697 07:16:31 INFO - PROCESS | 5463 | __metrics 07:16:31 ERROR - PROCESS | 5463 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:16:32 INFO - TEST-INFO | 5463: exit 0 07:16:32 INFO - Browser initialized. 07:16:32 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:32 INFO - TEST-INFO | started process 5584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXAKF3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:34 INFO - PROCESS | 5584 | 07:16:34 INFO - PROCESS | 5584 | (process:5643): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:16:44 INFO - PROCESS | 5584 | RSS: Main: 165928960 07:16:44 INFO - PROCESS | 5584 | 07:17:34 INFO - PROCESS | 5584 | 1461939454048 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:19:47 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:45561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45561/tests/dromaeo/cssquery-ext.html) 07:19:48 INFO - PROCESS | 5584 | RSS: Main: 166875136 07:19:48 INFO - PROCESS | 5584 | 07:22:50 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:45561/tests/dromaeo/cssquery-ext.html (next: http://localhost:45561/tests/dromaeo/cssquery-jquery.html) 07:22:51 INFO - PROCESS | 5584 | RSS: Main: 166789120 07:22:51 INFO - PROCESS | 5584 | 07:25:53 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:45561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45561/tests/dromaeo/cssquery-mootools.html) 07:25:53 INFO - PROCESS | 5584 | RSS: Main: 167976960 07:25:53 INFO - PROCESS | 5584 | 07:28:55 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:45561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45561/tests/dromaeo/cssquery-prototype.html) 07:28:56 INFO - PROCESS | 5584 | RSS: Main: 166068224 07:28:56 INFO - PROCESS | 5584 | 07:31:58 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:45561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45561/tests/dromaeo/cssquery-yui.html) 07:31:59 INFO - PROCESS | 5584 | RSS: Main: 167436288 07:31:59 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | Cycle 1(1): loaded http://localhost:45561/tests/dromaeo/cssquery-yui.html (next: http://localhost:45561/tests/dromaeo/cssquery-dojo.html) 07:35:02 INFO - PROCESS | 5584 | RSS: Main: 169156608 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | __start_tp_report 07:35:02 INFO - PROCESS | 5584 | _x_x_mozilla_page_load 07:35:02 INFO - PROCESS | 5584 | _x_x_mozilla_page_load_details 07:35:02 INFO - PROCESS | 5584 | |i|pagename|runs| 07:35:02 INFO - PROCESS | 5584 | |0;dojo.html;2602.297379707479;2680.865956702165;2711.295063283548;2715.8506282154485;2722.2513808702606;4738.407699037621;4742.122707299152;4764.833230836922;4771.284307353899;4857.319975203474;4612.377329060576;4726.125666751654;4735.455422626399;4784.97607511962;4793.496682848303;4363.6509079273665;4376.212281789277;4457.554244575549;4460.041091165399;4502.09958008398;4394.802233899466;4465.866024019285;4485.372047913278;4515.074409746011;4519.548045195487;4248.107897341562;4348.043430445297;4413.757243351614;4414;4462.576055274743;4373.190959672471;4373.212821692094;4386.956130438719;4417.447819022622;4462.44219472566;4304.354346847967;4315.503717072545;4349.803803953938;4360.6293465055505;4399.670024748125;4602.148602508513;4617.976910115462;4634.791434385461;4646.721196728174;4659.860204193879;5025.447200807908;5047.47001564834;5058.696478211283;5081.983603279359;5128.5640720538795;4922.80308787648;5099.286099946011;5115.2327150927285;5122.308488354061;5150.665206761549;4620.838270660544;4652.395188625457;4706.85879423611;4744.430668319824;4746.335513028179;5181.1969144782615;5183.196604526229;5189.4032186299055;5196.740162991835;5253.763580638881;4801.207800712913;4959.752012399365;4961.255811628284;4967.3294105296045;4981.626378021663;4926.1379258629595;5007.073691367109;5029.798808047711;5091.414487334004;5092.8472145835685;4960.553550180429;4985.052839960396;4991.425986011583;5002.849914502571;5039.722815245197;4884.65807393479;4940.728259945738;4956.157453232959;4961.925571116436;4979;4260.723053001545;4282.935755963663;4297.5702429756775;4304.91390172201;4340.327249276367;3740.308043011997;3740.7007439404783;3743.2139250757646;3761.5486141662627;3776.0937375029794;4289.206496798102;4328.9134217316105;4382;4382.320740285261;4388.890277743082;5039.244113382949;5050.6464547482055;5051.368578927634;5065.797368105234;5111.284420181178;4349.869503914824;4355.956440435619;4361.825526978885;4374.62815660666;4397.2964325707735;4407.0524837160165;4484.461864576272;4511.278195488706;4540.568645978627;4595.333676616939;4792.784324705466;4793.832215872428;4797.664163508521;4799;4820;5043.142665746906;5063.797448102182;5079.136546787129;5079.339685840817;5104.744762761773;4563.041761230046;4833.468318485035;4837.129316723023;4888.413390393033;4903.215485522299;4947.208446648519;4965.528274814032;4970.801167953386;4991.226359914219;4995.175795993766;5012.172991456368;5026.220935754964;5029.949700502948;5032.723200224023;5049.26785616091;4794.616430685606;4826.565609095198;4908.828191013297;4921.50784921505;4980.925286120783;4802.8799280018275;4817.397825271841;4831.371921650163;4836.806527738851;4837.564619184291;4742.502037286174;4749.192637251606;4792.880177995578;4895.877603059809;4951.183054795918;4941.258811178352;4943.629227807857;4944.92582611254;4950.05948869728;5005.024020316004;4740.976295118502;4807.903841923212;4859.052484765437;4860.416749989882;4881.829135980223 07:35:02 INFO - PROCESS | 5584 | |1;ext.html;569.4561693582629;598.835320286921;604.1692672575209;623.6507555768768;629.2606187729417;34106.65893341066;35147;35281.47077793835;35338.116547086305;35380;38391.61608383915;38959;39210.411843822294;39494;39536.209275814464;7630.351420129296;7822.80442988927;7834;7837.059552853666;7871.330936870344;6620.205575330967;7823.5305881647;7834.334081603042;7845.058592968823;7847.9215207847765;7819.257170568787;7881.408894332919;7900.802479938019;7926;7928.603569821515;7794.922050779476;7819.178986206452;7820.882686759704;7867.6852925882895;7877.133515313311;7615.5430674159725;7708.537487750753;7750.573718445483;7758.922410775933;7769.067711874554;35867;36468.27063458716;36473.63526364729;36498.452523212174;36536;2918.285020170072;3097.3340731742783;3110.2690867646083;3131.24850035992;3198.3123628419767;28817.423651526853;28921.56617650716;29191.270218244714;29243.56134657982;29483.557746633818;3072.2472994116583;3085.6142982127235;3136.560881476595;3207.951880721791;3233.8868139615;246760;247879;248083;248160;249259.9999999982;29874;52559.73720131375;52595.474045259056;52603.73698131561;52901.470985289656;31526;31602.683973160434;31716.04851854448;31774;31855.203619909225;12405.379731013414;12525.498980040697;12567.308798016014;12568.308743019039;12575.308358040396;10583.206259530565;10605.787884242272;10611.84082238767;10620.468976551296;10623.893761062445;8073.394495412867;8159.143289954588;8162.836743265101;8207.548584827773;8245.093039765621;3229.40256052631;3261.2662151016307;3275.6888095630875;3287.967120328766;3297.9340413191603;923.4182465047112;923.9584218710174;929.1683942871092;1006.6627679727227;1063.6117816996896;28606;28928;29082.27294317659;29159.271018224714;29544.704552954627;947.275334369208;983.6803039012207;985.827480190978;1024.3137098144261;1037.4968140451874;13756.243406612732;14052.929735351463;14139.787903181461;14262.57212283633;14327.78508322376;361617;376247;376535;377167;377520;48461.75769121132;49376.75311623419;49496.50503494919;49516.50483495191;49558;1228.9815652765217;1266.7213213093105;1272.8918041966351;1278.1564167649308;1283.0569531394417;26159.607605886307;27338.863305683346;27403.588946165426;27607;27793.861030695527;41121.79439102905;41165.58834411618;41541.584584153774;41646.37530436985;41811;313322;313612;313699;313833;315392;25279;25455.745442545336;25640;25674.662293901674;25766.87116564405;41339.89950753645;41943.7902810484;42463;42485.57514424816;42515.7874210627;36213.818930905174;36276.81861590675;36735.448968266035;36804.44793328156;36812.815935920145;31565.842170788997;32661.836690816395;32732.181695457803;33375.83312083424;36739.44890826693;28325.858370708014;31668.36663266768;31851.362972739953;32107.678923211402;32226.194345141557;29349.41301173922;29760.553591696575;29987;31044.844775775975;32571.837140814143;24496.755032449448;24588.631170532815;24713.25860224196;24764.876175619007;25174.24477265685 07:35:02 INFO - PROCESS | 5584 | |2;jquery.html;378.46258313195267;379.89742769452266;381.0910977319094;383.79466985162924;391.7668986952762;16058.919705401471;16552.83447165528;17245.3300124533;17464.563385915328;17469.737953930686;10428.165746740262;11159.27464714793;11161.776764464707;11187.552497900095;11219.270747401413;4604.470485894123;4765.499622539635;5045.621578381618;5348.465153484659;5350.892982140354;5298.417174110845;5300.946990530084;5302.6023048271345;5322.787088516455;5750.367459579443;6269.18500594922;6289.7169627366875;6297.433231009209;6297.874042519147;6322.74709011639;5395.487428694268;5584.1902924076185;5886.470217680408;6208.565400421972;6247.437730604244;5384.300040994684;5389.730513474311;5411.621186516945;5416.21464887593;5438;12326.445309961073;17536;18135.183916723647;20570.177192912266;20571.897140514353;2006.1173083843062;2026.9391918242477;2031.25859061443;2035.918563257468;2062.5018655045887;9379.484128372937;9529.428234305964;9582.568784404719;9714.077162669535;9758.414495130315;1786.7855857297207;1863.683173860447;1889.5937373464633;1925.663008973438;1937.5834195648004;69464;69789;71104.64447677729;71382.64308678423;71701.28298716998;10213;10251.897481025244;10272.743181420525;10353.63762268317;10560.102391296672;14302.213378264087;14318.355673994694;14380.280985950661;14385.712285754436;14411.207383593794;6721.175984414687;6887.829069058172;6909.516333856582;6997.545159564612;7125.75059872902;6419.518536109717;6462.709178086998;6493.70778314977;6499.09012738217;6578.868422631521;4385.3641222022625;4421.734695918255;4426.336049592587;4472.217361961643;4520.028193938253;1819.8180181981695;1920.5774729559475;1943.922243110288;1945.5427974425997;1946.9902650486656;910.7996240827008;919.8068405634891;940.3229674634252;940.9388389754644;967.0957654592978;16256.59358516023;16607.335706571845;16651.16744162787;16954.23705933236;17261.223244954006;903.8056817784208;904.737626088427;915.2037727177266;930.9348345615878;972.5915115651443;8970.102989700978;9451.905480945103;9533.380330278509;9544.570494327772;9612.423254604746;408986;414807;415369;415537;419665;85376;85822;85827;86763.56618216868;88103.11896880949;901.2699713232303;910.3718434280325;911.5761171055491;931.3852857114407;954.0697819625948;14586.781198281822;14784.408623654934;14838.18389988561;15153.318100685716;15447.768283475982;34993.475097873044;37436.43845342377;37751.433728494645;37785.62214377931;38095.238095237386;48840.511594883596;48861.51138488569;49089.754551227015;49339.753301233264;49568.75215624043;7534.39724822002;7541.886871696819;7662.961685191538;7960.402969777174;8038.236367545074;8374.748757537283;10406.47967601632;11465.140114491613;11554.711132221762;11615.36115513621;9483.14651681352;9717.222622190066;9815.901840981498;9868.259880508847;9980.500974951077;9720.513974301399;9799.559019844266;9848.556814943202;9908.455034973145;10222.080012798884;9566.234701224024;9868.358556693793;9990.950045249727;10007.399556026661;10359.896401035892;7620.32352882365;7676.846463070819;7825.3739700824935;7837.333826624573;7881;8974.41666291715;9900.950495247478;9936.20510359155;9960.053794889474;10311.112888390962 07:35:02 INFO - PROCESS | 5584 | |3;mootools.html;1439.014275221473;1445.5446534341681;1598.3766331130853;1727.2486468386246;1745.109993903109;6909.06727591775;7341.119065712115;7414.295641914009;7599.582022988733;7610.238976102387;7566.281203285679;7592.20281870404;7642.235776422355;7656.923430765704;7668.884966725504;2184.8579842310237;2229.5095079082575;2234.3520379090046;2234.4637287051155;2240.641497360423;2172.5546263016045;2201.922932697356;2241.753407125215;2243.8541494802867;2249.741279752825;2191.9123235070656;2199.472126689591;2213.9889300553473;2217.977820221793;2245.4274160089235;2152.3758110148037;2156.773538778429;2170.696102545637;2174.358564223542;2179.8801065941448;2146.3453646637768;2165.826733861303;2178.8910554472372;2179.3135162423946;2181.1711549611045;7619.276168763959;7716.189800071024;7757.806054848674;7768.728094516721;7772.611369431505;4338.761368124752;4477.77611119446;4478.955210447886;4502.977485112586;4520.276755719069;2761.7514423701764;2790;2906.1862678450066;2956.6008588840446;2961.141269031978;841.2891107014563;873.1792115411492;882.2941646682692;909.8635204719279;929.3076657889848;10659.78680426395;10669.19981001428;10680.359178449318;10693.091087257593;10745;4245;4263.083437061046;4370.300751879748;4372.475302963665;4431.246688063037;9116.544172791333;9133.77165570866;9135.451872887648;9147.131022552847;9163.03788102253;4638.141943740419;4672.57946784791;4673.112108699404;4683.250679891201;4699.318598803155;3672.485851980725;4042.919141617151;4109.2808758467145;4205.327147656421;4259.680523960716;3654.8720794772057;3698.68561172298;3760.1351689111657;3796.4115562087923;3801.106739916173;1197.6706405738491;1204.3015051270418;1210.5883999440057;1216.318861437598;1217.452146534063;745.6085555083516;877.8156587116649;889.700799842009;906.5240748607034;911.94214710935;5259.342582177228;5285.973570132125;5289.313813365248;5436.293281873332;5458.645188062763;858.3519442820631;900.657750054988;916.5005072235648;925.5557332480447;927.6984979881565;3623.4927110204594;3624.7643903146213;3683.318586061587;3707.4253490708984;3790.1093243087853;9222.953885230665;9534.809303814023;9561.474118923526;9641;9654.903450965401;9357.625694972125;9444.150026497648;9485.430874147572;9549.379290346105;9624.37441566296;7039.1553013638695;7126.572405655677;7129.60787156701;7211;7241.565506069653;4972.502749725143;5060.266261392151;5080.669756465818;5141.28022076902;5153.7165455898785;9093.22707569864;9182.862257066283;9218.861717074384;9256.398334108262;9359.532023398939;8702.825943480968;8752.64989400417;8753.25597324209;8817.16236957488;8979.10208979123;5913.319968203539;6247.531435142291;6457.160569125984;6474.708638111202;6558.573692709959;7393.593352365671;7395.445341599294;7449.627518623939;7464.104307483137;7495.17553069151;6685.231198412051;6921.688524016331;6948.513604047668;6950.304969503211;7100.751473698602;6807.149106361705;6816.454683625199;6820.283870193757;6888.242293347627;6893.241743408121;6321.367863213642;6396.10454536356;6465.77369792055;6561.245456772342;6601.207855057424;4429.82280708768;4450.866474005785;4544.431946006749;4564.475085365093;4565.452145742533;4695;4714.844863008585;4725;4811.975940120277;4845.636577256791 07:35:02 INFO - PROCESS | 5584 | |4;prototype.html;305.1471138168818;312.2568287475807;313.23570488009244;315.0548354935194;315.18996179817873;4949.6040316774615;4955.132851750947;4976.502349765031;5020.146575082235;5031.144705400082;4923.532264434882;4932.778024988876;4936.161707018461;4938.7530623468865;4970.105381031413;3688.8155592220414;3790.639889210521;3918.94121588175;3928.9017774555577;3945.960540394588;3909.921801563967;3920.020389703196;3925.9018524536973;3940.625640564142;3959.6436320731127;3913.849351272225;3931.2923673738715;3932.488776459056;3938.330483817758;3952.209558088394;3847.7306588538813;3918.981064923112;3929.4302326162833;3934.3705007198855;3953.6046395360663;3432.622411534729;3468.6357932416986;3483.146629075867;3488.686018258369;3496.3706532824335;4707.105649926503;4718.811247550128;4724.173269677827;4744.976275118637;4747.409617778048;4377.518472967971;4441.555844415565;4471.798769055368;4481.417415735966;4491.416115904912;5179.8446046618665;5186.403563590197;5201.765920533585;5209.557187639055;5213.296205012312;3761.22894806564;3775.716821238418;3785.791781452019;3802.5056742623283;3802.555029088956;5458.235846981426;5459.563234941234;5467.097928841737;5506.724663766796;5509.311336082989;3563.483294922222;3811.3330167220624;3823.5602905666206;3826.483424737625;3834.405667121601;3853.556840963269;3870.7549621219623;3880.2821478026653;3885.707432614771;3886.397608370707;4388.605025547716;4405.449318835145;4409.492908315585;4420.955790442119;4429.623482004065;5059.165237735806;5176.663516871391;5265.236540701653;5267.525922666901;5271.367435907716;1395.6720170759863;1404.9016568840289;1409.9436022558982;1410.4062409477226;1410.6473381654587;868.3183700794972;927.9164875161268;947.8436058050482;968.7093871838421;971.820213260549;4467.57037747924;4611.040307869142;4612.723236605814;4617.838375656903;4627.490975992638;5386.596005299618;5403.70279634616;5431.321084864392;5448.809291674773;5457.317835270591;4416.425864637641;4594.5864872161665;4602.815887364468;4605.539446055368;4620.699654522513;3067.4171907337536;3076.8923187652426;3098.9535156972665;3108.8601012954473;3110.8956320506345;5371.435999220103;5412.404635490093;5427.023135835588;5437.13005919051;5464.590155738336;5231.24146998683;5537.667739935617;5616.354119276254;5894;5895.705214739246;5087.8982420351385;5093.592512598983;5109.489051094861;5132.923006154911;5137.434882162959;5397.649152805055;5440.183972404171;5440.591955603267;5464.153056276284;5465;5192.714400707997;5282.762275697526;5286.664934753465;5290.365156181129;5351.839444816662;5098.439171691185;5101.591872650253;5103.974480127576;5109.310243117132;5119.74401279942;3802.144517483544;3852.2680690668685;3858.266929283427;3862.2854771867296;3862.9613703863724;5334.146231765986;5420.428075857957;5421.265195137676;5432.130859062531;5445.101558242845;5210.166373380241;5211.661242019257;5256.89486210266;5259.15853463444;5276.103062479311;5069.746512674278;5234.607404444758;5248.737563121905;5264.710440925785;5293.60297977661;5138.537531622172;5171.844844654666;5181.585473162213;5208.322918020633;5209.6874187548865;5020.196768517019;5102.923456148235;5269.367675878766;5276.39321478035;5287.867803304948;5045.8738531537;5053.924191137209;5106.080905437057;5110.4123025852505;5176.585873130216 07:35:02 INFO - PROCESS | 5584 | |5;yui.html;644.6035688051846;651.62531544362;667.2126890269482;690.226945820681;698.6576577477036;10756.408397538133;11057.06014988725;11064.225504214708;11072.501737421826;11079.169062320329;11529.654110376701;11534.423278836046;11621.767564648702;11638.185327027111;12092.576759813386;794.316887476771;803.120582961656;807.5356669914793;807.5477732469807;808.5754978636204;638.8945823939044;778.1168373895613;807.7576726981912;809.7854068671807;810.440795850861;840.2647683277132;842.7766641839918;844.543946269014;845.247729520727;848.7241646464893;838.0990435282096;841.5876220651897;841.9494830310201;842.49029337251;842.6587232170981;615.8521954730877;617.0897925559808;617.493655202734;618.653554009756;621.9782307619257;11271.323720576791;11290.548378064868;11303.434828258636;11310.886891131147;11346.092312614972;11270.267432616854;11471.885281147164;11572.768544629145;11624.883751162464;11758.118141139448;9823.410595364301;9829.508524573814;9848.50757462124;9999.75000624983;10006.19950403966;2914.140328603046;3130.7495400367916;3160.083575763026;3164.9208769780707;3242.1084201844446;42342.78828605868;44773.328400074024;44869.102617947785;45331.773341133085;45615.31577026347;8912.688055918012;8954.820903582022;8977.820443591092;9002.909970900208;9163.450192988443;16801.831981680272;16835.579110522336;16852.83147168537;16916.57708557296;16963.321467141424;6312.5581209314905;6445.935540644534;6528.477721782246;6595.043718660767;6635.137432133792;3590;3761.6990640748672;3791.9241615167543;3798.0694729791376;3816.37029890065;2655.7875369970357;2747.5329194037063;2756.4487102579565;2762.1575419497244;2762.2541913683194;491.8229437402532;496.32747626965664;499.0916531911885;502.09873277467034;505.0883155903629;482.1875140388457;493.8691246819596;552.0642510943992;604.652324913168;623.8627501949563;7651.279917990204;7732.690692372242;7749.961250193713;7789.83972937837;7923.9603801981775;513.4788189987166;514.9845504634867;577.4485366475006;604.8187523509723;615.4122812713847;3535.151563624763;3628.0567052565993;3669.3395188865725;3691.2617476504806;3718.4236443351324;52826.73586632042;53264;53586;54648.72675636596;54991.725041374535;47217.527824721314;48415.51584484181;49176;49526.50473495219;50154;44784;44997.55002449934;45065.54934450614;45213.32180017302;45691.31463028057;7891.64487598071;8013.599320034092;8074.919250807652;8135.877961830695;8307.252347288773;29927.251818703837;30014.24964375908;30030.54954175733;30200.54699179558;30930;37222.883313500635;37371.25257494889;38994.4150837732;39211.41182882316;39676.404853927794;9865.309428340235;10057.748556286151;10091.24315676342;10445.791084178425;10504.264701470824;10734.677959661223;11309.943450282695;11396.373199473777;11551.884481155417;11560.884391155982;10080.84878726805;10242.231832612733;10524.947375263075;10873.238873278795;11217.55129794799;11036.613718519813;11115.166362522681;11195.160362972647;11292.096632269562;11298.322100673986;10608.314140605193;10660.573577056832;10799.784004320027;11012.614558490415;11055.557777689124;8886.155815197546;8919.910800891908;9081.636734530544;9606.27952903521;9628.47043412619;8941.321337424828;9204.125608067223;9327.86008209891;9346.672866449642;9365.36106181402 07:35:02 INFO - PROCESS | 5584 | __end_tp_report 07:35:02 INFO - PROCESS | 5584 | __start_cc_report 07:35:02 INFO - PROCESS | 5584 | _x_x_mozilla_cycle_collect,383 07:35:02 INFO - PROCESS | 5584 | __end_cc_report 07:35:02 INFO - PROCESS | 5584 | __startTimestamp1461940502244__endTimestamp 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | ------- Summary: start ------- 07:35:02 INFO - PROCESS | 5584 | Number of tests: 6 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | [#0] dojo.html Cycles:165 Average:4671.51 Median:4797.66 stddev:473.57 (9.9%) stddev-sans-first:446.33 07:35:02 INFO - PROCESS | 5584 | Values: 2602.3 2680.9 2711.3 2715.9 2722.3 4738.4 4742.1 4764.8 4771.3 4857.3 4612.4 4726.1 4735.5 4785.0 4793.5 4363.7 4376.2 4457.6 4460.0 4502.1 4394.8 4465.9 4485.4 4515.1 4519.5 4248.1 4348.0 4413.8 4414.0 4462.6 4373.2 4373.2 4387.0 4417.4 4462.4 4304.4 4315.5 4349.8 4360.6 4399.7 4602.1 4618.0 4634.8 4646.7 4659.9 5025.4 5047.5 5058.7 5082.0 5128.6 4922.8 5099.3 5115.2 5122.3 5150.7 4620.8 4652.4 4706.9 4744.4 4746.3 5181.2 5183.2 5189.4 5196.7 5253.8 4801.2 4959.8 4961.3 4967.3 4981.6 4926.1 5007.1 5029.8 5091.4 5092.8 4960.6 4985.1 4991.4 5002.8 5039.7 4884.7 4940.7 4956.2 4961.9 4979.0 4260.7 4282.9 4297.6 4304.9 4340.3 3740.3 3740.7 3743.2 3761.5 3776.1 4289.2 4328.9 4382.0 4382.3 4388.9 5039.2 5050.6 5051.4 5065.8 5111.3 4349.9 4356.0 4361.8 4374.6 4397.3 4407.1 4484.5 4511.3 4540.6 4595.3 4792.8 4793.8 4797.7 4799.0 4820.0 5043.1 5063.8 5079.1 5079.3 5104.7 4563.0 4833.5 4837.1 4888.4 4903.2 4947.2 4965.5 4970.8 4991.2 4995.2 5012.2 5026.2 5029.9 5032.7 5049.3 4794.6 4826.6 4908.8 4921.5 4980.9 4802.9 4817.4 4831.4 4836.8 4837.6 4742.5 4749.2 4792.9 4895.9 4951.2 4941.3 4943.6 4944.9 4950.1 5005.0 4741.0 4807.9 4859.1 4860.4 4881.8 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | [#1] ext.html Cycles:180 Average:45115.98 Median:3281.83 stddev:83390.06 (2541.0%) stddev-sans-first:83556.92 07:35:02 INFO - PROCESS | 5584 | Values: 569.5 598.8 604.2 623.7 629.3 34106.7 35147.0 35281.5 35338.1 35380.0 38391.6 38959.0 39210.4 39494.0 39536.2 7630.4 7822.8 7834.0 7837.1 7871.3 6620.2 7823.5 7834.3 7845.1 7847.9 7819.3 7881.4 7900.8 7926.0 7928.6 7794.9 7819.2 7820.9 7867.7 7877.1 7615.5 7708.5 7750.6 7758.9 7769.1 35867.0 36468.3 36473.6 36498.5 36536.0 2918.3 3097.3 3110.3 3131.2 3198.3 28817.4 28921.6 29191.3 29243.6 29483.6 3072.2 3085.6 3136.6 3208.0 3233.9 246760.0 247879.0 248083.0 248160.0 249260.0 29874.0 52559.7 52595.5 52603.7 52901.5 31526.0 31602.7 31716.0 31774.0 31855.2 12405.4 12525.5 12567.3 12568.3 12575.3 10583.2 10605.8 10611.8 10620.5 10623.9 8073.4 8159.1 8162.8 8207.5 8245.1 3229.4 3261.3 3275.7 3288.0 3297.9 923.4 924.0 929.2 1006.7 1063.6 28606.0 28928.0 29082.3 29159.3 29544.7 947.3 983.7 985.8 1024.3 1037.5 13756.2 14052.9 14139.8 14262.6 14327.8 361617.0 376247.0 376535.0 377167.0 377520.0 48461.8 49376.8 49496.5 49516.5 49558.0 1229.0 1266.7 1272.9 1278.2 1283.1 26159.6 27338.9 27403.6 27607.0 27793.9 41121.8 41165.6 41541.6 41646.4 41811.0 313322.0 313612.0 313699.0 313833.0 315392.0 25279.0 25455.7 25640.0 25674.7 25766.9 41339.9 41943.8 42463.0 42485.6 42515.8 36213.8 36276.8 36735.4 36804.4 36812.8 31565.8 32661.8 32732.2 33375.8 36739.4 28325.9 31668.4 31851.4 32107.7 32226.2 29349.4 29760.6 29987.0 31044.8 32571.8 24496.8 24588.6 24713.3 24764.9 25174.2 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | [#2] jquery.html Cycles:180 Average:25000.40 Median:5349.68 stddev:68612.19 (1282.5%) stddev-sans-first:68779.76 07:35:02 INFO - PROCESS | 5584 | Values: 378.5 379.9 381.1 383.8 391.8 16058.9 16552.8 17245.3 17464.6 17469.7 10428.2 11159.3 11161.8 11187.6 11219.3 4604.5 4765.5 5045.6 5348.5 5350.9 5298.4 5300.9 5302.6 5322.8 5750.4 6269.2 6289.7 6297.4 6297.9 6322.7 5395.5 5584.2 5886.5 6208.6 6247.4 5384.3 5389.7 5411.6 5416.2 5438.0 12326.4 17536.0 18135.2 20570.2 20571.9 2006.1 2026.9 2031.3 2035.9 2062.5 9379.5 9529.4 9582.6 9714.1 9758.4 1786.8 1863.7 1889.6 1925.7 1937.6 69464.0 69789.0 71104.6 71382.6 71701.3 10213.0 10251.9 10272.7 10353.6 10560.1 14302.2 14318.4 14380.3 14385.7 14411.2 6721.2 6887.8 6909.5 6997.5 7125.8 6419.5 6462.7 6493.7 6499.1 6578.9 4385.4 4421.7 4426.3 4472.2 4520.0 1819.8 1920.6 1943.9 1945.5 1947.0 910.8 919.8 940.3 940.9 967.1 16256.6 16607.3 16651.2 16954.2 17261.2 903.8 904.7 915.2 930.9 972.6 8970.1 9451.9 9533.4 9544.6 9612.4 408986.0 414807.0 415369.0 415537.0 419665.0 85376.0 85822.0 85827.0 86763.6 88103.1 901.3 910.4 911.6 931.4 954.1 14586.8 14784.4 14838.2 15153.3 15447.8 34993.5 37436.4 37751.4 37785.6 38095.2 48840.5 48861.5 49089.8 49339.8 49568.8 7534.4 7541.9 7663.0 7960.4 8038.2 8374.7 10406.5 11465.1 11554.7 11615.4 9483.1 9717.2 9815.9 9868.3 9980.5 9720.5 9799.6 9848.6 9908.5 10222.1 9566.2 9868.4 9991.0 10007.4 10359.9 7620.3 7676.8 7825.4 7837.3 7881.0 8974.4 9901.0 9936.2 9960.1 10311.1 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | [#3] mootools.html Cycles:180 Average:5131.61 Median:5272.66 stddev:2844.28 (53.9%) stddev-sans-first:2838.72 07:35:02 INFO - PROCESS | 5584 | Values: 1439.0 1445.5 1598.4 1727.2 1745.1 6909.1 7341.1 7414.3 7599.6 7610.2 7566.3 7592.2 7642.2 7656.9 7668.9 2184.9 2229.5 2234.4 2234.5 2240.6 2172.6 2201.9 2241.8 2243.9 2249.7 2191.9 2199.5 2214.0 2218.0 2245.4 2152.4 2156.8 2170.7 2174.4 2179.9 2146.3 2165.8 2178.9 2179.3 2181.2 7619.3 7716.2 7757.8 7768.7 7772.6 4338.8 4477.8 4479.0 4503.0 4520.3 2761.8 2790.0 2906.2 2956.6 2961.1 841.3 873.2 882.3 909.9 929.3 10659.8 10669.2 10680.4 10693.1 10745.0 4245.0 4263.1 4370.3 4372.5 4431.2 9116.5 9133.8 9135.5 9147.1 9163.0 4638.1 4672.6 4673.1 4683.3 4699.3 3672.5 4042.9 4109.3 4205.3 4259.7 3654.9 3698.7 3760.1 3796.4 3801.1 1197.7 1204.3 1210.6 1216.3 1217.5 745.6 877.8 889.7 906.5 911.9 5259.3 5286.0 5289.3 5436.3 5458.6 858.4 900.7 916.5 925.6 927.7 3623.5 3624.8 3683.3 3707.4 3790.1 9223.0 9534.8 9561.5 9641.0 9654.9 9357.6 9444.2 9485.4 9549.4 9624.4 7039.2 7126.6 7129.6 7211.0 7241.6 4972.5 5060.3 5080.7 5141.3 5153.7 9093.2 9182.9 9218.9 9256.4 9359.5 8702.8 8752.6 8753.3 8817.2 8979.1 5913.3 6247.5 6457.2 6474.7 6558.6 7393.6 7395.4 7449.6 7464.1 7495.2 6685.2 6921.7 6948.5 6950.3 7100.8 6807.1 6816.5 6820.3 6888.2 6893.2 6321.4 6396.1 6465.8 6561.2 6601.2 4429.8 4450.9 4544.4 4564.5 4565.5 4695.0 4714.8 4725.0 4812.0 4845.6 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | [#4] prototype.html Cycles:180 Average:4374.20 Median:4962.62 stddev:1256.89 (25.3%) stddev-sans-first:1222.74 07:35:02 INFO - PROCESS | 5584 | Values: 305.1 312.3 313.2 315.1 315.2 4949.6 4955.1 4976.5 5020.1 5031.1 4923.5 4932.8 4936.2 4938.8 4970.1 3688.8 3790.6 3918.9 3928.9 3946.0 3909.9 3920.0 3925.9 3940.6 3959.6 3913.8 3931.3 3932.5 3938.3 3952.2 3847.7 3919.0 3929.4 3934.4 3953.6 3432.6 3468.6 3483.1 3488.7 3496.4 4707.1 4718.8 4724.2 4745.0 4747.4 4377.5 4441.6 4471.8 4481.4 4491.4 5179.8 5186.4 5201.8 5209.6 5213.3 3761.2 3775.7 3785.8 3802.5 3802.6 5458.2 5459.6 5467.1 5506.7 5509.3 3563.5 3811.3 3823.6 3826.5 3834.4 3853.6 3870.8 3880.3 3885.7 3886.4 4388.6 4405.4 4409.5 4421.0 4429.6 5059.2 5176.7 5265.2 5267.5 5271.4 1395.7 1404.9 1409.9 1410.4 1410.6 868.3 927.9 947.8 968.7 971.8 4467.6 4611.0 4612.7 4617.8 4627.5 5386.6 5403.7 5431.3 5448.8 5457.3 4416.4 4594.6 4602.8 4605.5 4620.7 3067.4 3076.9 3099.0 3108.9 3110.9 5371.4 5412.4 5427.0 5437.1 5464.6 5231.2 5537.7 5616.4 5894.0 5895.7 5087.9 5093.6 5109.5 5132.9 5137.4 5397.6 5440.2 5440.6 5464.2 5465.0 5192.7 5282.8 5286.7 5290.4 5351.8 5098.4 5101.6 5104.0 5109.3 5119.7 3802.1 3852.3 3858.3 3862.3 3863.0 5334.1 5420.4 5421.3 5432.1 5445.1 5210.2 5211.7 5256.9 5259.2 5276.1 5069.7 5234.6 5248.7 5264.7 5293.6 5138.5 5171.8 5181.6 5208.3 5209.7 5020.2 5102.9 5269.4 5276.4 5287.9 5045.9 5053.9 5106.1 5110.4 5176.6 07:35:02 INFO - PROCESS | 5584 | 07:35:02 INFO - PROCESS | 5584 | [#5] yui.html Cycles:180 Average:12690.91 Median:23849.86 stddev:14833.27 (62.2%) stddev-sans-first:14847.29 07:35:02 INFO - PROCESS | 5584 | Values: 644.6 651.6 667.2 690.2 698.7 10756.4 11057.1 11064.2 11072.5 11079.2 11529.7 11534.4 11621.8 11638.2 12092.6 794.3 803.1 807.5 807.5 808.6 638.9 778.1 807.8 809.8 810.4 840.3 842.8 844.5 845.2 848.7 838.1 841.6 841.9 842.5 842.7 615.9 617.1 617.5 618.7 622.0 11271.3 11290.5 11303.4 11310.9 11346.1 11270.3 11471.9 11572.8 11624.9 11758.1 9823.4 9829.5 9848.5 9999.8 10006.2 2914.1 3130.7 3160.1 3164.9 3242.1 42342.8 44773.3 44869.1 45331.8 45615.3 8912.7 8954.8 8977.8 9002.9 9163.5 16801.8 16835.6 16852.8 16916.6 16963.3 6312.6 6445.9 6528.5 6595.0 6635.1 3590.0 3761.7 3791.9 3798.1 3816.4 2655.8 2747.5 2756.4 2762.2 2762.3 491.8 496.3 499.1 502.1 505.1 482.2 493.9 552.1 604.7 623.9 7651.3 7732.7 7750.0 7789.8 7924.0 513.5 515.0 577.4 604.8 615.4 3535.2 3628.1 3669.3 3691.3 3718.4 52826.7 53264.0 53586.0 54648.7 54991.7 47217.5 48415.5 49176.0 49526.5 50154.0 44784.0 44997.6 45065.5 45213.3 45691.3 7891.6 8013.6 8074.9 8135.9 8307.3 29927.3 30014.2 30030.5 30200.5 30930.0 37222.9 37371.3 38994.4 39211.4 39676.4 9865.3 10057.7 10091.2 10445.8 10504.3 10734.7 11309.9 11396.4 11551.9 11560.9 10080.8 10242.2 10524.9 10873.2 11217.6 11036.6 11115.2 11195.2 11292.1 11298.3 10608.3 10660.6 10799.8 11012.6 11055.6 8886.2 8919.9 9081.6 9606.3 9628.5 8941.3 9204.1 9327.9 9346.7 9365.4 07:35:02 INFO - PROCESS | 5584 | -------- Summary: end -------- 07:35:02 INFO - PROCESS | 5584 | 07:35:03 INFO - TEST-INFO | 5584: exit 0 07:35:03 INFO - TEST-OK | dromaeo_css | took 1116504ms 07:35:03 INFO - TEST-START | kraken 07:35:03 INFO - operating with platform_type : linux_ 07:35:03 INFO - Initialising browser for kraken test... 07:35:03 INFO - TEST-INFO | started process 5860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXqskp2/profile http://localhost:45561/getInfo.html) 07:35:06 INFO - PROCESS | 5860 | 07:35:06 INFO - PROCESS | 5860 | (process:5927): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:35:07 INFO - PROCESS | 5860 | __metrics Screen width/height:1600/1200 07:35:07 INFO - PROCESS | 5860 | colorDepth:24 07:35:07 INFO - PROCESS | 5860 | Browser inner width/height: 1024/697 07:35:07 INFO - PROCESS | 5860 | __metrics 07:35:08 ERROR - PROCESS | 5860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:35:09 INFO - TEST-INFO | 5860: exit 0 07:35:09 INFO - Browser initialized. 07:35:09 INFO - Running cycle 1/1 for kraken test... 07:35:09 INFO - TEST-INFO | started process 5978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXqskp2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:11 INFO - PROCESS | 5978 | 07:35:11 INFO - PROCESS | 5978 | (process:6038): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:35:21 INFO - PROCESS | 5978 | RSS: Main: 165769216 07:35:21 INFO - PROCESS | 5978 | 07:35:23 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45561/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:24 INFO - PROCESS | 5978 | RSS: Main: 170627072 07:35:24 INFO - PROCESS | 5978 | 07:35:27 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45561/tests/kraken/driver.html?testName=audio-dft) 07:35:28 INFO - PROCESS | 5978 | RSS: Main: 173674496 07:35:28 INFO - PROCESS | 5978 | 07:35:31 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45561/tests/kraken/driver.html?testName=audio-fft) 07:35:31 INFO - PROCESS | 5978 | RSS: Main: 163729408 07:35:31 INFO - PROCESS | 5978 | 07:35:33 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45561/tests/kraken/driver.html?testName=audio-oscillator) 07:35:34 INFO - PROCESS | 5978 | RSS: Main: 165941248 07:35:34 INFO - PROCESS | 5978 | 07:35:36 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:37 INFO - PROCESS | 5978 | RSS: Main: 165744640 07:35:37 INFO - PROCESS | 5978 | 07:35:40 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45561/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:41 INFO - PROCESS | 5978 | RSS: Main: 166191104 07:35:41 INFO - PROCESS | 5978 | 07:35:44 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45561/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:45 INFO - PROCESS | 5978 | RSS: Main: 165756928 07:35:45 INFO - PROCESS | 5978 | 07:35:48 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45561/tests/kraken/driver.html?testName=json-parse-financial) 07:35:48 INFO - PROCESS | 5978 | RSS: Main: 165998592 07:35:48 INFO - PROCESS | 5978 | 07:35:50 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:51 INFO - PROCESS | 5978 | RSS: Main: 166342656 07:35:51 INFO - PROCESS | 5978 | 07:35:53 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:53 INFO - PROCESS | 5978 | RSS: Main: 166207488 07:35:53 INFO - PROCESS | 5978 | 07:35:55 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:56 INFO - PROCESS | 5978 | RSS: Main: 166461440 07:35:56 INFO - PROCESS | 5978 | 07:35:59 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:59 INFO - PROCESS | 5978 | RSS: Main: 166817792 07:35:59 INFO - PROCESS | 5978 | 07:36:02 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:03 INFO - PROCESS | 5978 | RSS: Main: 167096320 07:36:03 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | Cycle 1(1): loaded http://localhost:45561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45561/tests/kraken/driver.html?testName=ai-astar) 07:36:05 INFO - PROCESS | 5978 | RSS: Main: 168558592 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | __start_tp_report 07:36:05 INFO - PROCESS | 5978 | _x_x_mozilla_page_load 07:36:05 INFO - PROCESS | 5978 | _x_x_mozilla_page_load_details 07:36:05 INFO - PROCESS | 5978 | |i|pagename|runs| 07:36:05 INFO - PROCESS | 5978 | |0;ai-astar;116;108;112;113;115;127;112;115;115;113 07:36:05 INFO - PROCESS | 5978 | |1;audio-beat-detection;163;130;155;180;133;165;159;140;202;135 07:36:05 INFO - PROCESS | 5978 | |2;audio-dft;163;161;163;175;163;164;164;161;165;164 07:36:05 INFO - PROCESS | 5978 | |3;audio-fft;75;75;74;159;76;74;74;74;159;77 07:36:05 INFO - PROCESS | 5978 | |4;audio-oscillator;94;94;146;93;93;94;138;93;94;148 07:36:05 INFO - PROCESS | 5978 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;117;119;117 07:36:05 INFO - PROCESS | 5978 | |6;imaging-darkroom;148;147;146;146;147;147;146;147;147;149 07:36:05 INFO - PROCESS | 5978 | |7;imaging-desaturate;95;96;95;95;99;96;96;96;96;100 07:36:05 INFO - PROCESS | 5978 | |8;json-parse-financial;68;65;68;66;66;65;65;88;66;70 07:36:05 INFO - PROCESS | 5978 | |9;json-stringify-tinderbox;65;66;66;65;66;66;65;65;65;66 07:36:05 INFO - PROCESS | 5978 | |10;stanford-crypto-aes;80;78;80;82;90;81;82;89;91;81 07:36:05 INFO - PROCESS | 5978 | |11;stanford-crypto-ccm;135;134;132;137;129;132;146;132;160;135 07:36:05 INFO - PROCESS | 5978 | |12;stanford-crypto-pbkdf2;179;176;179;175;176;177;183;180;174;172 07:36:05 INFO - PROCESS | 5978 | |13;stanford-crypto-sha256-iterative;79;73;72;82;75;72;78;71;72;73 07:36:05 INFO - PROCESS | 5978 | __end_tp_report 07:36:05 INFO - PROCESS | 5978 | __start_cc_report 07:36:05 INFO - PROCESS | 5978 | _x_x_mozilla_cycle_collect,940 07:36:05 INFO - PROCESS | 5978 | __end_cc_report 07:36:05 INFO - PROCESS | 5978 | __startTimestamp1461940565582__endTimestamp 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | ------- Summary: start ------- 07:36:05 INFO - PROCESS | 5978 | Number of tests: 14 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:4.93 (4.3%) stddev-sans-first:5.20 07:36:05 INFO - PROCESS | 5978 | Values: 116.0 108.0 112.0 113.0 115.0 127.0 112.0 115.0 115.0 113.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:161.00 stddev:22.93 (14.2%) stddev-sans-first:24.19 07:36:05 INFO - PROCESS | 5978 | Values: 163.0 130.0 155.0 180.0 133.0 165.0 159.0 140.0 202.0 135.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.97 (2.4%) stddev-sans-first:4.19 07:36:05 INFO - PROCESS | 5978 | Values: 163.0 161.0 163.0 175.0 163.0 164.0 164.0 161.0 165.0 164.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#3] audio-fft Cycles:10 Average:91.70 Median:74.50 stddev:35.48 (47.6%) stddev-sans-first:37.12 07:36:05 INFO - PROCESS | 5978 | Values: 75.0 75.0 74.0 159.0 76.0 74.0 74.0 74.0 159.0 77.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:93.50 stddev:24.49 (26.2%) stddev-sans-first:25.39 07:36:05 INFO - PROCESS | 5978 | Values: 94.0 94.0 146.0 93.0 93.0 94.0 138.0 93.0 94.0 148.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:36:05 INFO - PROCESS | 5978 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 119.0 117.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 07:36:05 INFO - PROCESS | 5978 | Values: 148.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 149.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.71 (1.8%) stddev-sans-first:1.74 07:36:05 INFO - PROCESS | 5978 | Values: 95.0 96.0 95.0 95.0 99.0 96.0 96.0 96.0 96.0 100.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:67.00 stddev:6.98 (10.4%) stddev-sans-first:7.40 07:36:05 INFO - PROCESS | 5978 | Values: 68.0 65.0 68.0 66.0 66.0 65.0 65.0 88.0 66.0 70.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 07:36:05 INFO - PROCESS | 5978 | Values: 65.0 66.0 66.0 65.0 66.0 66.0 65.0 65.0 65.0 66.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.00 stddev:4.72 (5.8%) stddev-sans-first:4.84 07:36:05 INFO - PROCESS | 5978 | Values: 80.0 78.0 80.0 82.0 90.0 81.0 82.0 89.0 91.0 81.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:135.00 stddev:9.22 (6.8%) stddev-sans-first:9.75 07:36:05 INFO - PROCESS | 5978 | Values: 135.0 134.0 132.0 137.0 129.0 132.0 146.0 132.0 160.0 135.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:178.00 stddev:3.21 (1.8%) stddev-sans-first:3.33 07:36:05 INFO - PROCESS | 5978 | Values: 179.0 176.0 179.0 175.0 176.0 177.0 183.0 180.0 174.0 172.0 07:36:05 INFO - PROCESS | 5978 | 07:36:05 INFO - PROCESS | 5978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:74.00 stddev:3.71 (5.0%) stddev-sans-first:3.60 07:36:05 INFO - PROCESS | 5978 | Values: 79.0 73.0 72.0 82.0 75.0 72.0 78.0 71.0 72.0 73.0 07:36:05 INFO - PROCESS | 5978 | -------- Summary: end -------- 07:36:05 INFO - PROCESS | 5978 | 07:36:06 INFO - TEST-INFO | 5978: exit 0 07:36:06 INFO - TEST-OK | kraken | took 63503ms 07:36:06 INFO - SUITE-END | took 1180s 07:36:06 INFO - Completed test suite (00:19:40) 07:36:06 INFO - javascript benchmark 07:36:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.297379707479, 2680.865956702165, 2711.295063283548, 2715.8506282154485, 2722.2513808702606, 4738.407699037621, 4742.122707299152, 4764.833230836922, 4771.284307353899, 4857.319975203474, 4612.377329060576, 4726.125666751654, 4735.455422626399, 4784.97607511962, 4793.496682848303, 4363.6509079273665, 4376.212281789277, 4457.554244575549, 4460.041091165399, 4502.09958008398, 4394.802233899466, 4465.866024019285, 4485.372047913278, 4515.074409746011, 4519.548045195487, 4248.107897341562, 4348.043430445297, 4413.757243351614, 4414.0, 4462.576055274743, 4373.190959672471, 4373.212821692094, 4386.956130438719, 4417.447819022622, 4462.44219472566, 4304.354346847967, 4315.503717072545, 4349.803803953938, 4360.6293465055505, 4399.670024748125, 4602.148602508513, 4617.976910115462, 4634.791434385461, 4646.721196728174, 4659.860204193879, 5025.447200807908, 5047.47001564834, 5058.696478211283, 5081.983603279359, 5128.5640720538795, 4922.80308787648, 5099.286099946011, 5115.2327150927285, 5122.308488354061, 5150.665206761549, 4620.838270660544, 4652.395188625457, 4706.85879423611, 4744.430668319824, 4746.335513028179, 5181.1969144782615, 5183.196604526229, 5189.4032186299055, 5196.740162991835, 5253.763580638881, 4801.207800712913, 4959.752012399365, 4961.255811628284, 4967.3294105296045, 4981.626378021663, 4926.1379258629595, 5007.073691367109, 5029.798808047711, 5091.414487334004, 5092.8472145835685, 4960.553550180429, 4985.052839960396, 4991.425986011583, 5002.849914502571, 5039.722815245197, 4884.65807393479, 4940.728259945738, 4956.157453232959, 4961.925571116436, 4979.0, 4260.723053001545, 4282.935755963663, 4297.5702429756775, 4304.91390172201, 4340.327249276367, 3740.308043011997, 3740.7007439404783, 3743.2139250757646, 3761.5486141662627, 3776.0937375029794, 4289.206496798102, 4328.9134217316105, 4382.0, 4382.320740285261, 4388.890277743082, 5039.244113382949, 5050.6464547482055, 5051.368578927634, 5065.797368105234, 5111.284420181178, 4349.869503914824, 4355.956440435619, 4361.825526978885, 4374.62815660666, 4397.2964325707735, 4407.0524837160165, 4484.461864576272, 4511.278195488706, 4540.568645978627, 4595.333676616939, 4792.784324705466, 4793.832215872428, 4797.664163508521, 4799.0, 4820.0, 5043.142665746906, 5063.797448102182, 5079.136546787129, 5079.339685840817, 5104.744762761773, 4563.041761230046, 4833.468318485035, 4837.129316723023, 4888.413390393033, 4903.215485522299, 4947.208446648519, 4965.528274814032, 4970.801167953386, 4991.226359914219, 4995.175795993766, 5012.172991456368, 5026.220935754964, 5029.949700502948, 5032.723200224023, 5049.26785616091, 4794.616430685606, 4826.565609095198, 4908.828191013297, 4921.50784921505, 4980.925286120783, 4802.8799280018275, 4817.397825271841, 4831.371921650163, 4836.806527738851, 4837.564619184291, 4742.502037286174, 4749.192637251606, 4792.880177995578, 4895.877603059809, 4951.183054795918, 4941.258811178352, 4943.629227807857, 4944.92582611254, 4950.05948869728, 5005.024020316004, 4740.976295118502, 4807.903841923212, 4859.052484765437, 4860.416749989882, 4881.829135980223], "value": 4642.37940556745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4561693582629, 598.835320286921, 604.1692672575209, 623.6507555768768, 629.2606187729417, 34106.65893341066, 35147.0, 35281.47077793835, 35338.116547086305, 35380.0, 38391.61608383915, 38959.0, 39210.411843822294, 39494.0, 39536.209275814464, 7630.351420129296, 7822.80442988927, 7834.0, 7837.059552853666, 7871.330936870344, 6620.205575330967, 7823.5305881647, 7834.334081603042, 7845.058592968823, 7847.9215207847765, 7819.257170568787, 7881.408894332919, 7900.802479938019, 7926.0, 7928.603569821515, 7794.922050779476, 7819.178986206452, 7820.882686759704, 7867.6852925882895, 7877.133515313311, 7615.5430674159725, 7708.537487750753, 7750.573718445483, 7758.922410775933, 7769.067711874554, 35867.0, 36468.27063458716, 36473.63526364729, 36498.452523212174, 36536.0, 2918.285020170072, 3097.3340731742783, 3110.2690867646083, 3131.24850035992, 3198.3123628419767, 28817.423651526853, 28921.56617650716, 29191.270218244714, 29243.56134657982, 29483.557746633818, 3072.2472994116583, 3085.6142982127235, 3136.560881476595, 3207.951880721791, 3233.8868139615, 246760.0, 247879.0, 248083.0, 248160.0, 249259.9999999982, 29874.0, 52559.73720131375, 52595.474045259056, 52603.73698131561, 52901.470985289656, 31526.0, 31602.683973160434, 31716.04851854448, 31774.0, 31855.203619909225, 12405.379731013414, 12525.498980040697, 12567.308798016014, 12568.308743019039, 12575.308358040396, 10583.206259530565, 10605.787884242272, 10611.84082238767, 10620.468976551296, 10623.893761062445, 8073.394495412867, 8159.143289954588, 8162.836743265101, 8207.548584827773, 8245.093039765621, 3229.40256052631, 3261.2662151016307, 3275.6888095630875, 3287.967120328766, 3297.9340413191603, 923.4182465047112, 923.9584218710174, 929.1683942871092, 1006.6627679727227, 1063.6117816996896, 28606.0, 28928.0, 29082.27294317659, 29159.271018224714, 29544.704552954627, 947.275334369208, 983.6803039012207, 985.827480190978, 1024.3137098144261, 1037.4968140451874, 13756.243406612732, 14052.929735351463, 14139.787903181461, 14262.57212283633, 14327.78508322376, 361617.0, 376247.0, 376535.0, 377167.0, 377520.0, 48461.75769121132, 49376.75311623419, 49496.50503494919, 49516.50483495191, 49558.0, 1228.9815652765217, 1266.7213213093105, 1272.8918041966351, 1278.1564167649308, 1283.0569531394417, 26159.607605886307, 27338.863305683346, 27403.588946165426, 27607.0, 27793.861030695527, 41121.79439102905, 41165.58834411618, 41541.584584153774, 41646.37530436985, 41811.0, 313322.0, 313612.0, 313699.0, 313833.0, 315392.0, 25279.0, 25455.745442545336, 25640.0, 25674.662293901674, 25766.87116564405, 41339.89950753645, 41943.7902810484, 42463.0, 42485.57514424816, 42515.7874210627, 36213.818930905174, 36276.81861590675, 36735.448968266035, 36804.44793328156, 36812.815935920145, 31565.842170788997, 32661.836690816395, 32732.181695457803, 33375.83312083424, 36739.44890826693, 28325.858370708014, 31668.36663266768, 31851.362972739953, 32107.678923211402, 32226.194345141557, 29349.41301173922, 29760.553591696575, 29987.0, 31044.844775775975, 32571.837140814143, 24496.755032449448, 24588.631170532815, 24713.25860224196, 24764.876175619007, 25174.24477265685], "value": 16178.053801271371, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.46258313195267, 379.89742769452266, 381.0910977319094, 383.79466985162924, 391.7668986952762, 16058.919705401471, 16552.83447165528, 17245.3300124533, 17464.563385915328, 17469.737953930686, 10428.165746740262, 11159.27464714793, 11161.776764464707, 11187.552497900095, 11219.270747401413, 4604.470485894123, 4765.499622539635, 5045.621578381618, 5348.465153484659, 5350.892982140354, 5298.417174110845, 5300.946990530084, 5302.6023048271345, 5322.787088516455, 5750.367459579443, 6269.18500594922, 6289.7169627366875, 6297.433231009209, 6297.874042519147, 6322.74709011639, 5395.487428694268, 5584.1902924076185, 5886.470217680408, 6208.565400421972, 6247.437730604244, 5384.300040994684, 5389.730513474311, 5411.621186516945, 5416.21464887593, 5438.0, 12326.445309961073, 17536.0, 18135.183916723647, 20570.177192912266, 20571.897140514353, 2006.1173083843062, 2026.9391918242477, 2031.25859061443, 2035.918563257468, 2062.5018655045887, 9379.484128372937, 9529.428234305964, 9582.568784404719, 9714.077162669535, 9758.414495130315, 1786.7855857297207, 1863.683173860447, 1889.5937373464633, 1925.663008973438, 1937.5834195648004, 69464.0, 69789.0, 71104.64447677729, 71382.64308678423, 71701.28298716998, 10213.0, 10251.897481025244, 10272.743181420525, 10353.63762268317, 10560.102391296672, 14302.213378264087, 14318.355673994694, 14380.280985950661, 14385.712285754436, 14411.207383593794, 6721.175984414687, 6887.829069058172, 6909.516333856582, 6997.545159564612, 7125.75059872902, 6419.518536109717, 6462.709178086998, 6493.70778314977, 6499.09012738217, 6578.868422631521, 4385.3641222022625, 4421.734695918255, 4426.336049592587, 4472.217361961643, 4520.028193938253, 1819.8180181981695, 1920.5774729559475, 1943.922243110288, 1945.5427974425997, 1946.9902650486656, 910.7996240827008, 919.8068405634891, 940.3229674634252, 940.9388389754644, 967.0957654592978, 16256.59358516023, 16607.335706571845, 16651.16744162787, 16954.23705933236, 17261.223244954006, 903.8056817784208, 904.737626088427, 915.2037727177266, 930.9348345615878, 972.5915115651443, 8970.102989700978, 9451.905480945103, 9533.380330278509, 9544.570494327772, 9612.423254604746, 408986.0, 414807.0, 415369.0, 415537.0, 419665.0, 85376.0, 85822.0, 85827.0, 86763.56618216868, 88103.11896880949, 901.2699713232303, 910.3718434280325, 911.5761171055491, 931.3852857114407, 954.0697819625948, 14586.781198281822, 14784.408623654934, 14838.18389988561, 15153.318100685716, 15447.768283475982, 34993.475097873044, 37436.43845342377, 37751.433728494645, 37785.62214377931, 38095.238095237386, 48840.511594883596, 48861.51138488569, 49089.754551227015, 49339.753301233264, 49568.75215624043, 7534.39724822002, 7541.886871696819, 7662.961685191538, 7960.402969777174, 8038.236367545074, 8374.748757537283, 10406.47967601632, 11465.140114491613, 11554.711132221762, 11615.36115513621, 9483.14651681352, 9717.222622190066, 9815.901840981498, 9868.259880508847, 9980.500974951077, 9720.513974301399, 9799.559019844266, 9848.556814943202, 9908.455034973145, 10222.080012798884, 9566.234701224024, 9868.358556693793, 9990.950045249727, 10007.399556026661, 10359.896401035892, 7620.32352882365, 7676.846463070819, 7825.3739700824935, 7837.333826624573, 7881.0, 8974.41666291715, 9900.950495247478, 9936.20510359155, 9960.053794889474, 10311.112888390962], "value": 8193.946455014599, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.014275221473, 1445.5446534341681, 1598.3766331130853, 1727.2486468386246, 1745.109993903109, 6909.06727591775, 7341.119065712115, 7414.295641914009, 7599.582022988733, 7610.238976102387, 7566.281203285679, 7592.20281870404, 7642.235776422355, 7656.923430765704, 7668.884966725504, 2184.8579842310237, 2229.5095079082575, 2234.3520379090046, 2234.4637287051155, 2240.641497360423, 2172.5546263016045, 2201.922932697356, 2241.753407125215, 2243.8541494802867, 2249.741279752825, 2191.9123235070656, 2199.472126689591, 2213.9889300553473, 2217.977820221793, 2245.4274160089235, 2152.3758110148037, 2156.773538778429, 2170.696102545637, 2174.358564223542, 2179.8801065941448, 2146.3453646637768, 2165.826733861303, 2178.8910554472372, 2179.3135162423946, 2181.1711549611045, 7619.276168763959, 7716.189800071024, 7757.806054848674, 7768.728094516721, 7772.611369431505, 4338.761368124752, 4477.77611119446, 4478.955210447886, 4502.977485112586, 4520.276755719069, 2761.7514423701764, 2790.0, 2906.1862678450066, 2956.6008588840446, 2961.141269031978, 841.2891107014563, 873.1792115411492, 882.2941646682692, 909.8635204719279, 929.3076657889848, 10659.78680426395, 10669.19981001428, 10680.359178449318, 10693.091087257593, 10745.0, 4245.0, 4263.083437061046, 4370.300751879748, 4372.475302963665, 4431.246688063037, 9116.544172791333, 9133.77165570866, 9135.451872887648, 9147.131022552847, 9163.03788102253, 4638.141943740419, 4672.57946784791, 4673.112108699404, 4683.250679891201, 4699.318598803155, 3672.485851980725, 4042.919141617151, 4109.2808758467145, 4205.327147656421, 4259.680523960716, 3654.8720794772057, 3698.68561172298, 3760.1351689111657, 3796.4115562087923, 3801.106739916173, 1197.6706405738491, 1204.3015051270418, 1210.5883999440057, 1216.318861437598, 1217.452146534063, 745.6085555083516, 877.8156587116649, 889.700799842009, 906.5240748607034, 911.94214710935, 5259.342582177228, 5285.973570132125, 5289.313813365248, 5436.293281873332, 5458.645188062763, 858.3519442820631, 900.657750054988, 916.5005072235648, 925.5557332480447, 927.6984979881565, 3623.4927110204594, 3624.7643903146213, 3683.318586061587, 3707.4253490708984, 3790.1093243087853, 9222.953885230665, 9534.809303814023, 9561.474118923526, 9641.0, 9654.903450965401, 9357.625694972125, 9444.150026497648, 9485.430874147572, 9549.379290346105, 9624.37441566296, 7039.1553013638695, 7126.572405655677, 7129.60787156701, 7211.0, 7241.565506069653, 4972.502749725143, 5060.266261392151, 5080.669756465818, 5141.28022076902, 5153.7165455898785, 9093.22707569864, 9182.862257066283, 9218.861717074384, 9256.398334108262, 9359.532023398939, 8702.825943480968, 8752.64989400417, 8753.25597324209, 8817.16236957488, 8979.10208979123, 5913.319968203539, 6247.531435142291, 6457.160569125984, 6474.708638111202, 6558.573692709959, 7393.593352365671, 7395.445341599294, 7449.627518623939, 7464.104307483137, 7495.17553069151, 6685.231198412051, 6921.688524016331, 6948.513604047668, 6950.304969503211, 7100.751473698602, 6807.149106361705, 6816.454683625199, 6820.283870193757, 6888.242293347627, 6893.241743408121, 6321.367863213642, 6396.10454536356, 6465.77369792055, 6561.245456772342, 6601.207855057424, 4429.82280708768, 4450.866474005785, 4544.431946006749, 4564.475085365093, 4565.452145742533, 4695.0, 4714.844863008585, 4725.0, 4811.975940120277, 4845.636577256791], "value": 4156.874032294693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.1471138168818, 312.2568287475807, 313.23570488009244, 315.0548354935194, 315.18996179817873, 4949.6040316774615, 4955.132851750947, 4976.502349765031, 5020.146575082235, 5031.144705400082, 4923.532264434882, 4932.778024988876, 4936.161707018461, 4938.7530623468865, 4970.105381031413, 3688.8155592220414, 3790.639889210521, 3918.94121588175, 3928.9017774555577, 3945.960540394588, 3909.921801563967, 3920.020389703196, 3925.9018524536973, 3940.625640564142, 3959.6436320731127, 3913.849351272225, 3931.2923673738715, 3932.488776459056, 3938.330483817758, 3952.209558088394, 3847.7306588538813, 3918.981064923112, 3929.4302326162833, 3934.3705007198855, 3953.6046395360663, 3432.622411534729, 3468.6357932416986, 3483.146629075867, 3488.686018258369, 3496.3706532824335, 4707.105649926503, 4718.811247550128, 4724.173269677827, 4744.976275118637, 4747.409617778048, 4377.518472967971, 4441.555844415565, 4471.798769055368, 4481.417415735966, 4491.416115904912, 5179.8446046618665, 5186.403563590197, 5201.765920533585, 5209.557187639055, 5213.296205012312, 3761.22894806564, 3775.716821238418, 3785.791781452019, 3802.5056742623283, 3802.555029088956, 5458.235846981426, 5459.563234941234, 5467.097928841737, 5506.724663766796, 5509.311336082989, 3563.483294922222, 3811.3330167220624, 3823.5602905666206, 3826.483424737625, 3834.405667121601, 3853.556840963269, 3870.7549621219623, 3880.2821478026653, 3885.707432614771, 3886.397608370707, 4388.605025547716, 4405.449318835145, 4409.492908315585, 4420.955790442119, 4429.623482004065, 5059.165237735806, 5176.663516871391, 5265.236540701653, 5267.525922666901, 5271.367435907716, 1395.6720170759863, 1404.9016568840289, 1409.9436022558982, 1410.4062409477226, 1410.6473381654587, 868.3183700794972, 927.9164875161268, 947.8436058050482, 968.7093871838421, 971.820213260549, 4467.57037747924, 4611.040307869142, 4612.723236605814, 4617.838375656903, 4627.490975992638, 5386.596005299618, 5403.70279634616, 5431.321084864392, 5448.809291674773, 5457.317835270591, 4416.425864637641, 4594.5864872161665, 4602.815887364468, 4605.539446055368, 4620.699654522513, 3067.4171907337536, 3076.8923187652426, 3098.9535156972665, 3108.8601012954473, 3110.8956320506345, 5371.435999220103, 5412.404635490093, 5427.023135835588, 5437.13005919051, 5464.590155738336, 5231.24146998683, 5537.667739935617, 5616.354119276254, 5894.0, 5895.705214739246, 5087.8982420351385, 5093.592512598983, 5109.489051094861, 5132.923006154911, 5137.434882162959, 5397.649152805055, 5440.183972404171, 5440.591955603267, 5464.153056276284, 5465.0, 5192.714400707997, 5282.762275697526, 5286.664934753465, 5290.365156181129, 5351.839444816662, 5098.439171691185, 5101.591872650253, 5103.974480127576, 5109.310243117132, 5119.74401279942, 3802.144517483544, 3852.2680690668685, 3858.266929283427, 3862.2854771867296, 3862.9613703863724, 5334.146231765986, 5420.428075857957, 5421.265195137676, 5432.130859062531, 5445.101558242845, 5210.166373380241, 5211.661242019257, 5256.89486210266, 5259.15853463444, 5276.103062479311, 5069.746512674278, 5234.607404444758, 5248.737563121905, 5264.710440925785, 5293.60297977661, 5138.537531622172, 5171.844844654666, 5181.585473162213, 5208.322918020633, 5209.6874187548865, 5020.196768517019, 5102.923456148235, 5269.367675878766, 5276.39321478035, 5287.867803304948, 5045.8738531537, 5053.924191137209, 5106.080905437057, 5110.4123025852505, 5176.585873130216], "value": 3980.4968801701352, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.6035688051846, 651.62531544362, 667.2126890269482, 690.226945820681, 698.6576577477036, 10756.408397538133, 11057.06014988725, 11064.225504214708, 11072.501737421826, 11079.169062320329, 11529.654110376701, 11534.423278836046, 11621.767564648702, 11638.185327027111, 12092.576759813386, 794.316887476771, 803.120582961656, 807.5356669914793, 807.5477732469807, 808.5754978636204, 638.8945823939044, 778.1168373895613, 807.7576726981912, 809.7854068671807, 810.440795850861, 840.2647683277132, 842.7766641839918, 844.543946269014, 845.247729520727, 848.7241646464893, 838.0990435282096, 841.5876220651897, 841.9494830310201, 842.49029337251, 842.6587232170981, 615.8521954730877, 617.0897925559808, 617.493655202734, 618.653554009756, 621.9782307619257, 11271.323720576791, 11290.548378064868, 11303.434828258636, 11310.886891131147, 11346.092312614972, 11270.267432616854, 11471.885281147164, 11572.768544629145, 11624.883751162464, 11758.118141139448, 9823.410595364301, 9829.508524573814, 9848.50757462124, 9999.75000624983, 10006.19950403966, 2914.140328603046, 3130.7495400367916, 3160.083575763026, 3164.9208769780707, 3242.1084201844446, 42342.78828605868, 44773.328400074024, 44869.102617947785, 45331.773341133085, 45615.31577026347, 8912.688055918012, 8954.820903582022, 8977.820443591092, 9002.909970900208, 9163.450192988443, 16801.831981680272, 16835.579110522336, 16852.83147168537, 16916.57708557296, 16963.321467141424, 6312.5581209314905, 6445.935540644534, 6528.477721782246, 6595.043718660767, 6635.137432133792, 3590.0, 3761.6990640748672, 3791.9241615167543, 3798.0694729791376, 3816.37029890065, 2655.7875369970357, 2747.5329194037063, 2756.4487102579565, 2762.1575419497244, 2762.2541913683194, 491.8229437402532, 496.32747626965664, 499.0916531911885, 502.09873277467034, 505.0883155903629, 482.1875140388457, 493.8691246819596, 552.0642510943992, 604.652324913168, 623.8627501949563, 7651.279917990204, 7732.690692372242, 7749.961250193713, 7789.83972937837, 7923.9603801981775, 513.4788189987166, 514.9845504634867, 577.4485366475006, 604.8187523509723, 615.4122812713847, 3535.151563624763, 3628.0567052565993, 3669.3395188865725, 3691.2617476504806, 3718.4236443351324, 52826.73586632042, 53264.0, 53586.0, 54648.72675636596, 54991.725041374535, 47217.527824721314, 48415.51584484181, 49176.0, 49526.50473495219, 50154.0, 44784.0, 44997.55002449934, 45065.54934450614, 45213.32180017302, 45691.31463028057, 7891.64487598071, 8013.599320034092, 8074.919250807652, 8135.877961830695, 8307.252347288773, 29927.251818703837, 30014.24964375908, 30030.54954175733, 30200.54699179558, 30930.0, 37222.883313500635, 37371.25257494889, 38994.4150837732, 39211.41182882316, 39676.404853927794, 9865.309428340235, 10057.748556286151, 10091.24315676342, 10445.791084178425, 10504.264701470824, 10734.677959661223, 11309.943450282695, 11396.373199473777, 11551.884481155417, 11560.884391155982, 10080.84878726805, 10242.231832612733, 10524.947375263075, 10873.238873278795, 11217.55129794799, 11036.613718519813, 11115.166362522681, 11195.160362972647, 11292.096632269562, 11298.322100673986, 10608.314140605193, 10660.573577056832, 10799.784004320027, 11012.614558490415, 11055.557777689124, 8886.155815197546, 8919.910800891908, 9081.636734530544, 9606.27952903521, 9628.47043412619, 8941.321337424828, 9204.125608067223, 9327.86008209891, 9346.672866449642, 9365.36106181402], "value": 5779.526457227493, "unit": "score"}], "name": "dromaeo_css", "value": 6236.8714203951795, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 112.0, 113.0, 115.0, 127.0, 112.0, 115.0, 115.0, 113.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 155.0, 180.0, 133.0, 165.0, 159.0, 140.0, 202.0, 135.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 175.0, 163.0, 164.0, 164.0, 161.0, 165.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 159.0, 76.0, 74.0, 74.0, 74.0, 159.0, 77.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 146.0, 93.0, 93.0, 94.0, 138.0, 93.0, 94.0, 148.0], "value": 108.7, "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, 117.0, 119.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 149.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 99.0, 96.0, 96.0, 96.0, 96.0, 100.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 66.0, 66.0, 65.0, 65.0, 88.0, 66.0, 70.0], "value": 68.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 80.0, 82.0, 90.0, 81.0, 82.0, 89.0, 91.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 132.0, 137.0, 129.0, 132.0, 146.0, 132.0, 160.0, 135.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 176.0, 179.0, 175.0, 176.0, 177.0, 183.0, 180.0, 174.0, 172.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 72.0, 82.0, 75.0, 72.0, 78.0, 71.0, 72.0, 73.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1603.2, "alertThreshold": 2.0}]} 07:36:06 INFO - Return code: 0 07:36:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:36:06 ERROR - # TBPL SUCCESS # 07:36:06 INFO - Running post-action listener: _resource_record_post_action 07:36:06 INFO - Running post-run listener: _resource_record_post_run 07:36:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 2727936; Write bytes: 519974912; Read time: 1140; Write time: 398824 07:36:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234897408; Read time: 0; Write time: 222852 07:36:07 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 2727936; Write bytes: 285077504; Read time: 1140; Write time: 175972 07:36:07 INFO - Running post-run listener: _upload_blobber_files 07:36:07 INFO - Blob upload gear active. 07:36:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:07 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 07:36:07 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:36:07 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:36:08 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:36:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:10 INFO - (blobuploader) - INFO - Done attempting. 07:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:10 INFO - (blobuploader) - INFO - Done attempting. 07:36:10 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:10 INFO - Return code: 0 07:36:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48375d375a232ab458ca0750920d38cbf87846deef2e10032d2fe3bfc1f4d322109eef5cb8c142b18f96484103c8f093c0646ec6f7ee36684eb17d8901394804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e8bd64b666b040c19b050a06db16a8ae3c6ffa1e01e17a5b6472bec9d38dadf5ecca4b8ecabbbdeb4c3dd46f1e84ca9dbe5bc21cd379602967e9d9cba938215"} 07:36:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:10 INFO - Contents: 07:36:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48375d375a232ab458ca0750920d38cbf87846deef2e10032d2fe3bfc1f4d322109eef5cb8c142b18f96484103c8f093c0646ec6f7ee36684eb17d8901394804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e8bd64b666b040c19b050a06db16a8ae3c6ffa1e01e17a5b6472bec9d38dadf5ecca4b8ecabbbdeb4c3dd46f1e84ca9dbe5bc21cd379602967e9d9cba938215"} 07:36:10 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:10 INFO - Copying logs to upload dir... 07:36:10 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.082379 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-29 07:36:10.669287) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 07:36:10.673807) ========= 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=41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043 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-Non-PGO/sha512/48375d375a232ab458ca0750920d38cbf87846deef2e10032d2fe3bfc1f4d322109eef5cb8c142b18f96484103c8f093c0646ec6f7ee36684eb17d8901394804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e8bd64b666b040c19b050a06db16a8ae3c6ffa1e01e17a5b6472bec9d38dadf5ecca4b8ecabbbdeb4c3dd46f1e84ca9dbe5bc21cd379602967e9d9cba938215"} build_url:https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/FQ5Z-pGZRCygdRdQ0XhX1g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48375d375a232ab458ca0750920d38cbf87846deef2e10032d2fe3bfc1f4d322109eef5cb8c142b18f96484103c8f093c0646ec6f7ee36684eb17d8901394804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e8bd64b666b040c19b050a06db16a8ae3c6ffa1e01e17a5b6472bec9d38dadf5ecca4b8ecabbbdeb4c3dd46f1e84ca9dbe5bc21cd379602967e9d9cba938215"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 07:36:10.707299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:36:10.707887) ========= 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=41bf3e9aed84707956354da8000001c5-1461939096.55998-1897407043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 07:36:10.789220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 07:36:10.789798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 07:36:10.790338) ========= ========= Total master_lag: 0.19 =========