builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1462827984.54 results: success (0) buildid: 20160509132658 builduid: 0e37bb8e6ed34955aa0cd1079c28a349 revision: ea89f71fc38e4f4627b3e3075159cddc31aae645 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.537741) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.538164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.538453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.547382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.547654) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 14:06:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.6M=0s 2016-05-09 14:06:24 (53.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139153 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.694465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.694795) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009699 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.741456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:24.741840) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea89f71fc38e4f4627b3e3075159cddc31aae645 --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 ea89f71fc38e4f4627b3e3075159cddc31aae645 --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=8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 14:06:24,880 truncating revision to first 12 chars 2016-05-09 14:06:24,880 Setting DEBUG logging. 2016-05-09 14:06:24,880 attempt 1/10 2016-05-09 14:06:24,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea89f71fc38e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 14:06:25,180 unpacking tar archive at: fx-team-ea89f71fc38e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536858 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:25.286514) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:25.286859) ========= script_repo_revision: ea89f71fc38e4f4627b3e3075159cddc31aae645 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:25.287310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:25.287585) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 14:06:25.293397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-09 14:06:25.293672) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:06:25 INFO - MultiFileLogger online at 20160509 14:06:25 in /builds/slave/test 14:06:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:06:25 INFO - {'append_to_log': False, 14:06:25 INFO - 'base_work_dir': '/builds/slave/test', 14:06:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:06:25 INFO - 'branch': 'Fx-Team-Non-PGO', 14:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 14:06:25 INFO - 'config_files': ('talos/linux_config.py',), 14:06:25 INFO - 'default_actions': ('clobber', 14:06:25 INFO - 'read-buildbot-config', 14:06:25 INFO - 'download-and-extract', 14:06:25 INFO - 'populate-webroot', 14:06:25 INFO - 'create-virtualenv', 14:06:25 INFO - 'install', 14:06:25 INFO - 'run-tests'), 14:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:06:25 INFO - 'download_minidump_stackwalk': True, 14:06:25 INFO - 'download_symbols': 'ondemand', 14:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 14:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 14:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:06:25 INFO - 'installer_path': 'installer.exe', 14:06:25 INFO - 'log_level': 'info', 14:06:25 INFO - 'log_name': 'talos', 14:06:25 INFO - 'log_to_console': True, 14:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:06:25 INFO - 'opt_config_files': (), 14:06:25 INFO - 'pip_index': False, 14:06:25 INFO - 'sps_profile': False, 14:06:25 INFO - 'sps_profile_interval': 0, 14:06:25 INFO - 'suite': 'dromaeojs', 14:06:25 INFO - 'system_bits': '32', 14:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:06:25 INFO - 'title': 'talos-linux64-ix-001', 14:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:06:25 INFO - 'use_talos_json': True, 14:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:06:25 INFO - 'work_dir': 'build'} 14:06:25 INFO - ##### 14:06:25 INFO - ##### Running clobber step. 14:06:25 INFO - ##### 14:06:25 INFO - Running pre-action listener: _resource_record_pre_action 14:06:25 INFO - Running main action method: clobber 14:06:25 INFO - rmtree: /builds/slave/test/build 14:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:06:26 INFO - Running post-action listener: _resource_record_post_action 14:06:26 INFO - ##### 14:06:26 INFO - ##### Finished clobber step (success) 14:06:26 INFO - ##### 14:06:26 INFO - ##### 14:06:26 INFO - ##### Running read-buildbot-config step. 14:06:26 INFO - ##### 14:06:26 INFO - Running pre-action listener: _resource_record_pre_action 14:06:26 INFO - Running main action method: read_buildbot_config 14:06:26 INFO - Using buildbot properties: 14:06:26 INFO - { 14:06:26 INFO - "project": "", 14:06:26 INFO - "product": "firefox", 14:06:26 INFO - "script_repo_revision": "production", 14:06:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:06:26 INFO - "repository": "", 14:06:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:06:26 INFO - "buildid": "20160509132658", 14:06:26 INFO - "pgo_build": "False", 14:06:26 INFO - "basedir": "/builds/slave/test", 14:06:26 INFO - "buildnumber": 2939, 14:06:26 INFO - "slavename": "talos-linux64-ix-001", 14:06:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:06:26 INFO - "platform": "ubuntu64_hw", 14:06:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:06:26 INFO - "branch": "fx-team", 14:06:26 INFO - "repo_path": "integration/fx-team", 14:06:26 INFO - "revision": "ea89f71fc38e4f4627b3e3075159cddc31aae645", 14:06:26 INFO - "stage_platform": "linux64", 14:06:26 INFO - "builduid": "0e37bb8e6ed34955aa0cd1079c28a349", 14:06:26 INFO - "slavebuilddir": "test" 14:06:26 INFO - } 14:06:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:06:26 INFO - Running post-action listener: _resource_record_post_action 14:06:26 INFO - ##### 14:06:26 INFO - ##### Finished read-buildbot-config step (success) 14:06:26 INFO - ##### 14:06:26 INFO - ##### 14:06:26 INFO - ##### Running download-and-extract step. 14:06:26 INFO - ##### 14:06:26 INFO - Running pre-action listener: _resource_record_pre_action 14:06:26 INFO - Running main action method: download_and_extract 14:06:26 INFO - mkdir: /builds/slave/test/build/tests 14:06:26 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')]} 14:06:26 INFO - https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:06:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:06:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:06:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:28 INFO - Downloaded 1361 bytes. 14:06:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:06:28 INFO - Using the following test package requirements: 14:06:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:06:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:06:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'jsshell-linux-x86_64.zip'], 14:06:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:06:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:06:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:06:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:06:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:06:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:06:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:06:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:06:28 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')]} 14:06:28 INFO - https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:30 INFO - Downloaded 22322863 bytes. 14:06:30 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'] 14:06:30 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 14:06:31 INFO - Return code: 0 14:06:31 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 14:06:31 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')]} 14:06:31 INFO - https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:32 INFO - Downloaded 22322863 bytes. 14:06:32 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'] 14:06:32 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 14:06:33 INFO - Return code: 0 14:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:33 INFO - https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:34 INFO - Downloaded 10840152 bytes. 14:06:34 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'] 14:06:34 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 14:06:34 INFO - Return code: 0 14:06: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')]} 14:06:34 INFO - https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FkvqVj_bSP25osVVoVUzJQ/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 14:06:36 INFO - Downloaded 54860286 bytes. 14:06:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:06:36 INFO - mkdir: /builds/slave/test/properties 14:06:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:06:36 INFO - Writing to file /builds/slave/test/properties/build_url 14:06:36 INFO - Contents: 14:06:36 INFO - build_url:https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:06:36 INFO - Running post-action listener: _resource_record_post_action 14:06:36 INFO - Running post-action listener: set_extra_try_arguments 14:06:36 INFO - ##### 14:06:36 INFO - ##### Finished download-and-extract step (success) 14:06:36 INFO - ##### 14:06:36 INFO - ##### 14:06:36 INFO - ##### Running populate-webroot step. 14:06:36 INFO - ##### 14:06:36 INFO - Running pre-action listener: _resource_record_pre_action 14:06:36 INFO - Running main action method: populate_webroot 14:06:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:06:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:06:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:06:36 INFO - '--tppagecycles', 14:06:36 INFO - '7'], 14:06:36 INFO - 'tests': ['tsvgm']}}, 14:06:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:06:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:06:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:06:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:06:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['damp', 'tps']}, 14:06:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'tests': ['damp', 'tps']}, 14:06:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['dromaeo_dom']}, 14:06:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:06:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['a11yr', 14:06:36 INFO - 'ts_paint', 14:06:36 INFO - 'tpaint', 14:06:36 INFO - 'sessionrestore', 14:06:36 INFO - 'sessionrestore_no_auto_restore', 14:06:36 INFO - 'tabpaint']}, 14:06:36 INFO - 'other-e10s': {'tests': ['a11yr', 14:06:36 INFO - 'ts_paint', 14:06:36 INFO - 'tpaint', 14:06:36 INFO - 'sessionrestore', 14:06:36 INFO - 'sessionrestore_no_auto_restore', 14:06:36 INFO - 'tabpaint']}, 14:06:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:06:36 INFO - 'ts_paint', 14:06:36 INFO - 'tpaint', 14:06:36 INFO - 'sessionrestore', 14:06:36 INFO - 'sessionrestore_no_auto_restore', 14:06:36 INFO - 'tabpaint']}, 14:06:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:06:36 INFO - 'ts_paint', 14:06:36 INFO - 'tpaint', 14:06:36 INFO - 'sessionrestore', 14:06:36 INFO - 'sessionrestore_no_auto_restore', 14:06:36 INFO - 'tabpaint']}, 14:06:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['a11yr', 14:06:36 INFO - 'ts_paint', 14:06:36 INFO - 'tpaint', 14:06:36 INFO - 'sessionrestore', 14:06:36 INFO - 'sessionrestore_no_auto_restore', 14:06:36 INFO - 'tabpaint']}, 14:06:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['a11yr', 14:06:36 INFO - 'ts_paint', 14:06:36 INFO - 'tpaint', 14:06:36 INFO - 'sessionrestore', 14:06:36 INFO - 'sessionrestore_no_auto_restore', 14:06:36 INFO - 'tabpaint']}, 14:06:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['tsvgx', 14:06:36 INFO - 'tsvgr_opacity', 14:06:36 INFO - 'tart', 14:06:36 INFO - 'tscrollx', 14:06:36 INFO - 'cart']}, 14:06:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:06:36 INFO - 'tsvgr_opacity', 14:06:36 INFO - 'tart', 14:06:36 INFO - 'tscrollx', 14:06:36 INFO - 'cart']}, 14:06:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'talos_options': ['--disable-e10s'], 14:06:36 INFO - 'tests': ['tp5o']}, 14:06:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'tests': ['tp5o']}, 14:06:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'talos_options': ['--disable-e10s', 14:06:36 INFO - '--xperf_path', 14:06:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:36 INFO - 'tests': ['tp5n']}, 14:06:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:36 INFO - 'talos_options': ['--xperf_path', 14:06:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:36 INFO - 'tests': ['tp5n']}}, 14:06:36 INFO - 'talos.zip': {'path': '', 14:06:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:06:36 INFO - Running post-action listener: _resource_record_post_action 14:06:36 INFO - ##### 14:06:36 INFO - ##### Finished populate-webroot step (success) 14:06:36 INFO - ##### 14:06:36 INFO - ##### 14:06:36 INFO - ##### Running create-virtualenv step. 14:06:36 INFO - ##### 14:06:36 INFO - Running pre-action listener: _resource_record_pre_action 14:06:36 INFO - Running main action method: create_virtualenv 14:06:36 INFO - Creating virtualenv /builds/slave/test/build/venv 14:06:36 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 14:06:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:06:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:06:37 INFO - Using real prefix '/usr' 14:06:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:06:37 INFO - Installing distribute.............................................................................................................................................................................................done. 14:06:39 INFO - Installing pip.................done. 14:06:39 INFO - Return code: 0 14:06:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:06:39 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')]} 14:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:39 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')]} 14:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:39 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:39 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 14:06:39 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 14:06:39 INFO - Using env: {'DISPLAY': ':0', 14:06:39 INFO - 'HOME': '/home/cltbld', 14:06:39 INFO - 'LANG': 'en_US.UTF-8', 14:06:39 INFO - 'LANGUAGE': 'en_US:en', 14:06:39 INFO - 'LOGNAME': 'cltbld', 14:06:39 INFO - 'MAIL': '/var/mail/cltbld', 14:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:39 INFO - 'MOZ_NO_REMOTE': '1', 14:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:39 INFO - 'NO_EM_RESTART': '1', 14:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:39 INFO - 'PWD': '/builds/slave/test', 14:06:39 INFO - 'SHELL': '/bin/bash', 14:06:39 INFO - 'SHLVL': '1', 14:06:39 INFO - 'TERM': 'linux', 14:06:39 INFO - 'TMOUT': '86400', 14:06:39 INFO - 'USER': 'cltbld', 14:06:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:39 INFO - '_': '/tools/buildbot/bin/python'} 14:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:39 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 14:06:39 INFO - Cleaning up... 14:06:39 INFO - Return code: 0 14:06:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:06:39 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')]} 14:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:39 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')]} 14:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:39 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:39 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 14:06:39 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 14:06:39 INFO - Using env: {'DISPLAY': ':0', 14:06:39 INFO - 'HOME': '/home/cltbld', 14:06:39 INFO - 'LANG': 'en_US.UTF-8', 14:06:39 INFO - 'LANGUAGE': 'en_US:en', 14:06:39 INFO - 'LOGNAME': 'cltbld', 14:06:39 INFO - 'MAIL': '/var/mail/cltbld', 14:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:39 INFO - 'MOZ_NO_REMOTE': '1', 14:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:39 INFO - 'NO_EM_RESTART': '1', 14:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:39 INFO - 'PWD': '/builds/slave/test', 14:06:39 INFO - 'SHELL': '/bin/bash', 14:06:39 INFO - 'SHLVL': '1', 14:06:39 INFO - 'TERM': 'linux', 14:06:39 INFO - 'TMOUT': '86400', 14:06:39 INFO - 'USER': 'cltbld', 14:06:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:39 INFO - '_': '/tools/buildbot/bin/python'} 14:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:39 INFO - Downloading/unpacking psutil>=0.7.1 14:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:06:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:41 INFO - Installing collected packages: psutil 14:06:41 INFO - Running setup.py install for psutil 14:06:41 INFO - building 'psutil._psutil_linux' extension 14:06:41 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 14:06:42 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 14:06:42 INFO - building 'psutil._psutil_posix' extension 14:06:42 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 14:06:42 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 14:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:42 INFO - Successfully installed psutil 14:06:42 INFO - Cleaning up... 14:06:42 INFO - Return code: 0 14:06:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:42 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:42 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 14:06:42 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 14:06:42 INFO - Using env: {'DISPLAY': ':0', 14:06:42 INFO - 'HOME': '/home/cltbld', 14:06:42 INFO - 'LANG': 'en_US.UTF-8', 14:06:42 INFO - 'LANGUAGE': 'en_US:en', 14:06:42 INFO - 'LOGNAME': 'cltbld', 14:06:42 INFO - 'MAIL': '/var/mail/cltbld', 14:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:42 INFO - 'MOZ_NO_REMOTE': '1', 14:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:42 INFO - 'NO_EM_RESTART': '1', 14:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:42 INFO - 'PWD': '/builds/slave/test', 14:06:42 INFO - 'SHELL': '/bin/bash', 14:06:42 INFO - 'SHLVL': '1', 14:06:42 INFO - 'TERM': 'linux', 14:06:42 INFO - 'TMOUT': '86400', 14:06:42 INFO - 'USER': 'cltbld', 14:06:42 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:42 INFO - '_': '/tools/buildbot/bin/python'} 14:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:06:42 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 14:06:42 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 14:06:42 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 14:06:42 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 14:06:42 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 14:06:42 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 14:06:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:06:44 INFO - Installing collected packages: mozsystemmonitor 14:06:44 INFO - Running setup.py install for mozsystemmonitor 14:06:44 INFO - Successfully installed mozsystemmonitor 14:06:44 INFO - Cleaning up... 14:06:44 INFO - Return code: 0 14:06:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:06:44 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')]} 14:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:44 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')]} 14:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:44 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:44 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 14:06:44 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 14:06:44 INFO - Using env: {'DISPLAY': ':0', 14:06:44 INFO - 'HOME': '/home/cltbld', 14:06:44 INFO - 'LANG': 'en_US.UTF-8', 14:06:44 INFO - 'LANGUAGE': 'en_US:en', 14:06:44 INFO - 'LOGNAME': 'cltbld', 14:06:44 INFO - 'MAIL': '/var/mail/cltbld', 14:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:44 INFO - 'MOZ_NO_REMOTE': '1', 14:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:44 INFO - 'NO_EM_RESTART': '1', 14:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:44 INFO - 'PWD': '/builds/slave/test', 14:06:44 INFO - 'SHELL': '/bin/bash', 14:06:44 INFO - 'SHLVL': '1', 14:06:44 INFO - 'TERM': 'linux', 14:06:44 INFO - 'TMOUT': '86400', 14:06:44 INFO - 'USER': 'cltbld', 14:06:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:44 INFO - '_': '/tools/buildbot/bin/python'} 14:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 14:06:44 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 14:06:44 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 14:06:44 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 14:06:44 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 14:06:44 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 14:06:44 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 14:06:46 INFO - Downloading blobuploader-1.2.4.tar.gz 14:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:06:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:06:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:06: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 14:06: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 14:06:47 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 14:06:47 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 14:06: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 14:06: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 14:06:47 INFO - Downloading docopt-0.6.1.tar.gz 14:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:06:47 INFO - Installing collected packages: blobuploader, requests, docopt 14:06:47 INFO - Running setup.py install for blobuploader 14:06:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:06:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:06:47 INFO - Running setup.py install for requests 14:06:47 INFO - Running setup.py install for docopt 14:06:47 INFO - Successfully installed blobuploader requests docopt 14:06:47 INFO - Cleaning up... 14:06:47 INFO - Return code: 0 14:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:47 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:47 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 14:06:47 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 14:06:47 INFO - Using env: {'DISPLAY': ':0', 14:06:47 INFO - 'HOME': '/home/cltbld', 14:06:47 INFO - 'LANG': 'en_US.UTF-8', 14:06:47 INFO - 'LANGUAGE': 'en_US:en', 14:06:47 INFO - 'LOGNAME': 'cltbld', 14:06:47 INFO - 'MAIL': '/var/mail/cltbld', 14:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:47 INFO - 'MOZ_NO_REMOTE': '1', 14:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:47 INFO - 'NO_EM_RESTART': '1', 14:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:47 INFO - 'PWD': '/builds/slave/test', 14:06:47 INFO - 'SHELL': '/bin/bash', 14:06:47 INFO - 'SHLVL': '1', 14:06:47 INFO - 'TERM': 'linux', 14:06:47 INFO - 'TMOUT': '86400', 14:06:47 INFO - 'USER': 'cltbld', 14:06:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:47 INFO - '_': '/tools/buildbot/bin/python'} 14:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:48 INFO - Running setup.py (path:/tmp/pip-gI5MwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:48 INFO - Running setup.py (path:/tmp/pip-0pXV_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:48 INFO - Running setup.py (path:/tmp/pip-GhqoAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:48 INFO - Running setup.py (path:/tmp/pip-ci_MPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:48 INFO - Running setup.py (path:/tmp/pip-TGSpZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:48 INFO - Running setup.py (path:/tmp/pip-X_e_sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:48 INFO - Running setup.py (path:/tmp/pip-kN5OSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:48 INFO - Running setup.py (path:/tmp/pip-_jCi0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:48 INFO - Running setup.py (path:/tmp/pip-NrP8hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:48 INFO - Running setup.py (path:/tmp/pip-4cJrJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:48 INFO - Running setup.py (path:/tmp/pip-KTp7C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:48 INFO - Running setup.py (path:/tmp/pip-icfL1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:48 INFO - Running setup.py (path:/tmp/pip-QbtY7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:48 INFO - Running setup.py (path:/tmp/pip-8o9FQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:48 INFO - Running setup.py (path:/tmp/pip-D93qUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:48 INFO - Running setup.py (path:/tmp/pip-wqJaqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:48 INFO - Running setup.py (path:/tmp/pip-n0N7x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:49 INFO - Running setup.py install for manifestparser 14:06:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Running setup.py install for mozcrash 14:06:49 INFO - Running setup.py install for mozdebug 14:06:49 INFO - Running setup.py install for mozdevice 14:06:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Running setup.py install for mozfile 14:06:49 INFO - Running setup.py install for mozhttpd 14:06:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Running setup.py install for mozinfo 14:06:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Running setup.py install for mozInstall 14:06:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Running setup.py install for mozleak 14:06:49 INFO - Running setup.py install for mozlog 14:06:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:49 INFO - Running setup.py install for moznetwork 14:06:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:50 INFO - Running setup.py install for mozprocess 14:06:50 INFO - Running setup.py install for mozprofile 14:06:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:50 INFO - Running setup.py install for mozrunner 14:06:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:50 INFO - Running setup.py install for mozscreenshot 14:06:50 INFO - Running setup.py install for moztest 14:06:50 INFO - Running setup.py install for mozversion 14:06:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:50 INFO - Cleaning up... 14:06:50 INFO - Return code: 0 14:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:50 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:50 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 14:06:50 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 14:06:50 INFO - Using env: {'DISPLAY': ':0', 14:06:50 INFO - 'HOME': '/home/cltbld', 14:06:50 INFO - 'LANG': 'en_US.UTF-8', 14:06:50 INFO - 'LANGUAGE': 'en_US:en', 14:06:50 INFO - 'LOGNAME': 'cltbld', 14:06:50 INFO - 'MAIL': '/var/mail/cltbld', 14:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:50 INFO - 'MOZ_NO_REMOTE': '1', 14:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:50 INFO - 'NO_EM_RESTART': '1', 14:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:50 INFO - 'PWD': '/builds/slave/test', 14:06:50 INFO - 'SHELL': '/bin/bash', 14:06:50 INFO - 'SHLVL': '1', 14:06:50 INFO - 'TERM': 'linux', 14:06:50 INFO - 'TMOUT': '86400', 14:06:50 INFO - 'USER': 'cltbld', 14:06:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:50 INFO - '_': '/tools/buildbot/bin/python'} 14:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:50 INFO - Running setup.py (path:/tmp/pip-vK5hgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:50 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)) 14:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:50 INFO - Running setup.py (path:/tmp/pip-NyngMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:50 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)) 14:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:50 INFO - Running setup.py (path:/tmp/pip-k3ocrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:51 INFO - Running setup.py (path:/tmp/pip-eaBPKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:51 INFO - Running setup.py (path:/tmp/pip-Kq_AOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:51 INFO - Running setup.py (path:/tmp/pip-kWJkVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:51 INFO - Running setup.py (path:/tmp/pip-39DSjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:51 INFO - Running setup.py (path:/tmp/pip-YwrYn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:51 INFO - Running setup.py (path:/tmp/pip-2JCcvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:51 INFO - Running setup.py (path:/tmp/pip-cD92T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:51 INFO - Running setup.py (path:/tmp/pip-FjoDgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:51 INFO - Running setup.py (path:/tmp/pip-dts9NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:51 INFO - Running setup.py (path:/tmp/pip-WYnVSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:51 INFO - Running setup.py (path:/tmp/pip-6X6UBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:51 INFO - Running setup.py (path:/tmp/pip-NLwWud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:51 INFO - Running setup.py (path:/tmp/pip-c8jShi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:51 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)) 14:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:51 INFO - Running setup.py (path:/tmp/pip-FLpo76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:51 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)) 14:06:51 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)) 14:06:51 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)) 14:06:51 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)) 14:06:51 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)) 14:06:51 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)) 14:06:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:53 INFO - Downloading blessings-1.6.tar.gz 14:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:53 INFO - Installing collected packages: blessings 14:06:53 INFO - Running setup.py install for blessings 14:06:53 INFO - Successfully installed blessings 14:06:53 INFO - Cleaning up... 14:06:53 INFO - Return code: 0 14:06:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:54 INFO - Reading from file tmpfile_stdout 14:06:54 INFO - Current package versions: 14:06:54 INFO - argparse == 1.2.1 14:06:54 INFO - blessings == 1.6 14:06:54 INFO - blobuploader == 1.2.4 14:06:54 INFO - docopt == 0.6.1 14:06:54 INFO - manifestparser == 1.1 14:06:54 INFO - mozInstall == 1.12 14:06:54 INFO - mozcrash == 0.17 14:06:54 INFO - mozdebug == 0.1 14:06:54 INFO - mozdevice == 0.48 14:06:54 INFO - mozfile == 1.2 14:06:54 INFO - mozhttpd == 0.7 14:06:54 INFO - mozinfo == 0.9 14:06:54 INFO - mozleak == 0.1 14:06:54 INFO - mozlog == 3.1 14:06:54 INFO - moznetwork == 0.27 14:06:54 INFO - mozprocess == 0.22 14:06:54 INFO - mozprofile == 0.28 14:06:54 INFO - mozrunner == 6.11 14:06:54 INFO - mozscreenshot == 0.1 14:06:54 INFO - mozsystemmonitor == 0.0 14:06:54 INFO - moztest == 0.7 14:06:54 INFO - mozversion == 1.4 14:06:54 INFO - psutil == 3.1.1 14:06:54 INFO - requests == 1.2.3 14:06:54 INFO - wsgiref == 0.1.2 14:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:54 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:54 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 14:06:54 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 14:06:54 INFO - Using env: {'DISPLAY': ':0', 14:06:54 INFO - 'HOME': '/home/cltbld', 14:06:54 INFO - 'LANG': 'en_US.UTF-8', 14:06:54 INFO - 'LANGUAGE': 'en_US:en', 14:06:54 INFO - 'LOGNAME': 'cltbld', 14:06:54 INFO - 'MAIL': '/var/mail/cltbld', 14:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:54 INFO - 'MOZ_NO_REMOTE': '1', 14:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:54 INFO - 'NO_EM_RESTART': '1', 14:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:54 INFO - 'PWD': '/builds/slave/test', 14:06:54 INFO - 'SHELL': '/bin/bash', 14:06:54 INFO - 'SHLVL': '1', 14:06:54 INFO - 'TERM': 'linux', 14:06:54 INFO - 'TMOUT': '86400', 14:06:54 INFO - 'USER': 'cltbld', 14:06:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:54 INFO - '_': '/tools/buildbot/bin/python'} 14:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 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)) 14:06:54 INFO - Cleaning up... 14:06:54 INFO - Return code: 0 14:06:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:54 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:54 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 14:06:54 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 14:06:54 INFO - Using env: {'DISPLAY': ':0', 14:06:54 INFO - 'HOME': '/home/cltbld', 14:06:54 INFO - 'LANG': 'en_US.UTF-8', 14:06:54 INFO - 'LANGUAGE': 'en_US:en', 14:06:54 INFO - 'LOGNAME': 'cltbld', 14:06:54 INFO - 'MAIL': '/var/mail/cltbld', 14:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:54 INFO - 'MOZ_NO_REMOTE': '1', 14:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:54 INFO - 'NO_EM_RESTART': '1', 14:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:54 INFO - 'PWD': '/builds/slave/test', 14:06:54 INFO - 'SHELL': '/bin/bash', 14:06:54 INFO - 'SHLVL': '1', 14:06:54 INFO - 'TERM': 'linux', 14:06:54 INFO - 'TMOUT': '86400', 14:06:54 INFO - 'USER': 'cltbld', 14:06:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:54 INFO - '_': '/tools/buildbot/bin/python'} 14:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:54 INFO - Downloading/unpacking jsonschema 14:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:06:56 INFO - Downloading/unpacking functools32 (from jsonschema) 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:56 INFO - Downloading functools32-3.2.3-2.tar.gz 14:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:06:56 INFO - warning: no files found matching '*.txt' 14:06:56 INFO - no previously-included directories found matching 'build' 14:06:56 INFO - no previously-included directories found matching 'dist' 14:06:56 INFO - no previously-included directories found matching '.git*' 14:06:56 INFO - Installing collected packages: jsonschema, functools32 14:06:56 INFO - Running setup.py install for functools32 14:06:56 INFO - warning: no files found matching '*.txt' 14:06:56 INFO - no previously-included directories found matching 'build' 14:06:56 INFO - no previously-included directories found matching 'dist' 14:06:56 INFO - no previously-included directories found matching '.git*' 14:06:56 INFO - Successfully installed jsonschema functools32 14:06:56 INFO - Cleaning up... 14:06:56 INFO - Return code: 0 14:06:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:06: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')]} 14:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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')]} 14:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:56 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 0x7f76bf572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, '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': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', '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 14:06:56 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 14:06:56 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 14:06:56 INFO - Using env: {'DISPLAY': ':0', 14:06:56 INFO - 'HOME': '/home/cltbld', 14:06:56 INFO - 'LANG': 'en_US.UTF-8', 14:06:56 INFO - 'LANGUAGE': 'en_US:en', 14:06:56 INFO - 'LOGNAME': 'cltbld', 14:06:56 INFO - 'MAIL': '/var/mail/cltbld', 14:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:56 INFO - 'MOZ_NO_REMOTE': '1', 14:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:06:56 INFO - 'NO_EM_RESTART': '1', 14:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:56 INFO - 'PWD': '/builds/slave/test', 14:06:56 INFO - 'SHELL': '/bin/bash', 14:06:56 INFO - 'SHLVL': '1', 14:06:56 INFO - 'TERM': 'linux', 14:06:56 INFO - 'TMOUT': '86400', 14:06:56 INFO - 'USER': 'cltbld', 14:06:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:56 INFO - '_': '/tools/buildbot/bin/python'} 14:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:57 INFO - Downloading/unpacking flake8 14:06:57 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 14:06:57 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 14:06:57 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 14:06:57 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 14:06:57 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 14:06:57 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 14:06:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:06:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:06:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:06:59 INFO - no previously-included directories found matching 'docs/_build' 14:06:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:06:59 INFO - Running setup.py install for pep8 14:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:06:59 INFO - no previously-included directories found matching 'docs/_build' 14:06:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:06:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:06:59 INFO - Cleaning up... 14:06:59 INFO - Return code: 0 14:06:59 INFO - Running post-action listener: _resource_record_post_action 14:06:59 INFO - Running post-action listener: _start_resource_monitoring 14:06:59 INFO - Starting resource monitoring. 14:06:59 INFO - ##### 14:06:59 INFO - ##### Finished create-virtualenv step (success) 14:06:59 INFO - ##### 14:06:59 INFO - ##### 14:06:59 INFO - ##### Running install step. 14:06:59 INFO - ##### 14:06:59 INFO - Running pre-action listener: _resource_record_pre_action 14:06:59 INFO - Running main action method: install 14:06:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:07:00 INFO - Reading from file tmpfile_stdout 14:07:00 INFO - Detecting whether we're running mozinstall >=1.0... 14:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:07:00 INFO - Reading from file tmpfile_stdout 14:07:00 INFO - Output received: 14:07:00 INFO - Usage: mozinstall [options] installer 14:07:00 INFO - Options: 14:07:00 INFO - -h, --help show this help message and exit 14:07:00 INFO - -d DEST, --destination=DEST 14:07:00 INFO - Directory to install application into. [default: 14:07:00 INFO - "/builds/slave/test"] 14:07:00 INFO - --app=APP Application being installed. [default: firefox] 14:07:00 INFO - mkdir: /builds/slave/test/build/application 14:07:00 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'] 14:07:00 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 14:07:15 INFO - Reading from file tmpfile_stdout 14:07:15 INFO - Output received: 14:07:15 INFO - /builds/slave/test/build/application/firefox/firefox 14:07:15 INFO - Running post-action listener: _resource_record_post_action 14:07:15 INFO - ##### 14:07:15 INFO - ##### Finished install step (success) 14:07:15 INFO - ##### 14:07:15 INFO - ##### 14:07:15 INFO - ##### Running run-tests step. 14:07:15 INFO - ##### 14:07:15 INFO - Running pre-action listener: _resource_record_pre_action 14:07:15 INFO - Running main action method: run_tests 14:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:15 INFO - Python 2.7.3 14:07:15 INFO - Return code: 0 14:07:15 INFO - grabbing minidump binary from tooltool 14:07:15 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')]} 14:07:15 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 0xe239c0>, '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 0xe248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe24d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:15 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 14:07:15 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 14:07:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:15 INFO - Return code: 0 14:07:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:07:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:07:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:07:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:07:16 INFO - Return code: 0 14:07:16 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:07:16 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:07:16 INFO - Using env: {'DISPLAY': ':0', 14:07:16 INFO - 'HOME': '/home/cltbld', 14:07:16 INFO - 'LANG': 'en_US.UTF-8', 14:07:16 INFO - 'LANGUAGE': 'en_US:en', 14:07:16 INFO - 'LOGNAME': 'cltbld', 14:07:16 INFO - 'MAIL': '/var/mail/cltbld', 14:07:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:07:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:16 INFO - 'MOZ_NO_REMOTE': '1', 14:07:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:16 INFO - 'NO_EM_RESTART': '1', 14:07:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:16 INFO - 'PWD': '/builds/slave/test', 14:07:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:16 INFO - 'SHELL': '/bin/bash', 14:07:16 INFO - 'SHLVL': '1', 14:07:16 INFO - 'TERM': 'linux', 14:07:16 INFO - 'TMOUT': '86400', 14:07:16 INFO - 'USER': 'cltbld', 14:07:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280', 14:07:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:16 INFO - '_': '/tools/buildbot/bin/python'} 14:07:16 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:07:17 INFO - mozversion application_buildid: 20160509132658 14:07:17 INFO - mozversion application_changeset: ea89f71fc38e4f4627b3e3075159cddc31aae645 14:07:17 INFO - mozversion application_display_name: Nightly 14:07:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:17 INFO - mozversion application_name: Firefox 14:07:17 INFO - mozversion application_remotingname: firefox 14:07:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:07:17 INFO - mozversion application_vendor: Mozilla 14:07:17 INFO - mozversion application_version: 49.0a1 14:07:17 INFO - mozversion platform_buildid: 20160509132658 14:07:17 INFO - mozversion platform_changeset: ea89f71fc38e4f4627b3e3075159cddc31aae645 14:07:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:07:17 INFO - mozversion platform_version: 49.0a1 14:07:17 INFO - using testdate: 1462828037 14:07:17 INFO - actual date: 1462828037 14:07:17 INFO - starting webserver on 'localhost:35781' 14:07:17 INFO - SUITE-START | Running 2 tests 14:07:17 INFO - TEST-START | dromaeo_css 14:07:17 INFO - operating with platform_type : linux_ 14:07:17 INFO - Initialising browser for dromaeo_css test... 14:07:17 INFO - TEST-INFO | started process 28064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfymJu/profile http://localhost:35781/getInfo.html) 14:07:21 INFO - PROCESS | 28064 | __metrics Screen width/height:1600/1200 14:07:21 INFO - PROCESS | 28064 | colorDepth:24 14:07:21 INFO - PROCESS | 28064 | Browser inner width/height: 1024/697 14:07:21 INFO - PROCESS | 28064 | __metrics 14:07:22 ERROR - PROCESS | 28064 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:07:23 INFO - TEST-INFO | 28064: exit 0 14:07:23 INFO - Browser initialized. 14:07:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:23 INFO - TEST-INFO | started process 28143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfymJu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:34 INFO - PROCESS | 28143 | RSS: Main: 152657920 14:07:34 INFO - PROCESS | 28143 | 14:08:26 INFO - PROCESS | 28143 | 1462828106316 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] 14:10:37 INFO - PROCESS | 28143 | Cycle 1(1): loaded http://localhost:35781/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35781/tests/dromaeo/cssquery-ext.html) 14:10:39 INFO - PROCESS | 28143 | RSS: Main: 271400960 14:10:39 INFO - PROCESS | 28143 | 14:13:41 INFO - PROCESS | 28143 | Cycle 1(1): loaded http://localhost:35781/tests/dromaeo/cssquery-ext.html (next: http://localhost:35781/tests/dromaeo/cssquery-jquery.html) 14:13:42 INFO - PROCESS | 28143 | RSS: Main: 238678016 14:13:42 INFO - PROCESS | 28143 | 14:16:44 INFO - PROCESS | 28143 | Cycle 1(1): loaded http://localhost:35781/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35781/tests/dromaeo/cssquery-mootools.html) 14:16:44 INFO - PROCESS | 28143 | RSS: Main: 243466240 14:16:44 INFO - PROCESS | 28143 | 14:19:46 INFO - PROCESS | 28143 | Cycle 1(1): loaded http://localhost:35781/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35781/tests/dromaeo/cssquery-prototype.html) 14:19:47 INFO - PROCESS | 28143 | RSS: Main: 233000960 14:19:47 INFO - PROCESS | 28143 | 14:22:50 INFO - PROCESS | 28143 | Cycle 1(1): loaded http://localhost:35781/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35781/tests/dromaeo/cssquery-yui.html) 14:22:50 INFO - PROCESS | 28143 | RSS: Main: 223182848 14:22:50 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | Cycle 1(1): loaded http://localhost:35781/tests/dromaeo/cssquery-yui.html (next: http://localhost:35781/tests/dromaeo/cssquery-dojo.html) 14:25:53 INFO - PROCESS | 28143 | RSS: Main: 274567168 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | __start_tp_report 14:25:53 INFO - PROCESS | 28143 | _x_x_mozilla_page_load 14:25:53 INFO - PROCESS | 28143 | _x_x_mozilla_page_load_details 14:25:53 INFO - PROCESS | 28143 | |i|pagename|runs| 14:25:53 INFO - PROCESS | 28143 | |0;dojo.html;2656.04382422328;2656.5616673248915;2682.9463410731787;2686.7313268673133;2694.070545661746;4547.317902314654;4597.494275629687;4712.03403302323;4755.215389460744;4820.975895120524;4638.350630911675;4730.692504987173;4733.124371991175;4773.80904763809;4774.140654682155;4312.374705667684;4321.567843215685;4352.39066530686;4458;4459.799309031101;4338.761368124768;4438.844640437585;4441;4482.193205223075;4496.168208881351;4182.91634167318;4231.428757117811;4301.032267739764;4332.805023773938;4353.76054317014;4258.53156152823;4286.742795432284;4288.614024737789;4325.589069038468;4352.978235108836;4258.148370325947;4313.676474264411;4322.524522302544;4329.090890912912;4392.648588112943;4433.578810013044;4609.400777898852;4615.699979501355;4619.353290539327;4627.097715945392;4953.777080031371;4988.226824842155;5000.82497112603;5043.218301163325;5070.188769796815;5014.498550144956;5038.319826823368;5059.2916991621205;5062.645614806965;5100.795968161269;4612.561806628365;4696.671233013656;4740;4753.643476739258;4774.40319960005;5111.8722031948755;5126.948730512721;5189.818356357509;5204.271402003723;5211.374635043743;4909.803607855646;4921.680090794087;4927.113119638428;4973.204287314013;4975.253711943165;4807.95192048082;4813.687110337817;4988;5013.047520971004;5063.367079115111;4972.0801651694555;4977.875553111201;4981.227909674007;4983.9252411213865;5067.543921047123;4978.0292842896015;4981.277714731344;5007.599392048627;5009.499050094962;5018.799248030111;4186.5604111568455;4268.893277668083;4274.273373526508;4274.636655884223;4337.956620433818;3710.9072273193387;3727.2731817295366;3761.4169803680475;3782.4893639358884;3803.6386543278345;4279.87160385189;4322.394864718942;4324.675649326313;4325.1565944641125;4342.956570434255;4867.610591152699;4956.504349565087;4986.052649996489;4994.225894986283;5032.672876263031;4220.451341325608;4252.107057517894;4255.319148936217;4273.700840941105;4296.548862369406;4525.796339164745;4538.410006699108;4542.727436353829;4592.425946756655;4598.126355992351;4618.399608050931;4620.953790462052;4659.184642687584;4666;4673.485916549245;4954.355933728592;4960.677555958851;4967.577755890645;4978.228374601942;5002.499750024968;4637.188492013952;4651.534846515321;4661.510541393105;4686.992296656235;4727.739974301447;4951.702897826142;4993.700377977188;5003.824866129668;5019.02129084825;5034.597232221487;5077.949220507895;5107.744612769421;5109.897802044013;5110.9233361500355;5151.5106064923775;4662.277347011219;4883;4923.950760492349;4949.183384741477;4982.2775697524385;4906.582940449959;4912.48418916023;4939.654224204415;4968.826091086795;4973.701577905337;4839.927401088916;4904.5340692634145;4934.18585933317;4958.727270000185;4958.776855041604;4802.207635740064;4946.356973593553;4969.900601988013;5049.9495005049475;5058.949410505995;4664.300354946785;4703.9529604704885;4816.325714400057;4837.129316723023;4873.147199240189 14:25:53 INFO - PROCESS | 28143 | |1;ext.html;544.9061910224623;552.4834279948246;572.3418069220397;580.2514755964805;586.9765209391625;40968.385474217874;42431.36352954708;42445.78777106114;46704.532954670445;46946.29580556294;42918;43495.56504434955;43596.78201608988;43654.345184822254;43850.342244866275;7849;7923.920760792376;7925.2867241948215;7940.364770818321;7971.202879712011;7668.233176682343;7727.265909738566;7757.534547927143;7769.300762931335;7794.337481314095;7800.648970796299;7802.921970780305;7806.843863122735;7828.491148075385;7851.5681637509915;7735.574543400111;7763.37892968564;7765.495242809199;7769.028871391076;7771.028621422322;7804.72683456082;7834.647440865175;7847.607619619053;7870.370370370357;7929.72245971394;37637;39779.8011009946;39921.20157596832;39967.40048899269;40110;3368.0569440556683;3381.509681096252;3402.2344972381266;3481.3211423772373;3726.925461490755;28779.59384358665;29593.55609665857;30493.542596861065;30892.073237802902;30896;3026.273694313371;3046.6800985896384;3094.798838075518;3095.148834070626;3146.7482601391835;236208;238607;238863;240008;242296;33389.83305083459;33760;54929.72535137379;56154.43845561574;56316;34916.65083349134;35088.82455587706;35129.64870351264;35139.29721405557;35280.470792938126;12609;12797.424115914806;12854.421551030038;12871.935640321739;12872.292023938586;10009.349392289478;10146.949265253626;10157.730283714536;10177.949110254402;10194;8303.95848020756;8329.958755155605;8352.081271060179;8393.32853371741;8408.285295749929;3224.1456014156265;3251.6098068231963;3256.316173603522;3256.3812875553567;3279.4588892832417;904.4347282948157;967.8675949139524;981.7545613596601;1008.606643409071;1033.560736686905;28130.43739125206;28234.71765282321;28925.855370723013;28964.71035289662;28966.710332896822;988.614440368257;1005.2962925951863;1015.243643485608;1068.060107105742;1075.9784804304027;14783.556493305217;15276.541703748906;15390.461333853262;15482.303296351465;15538.689226215638;365685;366936;370776;370966;373965;51042;51491;51622.48377516252;51748.74125629348;51766.74116629393;1082.6319051522362;1103.5144536404116;1199.0407673860877;1256.214865708932;1261.1550261324935;28776.712232877402;29167.7083229165;29304.853475732485;29652.703472964993;30085.3982920336;37484.43773343456;37958.24083518259;37999.620003800715;38252.617473826016;38325.44281079284;279480;281437;282704;283224;284110;22842.657360139943;25465.344752591023;25698.486030279662;26466.338341541614;26554;43343;43393.3490997629;43512.12975740531;44231.33652995143;44671.77664111659;35700.821495892356;36463.27073458569;36670;36750.44874326941;36780.63219367879;36559.81720091489;36824.44763328499;37238.25523489461;37290.254194916495;37383.439248411836;36177.638223617425;36478.8176059118;37275;37388.813055934545;37423;30763;33055.173620659676;33179;33679.66320336863;33761.15597110092;24758.50482990294;24917.50164996726;25063.87468062648;25181.05572285423;25603.615945760455 14:25:53 INFO - PROCESS | 28143 | |2;jquery.html;378.27748999411114;378.9204267103908;380.7468033757551;393.2194593731443;396.3341586135295;15637.983531070488;16461.34154633813;17348.21933013014;17540.298388064493;17555.38556150535;17070.658586828256;17131.914340428313;17192.82807171928;17619;17785.288588456446;5015.348004759376;5133.435322114565;5159.174532074869;5197.714125723083;5199.610029247802;3650.7627004244773;5606.803761868336;5931.139984702216;5945.524358051367;6017.097435384705;5958.285005799288;5970.97014514929;5980.700964951757;5997.49021333185;6008.399160083978;5744.31068271808;5873.207117039187;5914.645121292736;5986.431289027535;5992.910106348409;3276.639569647337;4859.781309841065;5199.740012999373;5215.765290561933;5327.653702509325;21009.68485472719;21077.367678969655;21537.138514459402;21555.67666485004;21600.243991460222;1936.070686070694;2017.0923084611984;2023.6660950943076;2037.3480486244407;2048.354768248012;13149.474021039146;13276.402561884643;13308.73382532344;13326.933365333209;13840.446382144703;1751.4964845674322;1801.9008954507497;1815.8728888977778;1847.75055367525;1854.5641774183057;59405.7029714853;63531.36468635301;63639;64032.67983660052;64206;10118.747031324276;10256.641017564349;10388;10493.580256789795;10583.364998099985;14459.78310325346;14507.202103884176;14527.709445811235;14585.41658333676;14593.978421510392;7146.857062858714;7300.853982920418;7325.450591205575;7383.520071195355;7408.222136675679;6852.45180385568;6893.448524118058;6947;6956.860862782716;6968.163820341591;4549.385832912514;4577.382053422812;4592.816287348469;4597.448306203277;4612.838550650711;1709.4273418404725;1754.97367539487;1857.990710046441;1863.5527473406285;1870.1303893689499;839.9328053755685;861.3152543727751;927.6289484206371;950.1780959470009;955.6320816485703;16603.41888033937;17070.658586828195;17266.374061446986;17386.21762020712;17729.202185901664;907.2288554728428;907.4691305586174;917.3349321741817;935.7988032573029;937.9437233765996;9275.423178059746;9922.950385248028;9971.900280997243;9978.900210997943;10145.898541014643;339073;352161;392428;411578;419113;72264.2773572268;75511;76938.92244310165;76946;77147;959.203860795538;964.8456247000446;966.0339660339661;978.9769690673263;981.2297346583041;15406.229688515754;15469.922650386676;15501.612459688598;15595.37618495293;15850.44523441674;23516.294511164007;27387.86306068457;33666.83166584151;35052.64947350596;35574;43127.35308970305;47941.28088078751;48013.75993120012;48131.518684812705;48268.27597585969;7739.148693643808;7787.844243114992;7840.921590784247;7872;8041.959790201012;7266.309700578437;8633.465363264606;9704.980976997596;11853.34806585646;12118.151729378858;9738.415695058318;10432.165426765992;10464.162866970471;10557.298864050257;10719.571217151226;10278.537465814206;10286.639967601099;10430.634927777492;10434.165266778791;10527.420991845522;10588.152947764007;10593.576256949944;10808.891911081104;10835.891641083488;10854.782904342026;7832;7885.369170466463;8005.479643823133;8140.592970351578;8143;7951.363890888831;9257.814843703223;10444.42555659446;10514.211434142622;10521.368717876952 14:25:53 INFO - PROCESS | 28143 | |3;mootools.html;1224.5714000099972;1404.382071888369;1455.6943041961188;1547.1336051810986;1729.1440736835268;6231.408016238456;7048.612326322057;7290.963545182267;7318.634068296577;7516.849663006737;7164.713411463548;7242.058532390795;7254.238304977967;7265.673044712988;7276.308750668692;2155.4072630026712;2188.73735151782;2189.1462329691435;2198.0658220256328;2200.2299195281685;2169.8698078115285;2190.87950162741;2214.1475531920246;2215.1360969222014;2217.0466699319286;2163.1996161420216;2165.4369863835436;2171.913123475067;2184.0936011555264;2200.4938864061273;2139.208492857645;2145.4314606629255;2145.8605190662556;2148.4843637527038;2149.03293517916;1965.2335589120255;2043.703662968876;2044.2845004248543;2044.5399785048246;2056.3008577083715;7028.753993610199;7191.6404179791325;7294.307040831112;7303.926960730431;7367.852642947111;4424.7123936944;4556.3621093047;4570.9943812361225;4597.885052873671;4602.746848923308;2932.29624890027;2939.8236105833716;2983.5077212260167;2999.460097182506;3014.849257537114;929.2287401456774;939.2063706168277;949.6343907595557;950.9524523773783;974.9756256093655;9392.530373481366;9411.717648470489;9535.951045384933;9631.036896310383;9666.420014799134;3899.454076429302;3987.6809855211513;4007.2786898358577;4088.897777555585;4115.506139263308;7857.096433910059;7867.409944254204;7881.133075361706;7888.447808653454;7893.565853878092;4277.679174061957;4371.147626212922;4400.317950717644;4418.491873434532;4432.933505997413;3600.6219346968714;4001.9799901000893;4061.1674606705556;4065.6137666921595;4142.130152667974;3374.308266805299;3398.09950363154;3431.5024321473247;3456.8962931112105;3487.4943133246043;1033.245730616639;1035.492608621785;1035.7651802161893;1043.8695163104612;1046.5395226100643;735.8381156145639;780.9101953275446;849.1508491508491;852.2627926843236;852.7868032991752;4904.141775189399;4965.957148998751;4979.701217926936;4986.80052797884;5007.4491805901325;435.0580992152019;437.34616747962;441.55182489772903;444.8020630819319;450.45494951109526;3454.136465883529;3482.164280572644;3498.9825050875093;3499.61504234534;3531.2937412517085;8270.545120018336;8766.386352955233;8793.296536277083;8874.334424918157;8951.239144672645;8797.912020879709;8819.514926679094;8820.986451164705;8835.425697329782;8850;6656.500762442836;6875.965620171867;6928.653567321614;6966.1988871280455;6978.860422791516;4771.4512831023485;4776.164171270083;4793.880152996203;4847.75761211931;4848.0546293472435;7961;8102.432829701865;8262.17378262169;8280.296174825207;8375.162483751576;8166.877496837434;8185.7135000277085;8381.413301068867;8456.577171141294;8549.786255343666;5427.538659213853;5607.635503692247;6039.939600603938;6105.145279660762;6141.048137538689;6607.075009498578;6664.100346453167;6668.499862510234;6828.658567071726;7043.119610048744;6135.84660383494;6404.711787969646;6537.771178008747;6556.377144171296;6704.396604305636;6294;6373.458256048288;6477.4494167996245;6578;6583.96708016476;6080.209572755691;6107.877842443215;6152;6162.322144564005;6164.506839452743;4350.412694286231;4412.227860124402;4500.369948207188;4533.84131555394;4544.341070544819;4197.391378250198;4473.619742321939;4495.527969563149;4591.265397536378;4609.51600082 14:25:53 INFO - PROCESS | 28143 | |4;prototype.html;305.12429327829136;315.4826085220239;319.9008307424697;320.34009939524583;320.8331667532883;4598.551456291266;4614.82322007888;4622.9768851155695;4655.441347038356;4662.90674186516;4186.2464756343925;4416.845410410636;4617.376654151689;4619.607333376659;4620.330052142445;3708.8516459341727;3732.2535492901393;3737.4020156774923;3761.13493896404;3762.586115527283;3738.439234114891;3742.4760533525327;3752.9812350938205;3753.8123093845197;3756.8773642891815;3504.281622267442;3587.2825434912993;3647.9817600911956;3668.413053911375;3718.776873387592;3646.8176591170336;3652.981735091334;3680.963190368089;3684.7604905681046;3719.8326075326677;3273.639899611041;3288.0629020729216;3291.8683252669866;3293.176705823544;3315.1049216711594;4282.907858496063;4297.097609502009;4403.119376124788;4419.138268037734;4443.289073748217;4102.630763231324;4128.02991297045;4137.296659567851;4144.6062624050965;4159.688023398227;4758.334582895994;4759.547842954914;4774.212254977924;4790.616750659974;4829.9275510867365;3559.6440355964196;3585;3592.9281414371567;3613.295407395559;3647.635236476331;4830.613550915953;5079.8222062228015;5081.110805609003;5096.980603879202;5132.5124113209185;3554.87557935471;3558.395072837624;3562.6259242779133;3569.982150089233;3570.6607872252093;3599.7480176387403;3613.1689711366007;3625.021244264034;3635.8909232723063;3655.7440979131206;3891.591382904754;4115.506139263308;4140.648044916215;4145.875623731293;4151.626353628128;4854.247591623304;4877.926831097537;4880.170371036932;4887.682300650517;4918.434380046269;1150.913681473893;1197.1440420099495;1201.9399030048462;1205.5840734946605;1214.2896405602644;872;889.1686273334324;903.9909600903907;914.1041779056562;919.5540163020929;4021.195760847842;4062.878113656595;4071.4096456013713;4085.428040074392;4087.4890638670167;4570.360149579062;4765.237561990065;4822.276658501182;4822.662413631082;4842.900543652066;3967.016491754123;4004.0390306326854;4016.55817860041;4054.2296963576828;4070.4911886014247;2493.800495960319;2505.922453345043;2521.6217567364674;2535.530926778552;2561.2316305108393;4477.597016268552;4502.797374118172;4504.369388285642;4526.4115664964;4541.205289074464;4758.666893317434;4838.564529192389;5084.211947148198;5120.231965205249;5178.378594568676;4761.166795810719;4763.285507173951;4770.212914869077;4778.928316075262;4793.856184314476;4975.581959141772;4975.975120124376;4983.626228032839;4986.401631804207;5020.723860187724;4786.377770889762;4923.655344125877;4970.428400733817;4979.502049794992;4986.276989836526;4764.404449443819;4780.95219047819;4783.832565860178;4785.59322457595;4815.15734746425;3573.6962358199844;3586.103474131467;3587.4798154268005;3594.7843129412317;3615.8734444294323;4899.632527560519;4919.655624106278;4990.276409920469;4998.775055122455;5043.394792624762;4836.685615434985;4851.126797176542;4852.611791056636;4854.563089321978;4858.319835223001;4847.660663753503;4847.806087756591;4864.221724524201;4885.560299573055;4886.462489126265;4555.362249285036;4570.7257564546235;4761.214399624023;4771.093492236464;4788.138135135709;4815.7351345676325;4824.541668541483;4856.271559266138;4858.659893807399;4867.537583929521;4656.205645797204;4778.641601879804;4779.211430113992;4781.9043619128115;4822.590079843112 14:25:53 INFO - PROCESS | 28143 | |5;yui.html;754.7962050246433;781;786.9213078692131;802.2058162419203;832.0514613340792;10790.622328218515;11053.889461105397;11170.776584468325;11183.66449006529;11201.943990280048;12472.688182795435;12990.090693651448;13030.218186908793;13182.472701091945;13196.670083247924;661.5402295404696;837.6063250272392;857.588357588358;858.068995140272;859.6432480520608;856.6316483911916;864.7362554420899;865.9913400866005;867.5835598912525;868.682930730282;900.7522931193942;901.2294488212582;904.7150147703452;907.9863802042975;909.2044461096541;687.1994126842247;880.1638443478657;899.3255058705938;899.6716198587501;903.1645727701849;667.0694381338055;669.0332469581457;669.9665016749192;670.2426258328106;670.25266827487;11216.102711783038;11223.943880280547;11255.099592032619;11291.322520648788;11292.548298068068;10555.94722026385;10966.978186922091;11008.001585453512;11215.271007384494;11259.21185517014;10187.796244075076;10197.337173083726;10257.692269231935;10324.793504129875;10337.844932326021;3944.112574670705;3970.622790834866;4017.4978127734034;4054.087830238173;4066.8983275418054;44204.90565660405;44526;44580;44833.77583112096;45188.774056129834;8551.1448855114;8691.739247822576;8792.47245165292;8829.33779966505;9079.319051071196;14345.211013394364;15987.120708360919;16090.597735056483;16141.596460088356;16152.596185095466;6336.6831658416895;6385.648789316632;6397.52018598607;6557.409833115043;6699.095622090956;3381.9323613528086;3499.1427100360575;3511.701505372021;3562.5012498250267;3573.6783689468075;2769.584562315669;2862.6994165612728;2863.155369166101;2868.6270784797844;2871.9856400717863;536.3028063517412;563.9266895303584;587.1427715535366;592.754007087054;613.0283500651517;413.70420149593184;566.7534622439252;596.5615272774508;636.7771280051945;643.7553729582822;7379.298966598165;7501.887471687929;7692;7972.923655306459;8054.275115239657;529.008109794136;551.4265164229237;640.5388120553195;653.4151934019027;656.1470088884431;3493.510908472816;3551.4140166872176;3650.9817450913106;3693;3826.770393776382;49163.262551061765;50320.49679503231;50382.49617503851;50413.24380134301;50627.746861265456;43985;45225.54774452213;45759.771201144446;46257.074858503314;46440.767796160806;41177.58822411797;41693;41983.79008105001;42493.362599561035;42515.14969700589;6939.30606939302;7016.22821489646;7026.943588262469;7028.332308430691;7062.329078737512;27991.58012629853;28178.577321339788;28558.857205713837;28758.137255882357;28986;36110;38156.2368752629;38469.6153038466;38472.80763596164;39169.804150979064;9271.907280927375;9427.717168484956;9438.716838494856;9465.952670236606;9570.425774453555;9777.657781977596;9905.108540231413;9946.204303655546;10027.799444010932;10140.188784897338;8949.552522373726;9114.498702571422;9140.994490606161;9146.131117543822;9228.676996305097;8844.867326989972;8955.194161950069;9032.593533291149;9055.275577953616;9306.162445379949;8873.29013678917;8987.95542006113;9028.729138125867;9034.096590340914;9054.366194366332;7791.688332466638;7883.487573307717;8043.83912321762;8123.7969050771835;8248.13394593583;8075;8292.751217463485;8383.245507904317;8497.490150590984;8515.531645759544 14:25:53 INFO - PROCESS | 28143 | __end_tp_report 14:25:53 INFO - PROCESS | 28143 | __start_cc_report 14:25:53 INFO - PROCESS | 28143 | _x_x_mozilla_cycle_collect,1009 14:25:53 INFO - PROCESS | 28143 | __end_cc_report 14:25:53 INFO - PROCESS | 28143 | __startTimestamp1462829153539__endTimestamp 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | ------- Summary: start ------- 14:25:53 INFO - PROCESS | 28143 | Number of tests: 6 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | [#0] dojo.html Cycles:165 Average:4643.78 Median:4753.64 stddev:479.63 (10.1%) stddev-sans-first:455.05 14:25:53 INFO - PROCESS | 28143 | Values: 2656.0 2656.6 2682.9 2686.7 2694.1 4547.3 4597.5 4712.0 4755.2 4821.0 4638.4 4730.7 4733.1 4773.8 4774.1 4312.4 4321.6 4352.4 4458.0 4459.8 4338.8 4438.8 4441.0 4482.2 4496.2 4182.9 4231.4 4301.0 4332.8 4353.8 4258.5 4286.7 4288.6 4325.6 4353.0 4258.1 4313.7 4322.5 4329.1 4392.6 4433.6 4609.4 4615.7 4619.4 4627.1 4953.8 4988.2 5000.8 5043.2 5070.2 5014.5 5038.3 5059.3 5062.6 5100.8 4612.6 4696.7 4740.0 4753.6 4774.4 5111.9 5126.9 5189.8 5204.3 5211.4 4909.8 4921.7 4927.1 4973.2 4975.3 4808.0 4813.7 4988.0 5013.0 5063.4 4972.1 4977.9 4981.2 4983.9 5067.5 4978.0 4981.3 5007.6 5009.5 5018.8 4186.6 4268.9 4274.3 4274.6 4338.0 3710.9 3727.3 3761.4 3782.5 3803.6 4279.9 4322.4 4324.7 4325.2 4343.0 4867.6 4956.5 4986.1 4994.2 5032.7 4220.5 4252.1 4255.3 4273.7 4296.5 4525.8 4538.4 4542.7 4592.4 4598.1 4618.4 4621.0 4659.2 4666.0 4673.5 4954.4 4960.7 4967.6 4978.2 5002.5 4637.2 4651.5 4661.5 4687.0 4727.7 4951.7 4993.7 5003.8 5019.0 5034.6 5077.9 5107.7 5109.9 5110.9 5151.5 4662.3 4883.0 4924.0 4949.2 4982.3 4906.6 4912.5 4939.7 4968.8 4973.7 4839.9 4904.5 4934.2 4958.7 4958.8 4802.2 4946.4 4969.9 5049.9 5058.9 4664.3 4704.0 4816.3 4837.1 4873.1 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | [#1] ext.html Cycles:180 Average:44851.02 Median:36519.32 stddev:79451.96 (217.6%) stddev-sans-first:79605.20 14:25:53 INFO - PROCESS | 28143 | Values: 544.9 552.5 572.3 580.3 587.0 40968.4 42431.4 42445.8 46704.5 46946.3 42918.0 43495.6 43596.8 43654.3 43850.3 7849.0 7923.9 7925.3 7940.4 7971.2 7668.2 7727.3 7757.5 7769.3 7794.3 7800.6 7802.9 7806.8 7828.5 7851.6 7735.6 7763.4 7765.5 7769.0 7771.0 7804.7 7834.6 7847.6 7870.4 7929.7 37637.0 39779.8 39921.2 39967.4 40110.0 3368.1 3381.5 3402.2 3481.3 3726.9 28779.6 29593.6 30493.5 30892.1 30896.0 3026.3 3046.7 3094.8 3095.1 3146.7 236208.0 238607.0 238863.0 240008.0 242296.0 33389.8 33760.0 54929.7 56154.4 56316.0 34916.7 35088.8 35129.6 35139.3 35280.5 12609.0 12797.4 12854.4 12871.9 12872.3 10009.3 10146.9 10157.7 10177.9 10194.0 8304.0 8330.0 8352.1 8393.3 8408.3 3224.1 3251.6 3256.3 3256.4 3279.5 904.4 967.9 981.8 1008.6 1033.6 28130.4 28234.7 28925.9 28964.7 28966.7 988.6 1005.3 1015.2 1068.1 1076.0 14783.6 15276.5 15390.5 15482.3 15538.7 365685.0 366936.0 370776.0 370966.0 373965.0 51042.0 51491.0 51622.5 51748.7 51766.7 1082.6 1103.5 1199.0 1256.2 1261.2 28776.7 29167.7 29304.9 29652.7 30085.4 37484.4 37958.2 37999.6 38252.6 38325.4 279480.0 281437.0 282704.0 283224.0 284110.0 22842.7 25465.3 25698.5 26466.3 26554.0 43343.0 43393.3 43512.1 44231.3 44671.8 35700.8 36463.3 36670.0 36750.4 36780.6 36559.8 36824.4 37238.3 37290.3 37383.4 36177.6 36478.8 37275.0 37388.8 37423.0 30763.0 33055.2 33179.0 33679.7 33761.2 24758.5 24917.5 25063.9 25181.1 25603.6 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | [#2] jquery.html Cycles:180 Average:23838.10 Median:415345.50 stddev:63243.08 (15.2%) stddev-sans-first:63395.96 14:25:53 INFO - PROCESS | 28143 | Values: 378.3 378.9 380.7 393.2 396.3 15638.0 16461.3 17348.2 17540.3 17555.4 17070.7 17131.9 17192.8 17619.0 17785.3 5015.3 5133.4 5159.2 5197.7 5199.6 3650.8 5606.8 5931.1 5945.5 6017.1 5958.3 5971.0 5980.7 5997.5 6008.4 5744.3 5873.2 5914.6 5986.4 5992.9 3276.6 4859.8 5199.7 5215.8 5327.7 21009.7 21077.4 21537.1 21555.7 21600.2 1936.1 2017.1 2023.7 2037.3 2048.4 13149.5 13276.4 13308.7 13326.9 13840.4 1751.5 1801.9 1815.9 1847.8 1854.6 59405.7 63531.4 63639.0 64032.7 64206.0 10118.7 10256.6 10388.0 10493.6 10583.4 14459.8 14507.2 14527.7 14585.4 14594.0 7146.9 7300.9 7325.5 7383.5 7408.2 6852.5 6893.4 6947.0 6956.9 6968.2 4549.4 4577.4 4592.8 4597.4 4612.8 1709.4 1755.0 1858.0 1863.6 1870.1 839.9 861.3 927.6 950.2 955.6 16603.4 17070.7 17266.4 17386.2 17729.2 907.2 907.5 917.3 935.8 937.9 9275.4 9923.0 9971.9 9978.9 10145.9 339073.0 352161.0 392428.0 411578.0 419113.0 72264.3 75511.0 76938.9 76946.0 77147.0 959.2 964.8 966.0 979.0 981.2 15406.2 15469.9 15501.6 15595.4 15850.4 23516.3 27387.9 33666.8 35052.6 35574.0 43127.4 47941.3 48013.8 48131.5 48268.3 7739.1 7787.8 7840.9 7872.0 8042.0 7266.3 8633.5 9705.0 11853.3 12118.2 9738.4 10432.2 10464.2 10557.3 10719.6 10278.5 10286.6 10430.6 10434.2 10527.4 10588.2 10593.6 10808.9 10835.9 10854.8 7832.0 7885.4 8005.5 8140.6 8143.0 7951.4 9257.8 10444.4 10514.2 10521.4 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | [#3] mootools.html Cycles:180 Average:4795.32 Median:4935.05 stddev:2593.27 (52.5%) stddev-sans-first:2586.66 14:25:53 INFO - PROCESS | 28143 | Values: 1224.6 1404.4 1455.7 1547.1 1729.1 6231.4 7048.6 7291.0 7318.6 7516.8 7164.7 7242.1 7254.2 7265.7 7276.3 2155.4 2188.7 2189.1 2198.1 2200.2 2169.9 2190.9 2214.1 2215.1 2217.0 2163.2 2165.4 2171.9 2184.1 2200.5 2139.2 2145.4 2145.9 2148.5 2149.0 1965.2 2043.7 2044.3 2044.5 2056.3 7028.8 7191.6 7294.3 7303.9 7367.9 4424.7 4556.4 4571.0 4597.9 4602.7 2932.3 2939.8 2983.5 2999.5 3014.8 929.2 939.2 949.6 951.0 975.0 9392.5 9411.7 9536.0 9631.0 9666.4 3899.5 3987.7 4007.3 4088.9 4115.5 7857.1 7867.4 7881.1 7888.4 7893.6 4277.7 4371.1 4400.3 4418.5 4432.9 3600.6 4002.0 4061.2 4065.6 4142.1 3374.3 3398.1 3431.5 3456.9 3487.5 1033.2 1035.5 1035.8 1043.9 1046.5 735.8 780.9 849.2 852.3 852.8 4904.1 4966.0 4979.7 4986.8 5007.4 435.1 437.3 441.6 444.8 450.5 3454.1 3482.2 3499.0 3499.6 3531.3 8270.5 8766.4 8793.3 8874.3 8951.2 8797.9 8819.5 8821.0 8835.4 8850.0 6656.5 6876.0 6928.7 6966.2 6978.9 4771.5 4776.2 4793.9 4847.8 4848.1 7961.0 8102.4 8262.2 8280.3 8375.2 8166.9 8185.7 8381.4 8456.6 8549.8 5427.5 5607.6 6039.9 6105.1 6141.0 6607.1 6664.1 6668.5 6828.7 7043.1 6135.8 6404.7 6537.8 6556.4 6704.4 6294.0 6373.5 6477.4 6578.0 6584.0 6080.2 6107.9 6152.0 6162.3 6164.5 4350.4 4412.2 4500.4 4533.8 4544.3 4197.4 4473.6 4495.5 4591.3 4609.5 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | [#4] prototype.html Cycles:180 Average:4017.94 Median:4533.81 stddev:1148.96 (25.3%) stddev-sans-first:1117.87 14:25:53 INFO - PROCESS | 28143 | Values: 305.1 315.5 319.9 320.3 320.8 4598.6 4614.8 4623.0 4655.4 4662.9 4186.2 4416.8 4617.4 4619.6 4620.3 3708.9 3732.3 3737.4 3761.1 3762.6 3738.4 3742.5 3753.0 3753.8 3756.9 3504.3 3587.3 3648.0 3668.4 3718.8 3646.8 3653.0 3681.0 3684.8 3719.8 3273.6 3288.1 3291.9 3293.2 3315.1 4282.9 4297.1 4403.1 4419.1 4443.3 4102.6 4128.0 4137.3 4144.6 4159.7 4758.3 4759.5 4774.2 4790.6 4829.9 3559.6 3585.0 3592.9 3613.3 3647.6 4830.6 5079.8 5081.1 5097.0 5132.5 3554.9 3558.4 3562.6 3570.0 3570.7 3599.7 3613.2 3625.0 3635.9 3655.7 3891.6 4115.5 4140.6 4145.9 4151.6 4854.2 4877.9 4880.2 4887.7 4918.4 1150.9 1197.1 1201.9 1205.6 1214.3 872.0 889.2 904.0 914.1 919.6 4021.2 4062.9 4071.4 4085.4 4087.5 4570.4 4765.2 4822.3 4822.7 4842.9 3967.0 4004.0 4016.6 4054.2 4070.5 2493.8 2505.9 2521.6 2535.5 2561.2 4477.6 4502.8 4504.4 4526.4 4541.2 4758.7 4838.6 5084.2 5120.2 5178.4 4761.2 4763.3 4770.2 4778.9 4793.9 4975.6 4976.0 4983.6 4986.4 5020.7 4786.4 4923.7 4970.4 4979.5 4986.3 4764.4 4781.0 4783.8 4785.6 4815.2 3573.7 3586.1 3587.5 3594.8 3615.9 4899.6 4919.7 4990.3 4998.8 5043.4 4836.7 4851.1 4852.6 4854.6 4858.3 4847.7 4847.8 4864.2 4885.6 4886.5 4555.4 4570.7 4761.2 4771.1 4788.1 4815.7 4824.5 4856.3 4858.7 4867.5 4656.2 4778.6 4779.2 4781.9 4822.6 14:25:53 INFO - PROCESS | 28143 | 14:25:53 INFO - PROCESS | 28143 | [#5] yui.html Cycles:180 Average:12078.26 Median:604.79 stddev:14087.19 (2329.3%) stddev-sans-first:14101.04 14:25:53 INFO - PROCESS | 28143 | Values: 754.8 781.0 786.9 802.2 832.1 10790.6 11053.9 11170.8 11183.7 11201.9 12472.7 12990.1 13030.2 13182.5 13196.7 661.5 837.6 857.6 858.1 859.6 856.6 864.7 866.0 867.6 868.7 900.8 901.2 904.7 908.0 909.2 687.2 880.2 899.3 899.7 903.2 667.1 669.0 670.0 670.2 670.3 11216.1 11223.9 11255.1 11291.3 11292.5 10555.9 10967.0 11008.0 11215.3 11259.2 10187.8 10197.3 10257.7 10324.8 10337.8 3944.1 3970.6 4017.5 4054.1 4066.9 44204.9 44526.0 44580.0 44833.8 45188.8 8551.1 8691.7 8792.5 8829.3 9079.3 14345.2 15987.1 16090.6 16141.6 16152.6 6336.7 6385.6 6397.5 6557.4 6699.1 3381.9 3499.1 3511.7 3562.5 3573.7 2769.6 2862.7 2863.2 2868.6 2872.0 536.3 563.9 587.1 592.8 613.0 413.7 566.8 596.6 636.8 643.8 7379.3 7501.9 7692.0 7972.9 8054.3 529.0 551.4 640.5 653.4 656.1 3493.5 3551.4 3651.0 3693.0 3826.8 49163.3 50320.5 50382.5 50413.2 50627.7 43985.0 45225.5 45759.8 46257.1 46440.8 41177.6 41693.0 41983.8 42493.4 42515.1 6939.3 7016.2 7026.9 7028.3 7062.3 27991.6 28178.6 28558.9 28758.1 28986.0 36110.0 38156.2 38469.6 38472.8 39169.8 9271.9 9427.7 9438.7 9466.0 9570.4 9777.7 9905.1 9946.2 10027.8 10140.2 8949.6 9114.5 9141.0 9146.1 9228.7 8844.9 8955.2 9032.6 9055.3 9306.2 8873.3 8988.0 9028.7 9034.1 9054.4 7791.7 7883.5 8043.8 8123.8 8248.1 8075.0 8292.8 8383.2 8497.5 8515.5 14:25:53 INFO - PROCESS | 28143 | -------- Summary: end -------- 14:25:53 INFO - PROCESS | 28143 | 14:25:54 INFO - TEST-INFO | 28143: exit 0 14:25:54 INFO - TEST-OK | dromaeo_css | took 1117066ms 14:25:54 INFO - TEST-START | kraken 14:25:54 INFO - operating with platform_type : linux_ 14:25:54 INFO - Initialising browser for kraken test... 14:25:54 INFO - TEST-INFO | started process 28322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVyOun3/profile http://localhost:35781/getInfo.html) 14:25:58 INFO - PROCESS | 28322 | __metrics Screen width/height:1600/1200 14:25:58 INFO - PROCESS | 28322 | colorDepth:24 14:25:58 INFO - PROCESS | 28322 | Browser inner width/height: 1024/697 14:25:58 INFO - PROCESS | 28322 | __metrics 14:25:59 ERROR - PROCESS | 28322 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:25:59 INFO - TEST-INFO | 28322: exit 0 14:25:59 INFO - Browser initialized. 14:25:59 INFO - Running cycle 1/1 for kraken test... 14:25:59 INFO - TEST-INFO | started process 28401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVyOun3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:11 INFO - PROCESS | 28401 | RSS: Main: 152743936 14:26:11 INFO - PROCESS | 28401 | 14:26:14 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35781/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:15 INFO - PROCESS | 28401 | RSS: Main: 208146432 14:26:15 INFO - PROCESS | 28401 | 14:26:17 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35781/tests/kraken/driver.html?testName=audio-dft) 14:26:18 INFO - PROCESS | 28401 | RSS: Main: 196362240 14:26:18 INFO - PROCESS | 28401 | 14:26:21 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35781/tests/kraken/driver.html?testName=audio-fft) 14:26:22 INFO - PROCESS | 28401 | RSS: Main: 266141696 14:26:22 INFO - PROCESS | 28401 | 14:26:24 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35781/tests/kraken/driver.html?testName=audio-oscillator) 14:26:25 INFO - PROCESS | 28401 | RSS: Main: 174632960 14:26:25 INFO - PROCESS | 28401 | 14:26:27 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35781/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:28 INFO - PROCESS | 28401 | RSS: Main: 178688000 14:26:28 INFO - PROCESS | 28401 | 14:26:31 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35781/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:32 INFO - PROCESS | 28401 | RSS: Main: 214585344 14:26:32 INFO - PROCESS | 28401 | 14:26:35 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35781/tests/kraken/driver.html?testName=imaging-desaturate) 14:26:36 INFO - PROCESS | 28401 | RSS: Main: 213585920 14:26:36 INFO - PROCESS | 28401 | 14:26:39 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35781/tests/kraken/driver.html?testName=json-parse-financial) 14:26:40 INFO - PROCESS | 28401 | RSS: Main: 214392832 14:26:40 INFO - PROCESS | 28401 | 14:26:41 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35781/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:26:42 INFO - PROCESS | 28401 | RSS: Main: 209821696 14:26:42 INFO - PROCESS | 28401 | 14:26:44 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:26:44 INFO - PROCESS | 28401 | RSS: Main: 210374656 14:26:44 INFO - PROCESS | 28401 | 14:26:47 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:47 INFO - PROCESS | 28401 | RSS: Main: 211910656 14:26:47 INFO - PROCESS | 28401 | 14:26:50 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:51 INFO - PROCESS | 28401 | RSS: Main: 217124864 14:26:51 INFO - PROCESS | 28401 | 14:26:54 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:55 INFO - PROCESS | 28401 | RSS: Main: 216457216 14:26:55 INFO - PROCESS | 28401 | 14:26:56 INFO - PROCESS | 28401 | Cycle 1(1): loaded http://localhost:35781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35781/tests/kraken/driver.html?testName=ai-astar) 14:26:57 INFO - PROCESS | 28401 | RSS: Main: 262238208 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | __start_tp_report 14:26:57 INFO - PROCESS | 28401 | _x_x_mozilla_page_load 14:26:57 INFO - PROCESS | 28401 | _x_x_mozilla_page_load_details 14:26:57 INFO - PROCESS | 28401 | |i|pagename|runs| 14:26:57 INFO - PROCESS | 28401 | |0;ai-astar;119;113;116;117;116;116;117;117;117;119 14:26:57 INFO - PROCESS | 28401 | |1;audio-beat-detection;159;140;159;214;144;162;160;145;186;142 14:26:57 INFO - PROCESS | 28401 | |2;audio-dft;163;167;164;164;165;163;165;164;165;163 14:26:57 INFO - PROCESS | 28401 | |3;audio-fft;77;77;78;149;79;78;79;77;127;78 14:26:57 INFO - PROCESS | 28401 | |4;audio-oscillator;95;94;150;94;94;94;122;94;93;117 14:26:57 INFO - PROCESS | 28401 | |5;imaging-gaussian-blur;117;118;118;120;119;117;118;118;117;118 14:26:57 INFO - PROCESS | 28401 | |6;imaging-darkroom;148;148;148;147;148;149;149;149;147;149 14:26:57 INFO - PROCESS | 28401 | |7;imaging-desaturate;96;95;96;96;97;97;97;97;97;96 14:26:57 INFO - PROCESS | 28401 | |8;json-parse-financial;67;65;67;66;67;66;66;66;65;67 14:26:57 INFO - PROCESS | 28401 | |9;json-stringify-tinderbox;65;65;65;64;64;65;65;65;64;64 14:26:57 INFO - PROCESS | 28401 | |10;stanford-crypto-aes;86;90;88;90;86;89;87;87;169;91 14:26:57 INFO - PROCESS | 28401 | |11;stanford-crypto-ccm;162;143;141;155;154;147;153;157;160;142 14:26:57 INFO - PROCESS | 28401 | |12;stanford-crypto-pbkdf2;182;179;181;182;180;182;177;180;177;184 14:26:57 INFO - PROCESS | 28401 | |13;stanford-crypto-sha256-iterative;72;71;72;71;73;70;70;69;68;69 14:26:57 INFO - PROCESS | 28401 | __end_tp_report 14:26:57 INFO - PROCESS | 28401 | __start_cc_report 14:26:57 INFO - PROCESS | 28401 | _x_x_mozilla_cycle_collect,1939 14:26:57 INFO - PROCESS | 28401 | __end_cc_report 14:26:57 INFO - PROCESS | 28401 | __startTimestamp1462829217209__endTimestamp 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | ------- Summary: start ------- 14:26:57 INFO - PROCESS | 28401 | Number of tests: 14 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#0] ai-astar Cycles:10 Average:116.70 Median:117.00 stddev:1.70 (1.5%) stddev-sans-first:1.59 14:26:57 INFO - PROCESS | 28401 | Values: 119.0 113.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 119.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#1] audio-beat-detection Cycles:10 Average:161.10 Median:159.50 stddev:23.07 (14.5%) stddev-sans-first:24.46 14:26:57 INFO - PROCESS | 28401 | Values: 159.0 140.0 159.0 214.0 144.0 162.0 160.0 145.0 186.0 142.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 14:26:57 INFO - PROCESS | 28401 | Values: 163.0 167.0 164.0 164.0 165.0 163.0 165.0 164.0 165.0 163.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#3] audio-fft Cycles:10 Average:89.90 Median:78.00 stddev:25.89 (33.2%) stddev-sans-first:27.03 14:26:57 INFO - PROCESS | 28401 | Values: 77.0 77.0 78.0 149.0 79.0 78.0 79.0 77.0 127.0 78.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:94.00 stddev:19.17 (20.4%) stddev-sans-first:20.00 14:26:57 INFO - PROCESS | 28401 | Values: 95.0 94.0 150.0 94.0 94.0 94.0 122.0 94.0 93.0 117.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 14:26:57 INFO - PROCESS | 28401 | Values: 117.0 118.0 118.0 120.0 119.0 117.0 118.0 118.0 117.0 118.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 14:26:57 INFO - PROCESS | 28401 | Values: 148.0 148.0 148.0 147.0 148.0 149.0 149.0 149.0 147.0 149.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 14:26:57 INFO - PROCESS | 28401 | Values: 96.0 95.0 96.0 96.0 97.0 97.0 97.0 97.0 97.0 96.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 14:26:57 INFO - PROCESS | 28401 | Values: 67.0 65.0 67.0 66.0 67.0 66.0 66.0 66.0 65.0 67.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 14:26:57 INFO - PROCESS | 28401 | Values: 65.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 64.0 64.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#10] stanford-crypto-aes Cycles:10 Average:96.30 Median:88.50 stddev:25.60 (28.9%) stddev-sans-first:26.88 14:26:57 INFO - PROCESS | 28401 | Values: 86.0 90.0 88.0 90.0 86.0 89.0 87.0 87.0 169.0 91.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:154.50 stddev:7.65 (5.0%) stddev-sans-first:7.08 14:26:57 INFO - PROCESS | 28401 | Values: 162.0 143.0 141.0 155.0 154.0 147.0 153.0 157.0 160.0 142.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:181.50 stddev:2.27 (1.3%) stddev-sans-first:2.33 14:26:57 INFO - PROCESS | 28401 | Values: 182.0 179.0 181.0 182.0 180.0 182.0 177.0 180.0 177.0 184.0 14:26:57 INFO - PROCESS | 28401 | 14:26:57 INFO - PROCESS | 28401 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:1.58 (2.2%) stddev-sans-first:1.58 14:26:57 INFO - PROCESS | 28401 | Values: 72.0 71.0 72.0 71.0 73.0 70.0 70.0 69.0 68.0 69.0 14:26:57 INFO - PROCESS | 28401 | -------- Summary: end -------- 14:26:57 INFO - PROCESS | 28401 | 14:26:58 INFO - TEST-INFO | 28401: exit 0 14:26:58 INFO - TEST-OK | kraken | took 63972ms 14:26:58 INFO - SUITE-END | took 1181s 14:26:58 INFO - Completed test suite (00:19:41) 14:26:58 INFO - javascript benchmark 14:26:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2656.04382422328, 2656.5616673248915, 2682.9463410731787, 2686.7313268673133, 2694.070545661746, 4547.317902314654, 4597.494275629687, 4712.03403302323, 4755.215389460744, 4820.975895120524, 4638.350630911675, 4730.692504987173, 4733.124371991175, 4773.80904763809, 4774.140654682155, 4312.374705667684, 4321.567843215685, 4352.39066530686, 4458.0, 4459.799309031101, 4338.761368124768, 4438.844640437585, 4441.0, 4482.193205223075, 4496.168208881351, 4182.91634167318, 4231.428757117811, 4301.032267739764, 4332.805023773938, 4353.76054317014, 4258.53156152823, 4286.742795432284, 4288.614024737789, 4325.589069038468, 4352.978235108836, 4258.148370325947, 4313.676474264411, 4322.524522302544, 4329.090890912912, 4392.648588112943, 4433.578810013044, 4609.400777898852, 4615.699979501355, 4619.353290539327, 4627.097715945392, 4953.777080031371, 4988.226824842155, 5000.82497112603, 5043.218301163325, 5070.188769796815, 5014.498550144956, 5038.319826823368, 5059.2916991621205, 5062.645614806965, 5100.795968161269, 4612.561806628365, 4696.671233013656, 4740.0, 4753.643476739258, 4774.40319960005, 5111.8722031948755, 5126.948730512721, 5189.818356357509, 5204.271402003723, 5211.374635043743, 4909.803607855646, 4921.680090794087, 4927.113119638428, 4973.204287314013, 4975.253711943165, 4807.95192048082, 4813.687110337817, 4988.0, 5013.047520971004, 5063.367079115111, 4972.0801651694555, 4977.875553111201, 4981.227909674007, 4983.9252411213865, 5067.543921047123, 4978.0292842896015, 4981.277714731344, 5007.599392048627, 5009.499050094962, 5018.799248030111, 4186.5604111568455, 4268.893277668083, 4274.273373526508, 4274.636655884223, 4337.956620433818, 3710.9072273193387, 3727.2731817295366, 3761.4169803680475, 3782.4893639358884, 3803.6386543278345, 4279.87160385189, 4322.394864718942, 4324.675649326313, 4325.1565944641125, 4342.956570434255, 4867.610591152699, 4956.504349565087, 4986.052649996489, 4994.225894986283, 5032.672876263031, 4220.451341325608, 4252.107057517894, 4255.319148936217, 4273.700840941105, 4296.548862369406, 4525.796339164745, 4538.410006699108, 4542.727436353829, 4592.425946756655, 4598.126355992351, 4618.399608050931, 4620.953790462052, 4659.184642687584, 4666.0, 4673.485916549245, 4954.355933728592, 4960.677555958851, 4967.577755890645, 4978.228374601942, 5002.499750024968, 4637.188492013952, 4651.534846515321, 4661.510541393105, 4686.992296656235, 4727.739974301447, 4951.702897826142, 4993.700377977188, 5003.824866129668, 5019.02129084825, 5034.597232221487, 5077.949220507895, 5107.744612769421, 5109.897802044013, 5110.9233361500355, 5151.5106064923775, 4662.277347011219, 4883.0, 4923.950760492349, 4949.183384741477, 4982.2775697524385, 4906.582940449959, 4912.48418916023, 4939.654224204415, 4968.826091086795, 4973.701577905337, 4839.927401088916, 4904.5340692634145, 4934.18585933317, 4958.727270000185, 4958.776855041604, 4802.207635740064, 4946.356973593553, 4969.900601988013, 5049.9495005049475, 5058.949410505995, 4664.300354946785, 4703.9529604704885, 4816.325714400057, 4837.129316723023, 4873.147199240189], "value": 4614.059880944322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9061910224623, 552.4834279948246, 572.3418069220397, 580.2514755964805, 586.9765209391625, 40968.385474217874, 42431.36352954708, 42445.78777106114, 46704.532954670445, 46946.29580556294, 42918.0, 43495.56504434955, 43596.78201608988, 43654.345184822254, 43850.342244866275, 7849.0, 7923.920760792376, 7925.2867241948215, 7940.364770818321, 7971.202879712011, 7668.233176682343, 7727.265909738566, 7757.534547927143, 7769.300762931335, 7794.337481314095, 7800.648970796299, 7802.921970780305, 7806.843863122735, 7828.491148075385, 7851.5681637509915, 7735.574543400111, 7763.37892968564, 7765.495242809199, 7769.028871391076, 7771.028621422322, 7804.72683456082, 7834.647440865175, 7847.607619619053, 7870.370370370357, 7929.72245971394, 37637.0, 39779.8011009946, 39921.20157596832, 39967.40048899269, 40110.0, 3368.0569440556683, 3381.509681096252, 3402.2344972381266, 3481.3211423772373, 3726.925461490755, 28779.59384358665, 29593.55609665857, 30493.542596861065, 30892.073237802902, 30896.0, 3026.273694313371, 3046.6800985896384, 3094.798838075518, 3095.148834070626, 3146.7482601391835, 236208.0, 238607.0, 238863.0, 240008.0, 242296.0, 33389.83305083459, 33760.0, 54929.72535137379, 56154.43845561574, 56316.0, 34916.65083349134, 35088.82455587706, 35129.64870351264, 35139.29721405557, 35280.470792938126, 12609.0, 12797.424115914806, 12854.421551030038, 12871.935640321739, 12872.292023938586, 10009.349392289478, 10146.949265253626, 10157.730283714536, 10177.949110254402, 10194.0, 8303.95848020756, 8329.958755155605, 8352.081271060179, 8393.32853371741, 8408.285295749929, 3224.1456014156265, 3251.6098068231963, 3256.316173603522, 3256.3812875553567, 3279.4588892832417, 904.4347282948157, 967.8675949139524, 981.7545613596601, 1008.606643409071, 1033.560736686905, 28130.43739125206, 28234.71765282321, 28925.855370723013, 28964.71035289662, 28966.710332896822, 988.614440368257, 1005.2962925951863, 1015.243643485608, 1068.060107105742, 1075.9784804304027, 14783.556493305217, 15276.541703748906, 15390.461333853262, 15482.303296351465, 15538.689226215638, 365685.0, 366936.0, 370776.0, 370966.0, 373965.0, 51042.0, 51491.0, 51622.48377516252, 51748.74125629348, 51766.74116629393, 1082.6319051522362, 1103.5144536404116, 1199.0407673860877, 1256.214865708932, 1261.1550261324935, 28776.712232877402, 29167.7083229165, 29304.853475732485, 29652.703472964993, 30085.3982920336, 37484.43773343456, 37958.24083518259, 37999.620003800715, 38252.617473826016, 38325.44281079284, 279480.0, 281437.0, 282704.0, 283224.0, 284110.0, 22842.657360139943, 25465.344752591023, 25698.486030279662, 26466.338341541614, 26554.0, 43343.0, 43393.3490997629, 43512.12975740531, 44231.33652995143, 44671.77664111659, 35700.821495892356, 36463.27073458569, 36670.0, 36750.44874326941, 36780.63219367879, 36559.81720091489, 36824.44763328499, 37238.25523489461, 37290.254194916495, 37383.439248411836, 36177.638223617425, 36478.8176059118, 37275.0, 37388.813055934545, 37423.0, 30763.0, 33055.173620659676, 33179.0, 33679.66320336863, 33761.15597110092, 24758.50482990294, 24917.50164996726, 25063.87468062648, 25181.05572285423, 25603.615945760455], "value": 16584.294698609603, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.27748999411114, 378.9204267103908, 380.7468033757551, 393.2194593731443, 396.3341586135295, 15637.983531070488, 16461.34154633813, 17348.21933013014, 17540.298388064493, 17555.38556150535, 17070.658586828256, 17131.914340428313, 17192.82807171928, 17619.0, 17785.288588456446, 5015.348004759376, 5133.435322114565, 5159.174532074869, 5197.714125723083, 5199.610029247802, 3650.7627004244773, 5606.803761868336, 5931.139984702216, 5945.524358051367, 6017.097435384705, 5958.285005799288, 5970.97014514929, 5980.700964951757, 5997.49021333185, 6008.399160083978, 5744.31068271808, 5873.207117039187, 5914.645121292736, 5986.431289027535, 5992.910106348409, 3276.639569647337, 4859.781309841065, 5199.740012999373, 5215.765290561933, 5327.653702509325, 21009.68485472719, 21077.367678969655, 21537.138514459402, 21555.67666485004, 21600.243991460222, 1936.070686070694, 2017.0923084611984, 2023.6660950943076, 2037.3480486244407, 2048.354768248012, 13149.474021039146, 13276.402561884643, 13308.73382532344, 13326.933365333209, 13840.446382144703, 1751.4964845674322, 1801.9008954507497, 1815.8728888977778, 1847.75055367525, 1854.5641774183057, 59405.7029714853, 63531.36468635301, 63639.0, 64032.67983660052, 64206.0, 10118.747031324276, 10256.641017564349, 10388.0, 10493.580256789795, 10583.364998099985, 14459.78310325346, 14507.202103884176, 14527.709445811235, 14585.41658333676, 14593.978421510392, 7146.857062858714, 7300.853982920418, 7325.450591205575, 7383.520071195355, 7408.222136675679, 6852.45180385568, 6893.448524118058, 6947.0, 6956.860862782716, 6968.163820341591, 4549.385832912514, 4577.382053422812, 4592.816287348469, 4597.448306203277, 4612.838550650711, 1709.4273418404725, 1754.97367539487, 1857.990710046441, 1863.5527473406285, 1870.1303893689499, 839.9328053755685, 861.3152543727751, 927.6289484206371, 950.1780959470009, 955.6320816485703, 16603.41888033937, 17070.658586828195, 17266.374061446986, 17386.21762020712, 17729.202185901664, 907.2288554728428, 907.4691305586174, 917.3349321741817, 935.7988032573029, 937.9437233765996, 9275.423178059746, 9922.950385248028, 9971.900280997243, 9978.900210997943, 10145.898541014643, 339073.0, 352161.0, 392428.0, 411578.0, 419113.0, 72264.2773572268, 75511.0, 76938.92244310165, 76946.0, 77147.0, 959.203860795538, 964.8456247000446, 966.0339660339661, 978.9769690673263, 981.2297346583041, 15406.229688515754, 15469.922650386676, 15501.612459688598, 15595.37618495293, 15850.44523441674, 23516.294511164007, 27387.86306068457, 33666.83166584151, 35052.64947350596, 35574.0, 43127.35308970305, 47941.28088078751, 48013.75993120012, 48131.518684812705, 48268.27597585969, 7739.148693643808, 7787.844243114992, 7840.921590784247, 7872.0, 8041.959790201012, 7266.309700578437, 8633.465363264606, 9704.980976997596, 11853.34806585646, 12118.151729378858, 9738.415695058318, 10432.165426765992, 10464.162866970471, 10557.298864050257, 10719.571217151226, 10278.537465814206, 10286.639967601099, 10430.634927777492, 10434.165266778791, 10527.420991845522, 10588.152947764007, 10593.576256949944, 10808.891911081104, 10835.891641083488, 10854.782904342026, 7832.0, 7885.369170466463, 8005.479643823133, 8140.592970351578, 8143.0, 7951.363890888831, 9257.814843703223, 10444.42555659446, 10514.211434142622, 10521.368717876952], "value": 8335.470412309953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.5714000099972, 1404.382071888369, 1455.6943041961188, 1547.1336051810986, 1729.1440736835268, 6231.408016238456, 7048.612326322057, 7290.963545182267, 7318.634068296577, 7516.849663006737, 7164.713411463548, 7242.058532390795, 7254.238304977967, 7265.673044712988, 7276.308750668692, 2155.4072630026712, 2188.73735151782, 2189.1462329691435, 2198.0658220256328, 2200.2299195281685, 2169.8698078115285, 2190.87950162741, 2214.1475531920246, 2215.1360969222014, 2217.0466699319286, 2163.1996161420216, 2165.4369863835436, 2171.913123475067, 2184.0936011555264, 2200.4938864061273, 2139.208492857645, 2145.4314606629255, 2145.8605190662556, 2148.4843637527038, 2149.03293517916, 1965.2335589120255, 2043.703662968876, 2044.2845004248543, 2044.5399785048246, 2056.3008577083715, 7028.753993610199, 7191.6404179791325, 7294.307040831112, 7303.926960730431, 7367.852642947111, 4424.7123936944, 4556.3621093047, 4570.9943812361225, 4597.885052873671, 4602.746848923308, 2932.29624890027, 2939.8236105833716, 2983.5077212260167, 2999.460097182506, 3014.849257537114, 929.2287401456774, 939.2063706168277, 949.6343907595557, 950.9524523773783, 974.9756256093655, 9392.530373481366, 9411.717648470489, 9535.951045384933, 9631.036896310383, 9666.420014799134, 3899.454076429302, 3987.6809855211513, 4007.2786898358577, 4088.897777555585, 4115.506139263308, 7857.096433910059, 7867.409944254204, 7881.133075361706, 7888.447808653454, 7893.565853878092, 4277.679174061957, 4371.147626212922, 4400.317950717644, 4418.491873434532, 4432.933505997413, 3600.6219346968714, 4001.9799901000893, 4061.1674606705556, 4065.6137666921595, 4142.130152667974, 3374.308266805299, 3398.09950363154, 3431.5024321473247, 3456.8962931112105, 3487.4943133246043, 1033.245730616639, 1035.492608621785, 1035.7651802161893, 1043.8695163104612, 1046.5395226100643, 735.8381156145639, 780.9101953275446, 849.1508491508491, 852.2627926843236, 852.7868032991752, 4904.141775189399, 4965.957148998751, 4979.701217926936, 4986.80052797884, 5007.4491805901325, 435.0580992152019, 437.34616747962, 441.55182489772903, 444.8020630819319, 450.45494951109526, 3454.136465883529, 3482.164280572644, 3498.9825050875093, 3499.61504234534, 3531.2937412517085, 8270.545120018336, 8766.386352955233, 8793.296536277083, 8874.334424918157, 8951.239144672645, 8797.912020879709, 8819.514926679094, 8820.986451164705, 8835.425697329782, 8850.0, 6656.500762442836, 6875.965620171867, 6928.653567321614, 6966.1988871280455, 6978.860422791516, 4771.4512831023485, 4776.164171270083, 4793.880152996203, 4847.75761211931, 4848.0546293472435, 7961.0, 8102.432829701865, 8262.17378262169, 8280.296174825207, 8375.162483751576, 8166.877496837434, 8185.7135000277085, 8381.413301068867, 8456.577171141294, 8549.786255343666, 5427.538659213853, 5607.635503692247, 6039.939600603938, 6105.145279660762, 6141.048137538689, 6607.075009498578, 6664.100346453167, 6668.499862510234, 6828.658567071726, 7043.119610048744, 6135.84660383494, 6404.711787969646, 6537.771178008747, 6556.377144171296, 6704.396604305636, 6294.0, 6373.458256048288, 6477.4494167996245, 6578.0, 6583.96708016476, 6080.209572755691, 6107.877842443215, 6152.0, 6162.322144564005, 6164.506839452743, 4350.412694286231, 4412.227860124402, 4500.369948207188, 4533.84131555394, 4544.341070544819, 4197.391378250198, 4473.619742321939, 4495.527969563149, 4591.265397536378, 4609.51600082], "value": 3861.767544687231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.12429327829136, 315.4826085220239, 319.9008307424697, 320.34009939524583, 320.8331667532883, 4598.551456291266, 4614.82322007888, 4622.9768851155695, 4655.441347038356, 4662.90674186516, 4186.2464756343925, 4416.845410410636, 4617.376654151689, 4619.607333376659, 4620.330052142445, 3708.8516459341727, 3732.2535492901393, 3737.4020156774923, 3761.13493896404, 3762.586115527283, 3738.439234114891, 3742.4760533525327, 3752.9812350938205, 3753.8123093845197, 3756.8773642891815, 3504.281622267442, 3587.2825434912993, 3647.9817600911956, 3668.413053911375, 3718.776873387592, 3646.8176591170336, 3652.981735091334, 3680.963190368089, 3684.7604905681046, 3719.8326075326677, 3273.639899611041, 3288.0629020729216, 3291.8683252669866, 3293.176705823544, 3315.1049216711594, 4282.907858496063, 4297.097609502009, 4403.119376124788, 4419.138268037734, 4443.289073748217, 4102.630763231324, 4128.02991297045, 4137.296659567851, 4144.6062624050965, 4159.688023398227, 4758.334582895994, 4759.547842954914, 4774.212254977924, 4790.616750659974, 4829.9275510867365, 3559.6440355964196, 3585.0, 3592.9281414371567, 3613.295407395559, 3647.635236476331, 4830.613550915953, 5079.8222062228015, 5081.110805609003, 5096.980603879202, 5132.5124113209185, 3554.87557935471, 3558.395072837624, 3562.6259242779133, 3569.982150089233, 3570.6607872252093, 3599.7480176387403, 3613.1689711366007, 3625.021244264034, 3635.8909232723063, 3655.7440979131206, 3891.591382904754, 4115.506139263308, 4140.648044916215, 4145.875623731293, 4151.626353628128, 4854.247591623304, 4877.926831097537, 4880.170371036932, 4887.682300650517, 4918.434380046269, 1150.913681473893, 1197.1440420099495, 1201.9399030048462, 1205.5840734946605, 1214.2896405602644, 872.0, 889.1686273334324, 903.9909600903907, 914.1041779056562, 919.5540163020929, 4021.195760847842, 4062.878113656595, 4071.4096456013713, 4085.428040074392, 4087.4890638670167, 4570.360149579062, 4765.237561990065, 4822.276658501182, 4822.662413631082, 4842.900543652066, 3967.016491754123, 4004.0390306326854, 4016.55817860041, 4054.2296963576828, 4070.4911886014247, 2493.800495960319, 2505.922453345043, 2521.6217567364674, 2535.530926778552, 2561.2316305108393, 4477.597016268552, 4502.797374118172, 4504.369388285642, 4526.4115664964, 4541.205289074464, 4758.666893317434, 4838.564529192389, 5084.211947148198, 5120.231965205249, 5178.378594568676, 4761.166795810719, 4763.285507173951, 4770.212914869077, 4778.928316075262, 4793.856184314476, 4975.581959141772, 4975.975120124376, 4983.626228032839, 4986.401631804207, 5020.723860187724, 4786.377770889762, 4923.655344125877, 4970.428400733817, 4979.502049794992, 4986.276989836526, 4764.404449443819, 4780.95219047819, 4783.832565860178, 4785.59322457595, 4815.15734746425, 3573.6962358199844, 3586.103474131467, 3587.4798154268005, 3594.7843129412317, 3615.8734444294323, 4899.632527560519, 4919.655624106278, 4990.276409920469, 4998.775055122455, 5043.394792624762, 4836.685615434985, 4851.126797176542, 4852.611791056636, 4854.563089321978, 4858.319835223001, 4847.660663753503, 4847.806087756591, 4864.221724524201, 4885.560299573055, 4886.462489126265, 4555.362249285036, 4570.7257564546235, 4761.214399624023, 4771.093492236464, 4788.138135135709, 4815.7351345676325, 4824.541668541483, 4856.271559266138, 4858.659893807399, 4867.537583929521, 4656.205645797204, 4778.641601879804, 4779.211430113992, 4781.9043619128115, 4822.590079843112], "value": 3663.9483485782825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.7962050246433, 781.0, 786.9213078692131, 802.2058162419203, 832.0514613340792, 10790.622328218515, 11053.889461105397, 11170.776584468325, 11183.66449006529, 11201.943990280048, 12472.688182795435, 12990.090693651448, 13030.218186908793, 13182.472701091945, 13196.670083247924, 661.5402295404696, 837.6063250272392, 857.588357588358, 858.068995140272, 859.6432480520608, 856.6316483911916, 864.7362554420899, 865.9913400866005, 867.5835598912525, 868.682930730282, 900.7522931193942, 901.2294488212582, 904.7150147703452, 907.9863802042975, 909.2044461096541, 687.1994126842247, 880.1638443478657, 899.3255058705938, 899.6716198587501, 903.1645727701849, 667.0694381338055, 669.0332469581457, 669.9665016749192, 670.2426258328106, 670.25266827487, 11216.102711783038, 11223.943880280547, 11255.099592032619, 11291.322520648788, 11292.548298068068, 10555.94722026385, 10966.978186922091, 11008.001585453512, 11215.271007384494, 11259.21185517014, 10187.796244075076, 10197.337173083726, 10257.692269231935, 10324.793504129875, 10337.844932326021, 3944.112574670705, 3970.622790834866, 4017.4978127734034, 4054.087830238173, 4066.8983275418054, 44204.90565660405, 44526.0, 44580.0, 44833.77583112096, 45188.774056129834, 8551.1448855114, 8691.739247822576, 8792.47245165292, 8829.33779966505, 9079.319051071196, 14345.211013394364, 15987.120708360919, 16090.597735056483, 16141.596460088356, 16152.596185095466, 6336.6831658416895, 6385.648789316632, 6397.52018598607, 6557.409833115043, 6699.095622090956, 3381.9323613528086, 3499.1427100360575, 3511.701505372021, 3562.5012498250267, 3573.6783689468075, 2769.584562315669, 2862.6994165612728, 2863.155369166101, 2868.6270784797844, 2871.9856400717863, 536.3028063517412, 563.9266895303584, 587.1427715535366, 592.754007087054, 613.0283500651517, 413.70420149593184, 566.7534622439252, 596.5615272774508, 636.7771280051945, 643.7553729582822, 7379.298966598165, 7501.887471687929, 7692.0, 7972.923655306459, 8054.275115239657, 529.008109794136, 551.4265164229237, 640.5388120553195, 653.4151934019027, 656.1470088884431, 3493.510908472816, 3551.4140166872176, 3650.9817450913106, 3693.0, 3826.770393776382, 49163.262551061765, 50320.49679503231, 50382.49617503851, 50413.24380134301, 50627.746861265456, 43985.0, 45225.54774452213, 45759.771201144446, 46257.074858503314, 46440.767796160806, 41177.58822411797, 41693.0, 41983.79008105001, 42493.362599561035, 42515.14969700589, 6939.30606939302, 7016.22821489646, 7026.943588262469, 7028.332308430691, 7062.329078737512, 27991.58012629853, 28178.577321339788, 28558.857205713837, 28758.137255882357, 28986.0, 36110.0, 38156.2368752629, 38469.6153038466, 38472.80763596164, 39169.804150979064, 9271.907280927375, 9427.717168484956, 9438.716838494856, 9465.952670236606, 9570.425774453555, 9777.657781977596, 9905.108540231413, 9946.204303655546, 10027.799444010932, 10140.188784897338, 8949.552522373726, 9114.498702571422, 9140.994490606161, 9146.131117543822, 9228.676996305097, 8844.867326989972, 8955.194161950069, 9032.593533291149, 9055.275577953616, 9306.162445379949, 8873.29013678917, 8987.95542006113, 9028.729138125867, 9034.096590340914, 9054.366194366332, 7791.688332466638, 7883.487573307717, 8043.83912321762, 8123.7969050771835, 8248.13394593583, 8075.0, 8292.751217463485, 8383.245507904317, 8497.490150590984, 8515.531645759544], "value": 5700.733212938736, "unit": "score"}], "name": "dromaeo_css", "value": 6098.712211177858, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 113.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 119.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 140.0, 159.0, 214.0, 144.0, 162.0, 160.0, 145.0, 186.0, 142.0], "value": 161.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 167.0, 164.0, 164.0, 165.0, 163.0, 165.0, 164.0, 165.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 149.0, 79.0, 78.0, 79.0, 77.0, 127.0, 78.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 150.0, 94.0, 94.0, 94.0, 122.0, 94.0, 93.0, 117.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 120.0, 119.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 149.0, 147.0, 149.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 88.0, 90.0, 86.0, 89.0, 87.0, 87.0, 169.0, 91.0], "value": 96.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 143.0, 141.0, 155.0, 154.0, 147.0, 153.0, 157.0, 160.0, 142.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 181.0, 182.0, 180.0, 182.0, 177.0, 180.0, 177.0, 184.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 72.0, 71.0, 73.0, 70.0, 70.0, 69.0, 68.0, 69.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1628.7, "alertThreshold": 2.0}]} 14:26:58 INFO - Return code: 0 14:26:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:26:58 ERROR - # TBPL SUCCESS # 14:26:58 INFO - Running post-action listener: _resource_record_post_action 14:26:58 INFO - ##### 14:26:58 INFO - ##### Finished run-tests step (success) 14:26:58 INFO - ##### 14:26:58 INFO - Running post-run listener: _resource_record_post_run 14:26:59 INFO - Total resource usage - Wall time: 1198s; CPU: 26.0%; Read bytes: 8192; Write bytes: 520417280; Read time: 224; Write time: 444184 14:26:59 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 235098112; Read time: 0; Write time: 229640 14:26:59 INFO - run-tests - Wall time: 1183s; CPU: 26.0%; Read bytes: 8192; Write bytes: 285319168; Read time: 224; Write time: 214544 14:26:59 INFO - Running post-run listener: _upload_blobber_files 14:26:59 INFO - Blob upload gear active. 14:26:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:59 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 14:26:59 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'] 14:26:59 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 14:26:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:26:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:27:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:00 INFO - (blobuploader) - INFO - Done attempting. 14:27:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:27:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:01 INFO - (blobuploader) - INFO - Done attempting. 14:27:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:01 INFO - Return code: 0 14:27:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:27:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b40ec6ebcf69b9a26b34a82b22f4fde093136d5d1d825d7bca77075915341ea63bd1cbbf78a9552cc242404b5fe76ab895bf0e6dbd0fb5505a1cce9893c9959", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9a0b59ca5edfbad801f63a6f564f4e2696de3cbd329abaebebcc318de1b237ef8e99f152bb27c079000e00633de8e0ccb7fde811f0979fb9a598a490c3c6642"} 14:27:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:27:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:27:01 INFO - Contents: 14:27:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b40ec6ebcf69b9a26b34a82b22f4fde093136d5d1d825d7bca77075915341ea63bd1cbbf78a9552cc242404b5fe76ab895bf0e6dbd0fb5505a1cce9893c9959", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9a0b59ca5edfbad801f63a6f564f4e2696de3cbd329abaebebcc318de1b237ef8e99f152bb27c079000e00633de8e0ccb7fde811f0979fb9a598a490c3c6642"} 14:27:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:01 INFO - Copying logs to upload dir... 14:27:01 INFO - mkdir: /builds/slave/test/build/upload/logs 14:27:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.125479 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-09 14:27:01.430349) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 14:27:01.434045) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b40ec6ebcf69b9a26b34a82b22f4fde093136d5d1d825d7bca77075915341ea63bd1cbbf78a9552cc242404b5fe76ab895bf0e6dbd0fb5505a1cce9893c9959", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9a0b59ca5edfbad801f63a6f564f4e2696de3cbd329abaebebcc318de1b237ef8e99f152bb27c079000e00633de8e0ccb7fde811f0979fb9a598a490c3c6642"} build_url:https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005375 build_url: 'https://queue.taskcluster.net/v1/task/FkvqVj_bSP25osVVoVUzJQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b40ec6ebcf69b9a26b34a82b22f4fde093136d5d1d825d7bca77075915341ea63bd1cbbf78a9552cc242404b5fe76ab895bf0e6dbd0fb5505a1cce9893c9959", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b9a0b59ca5edfbad801f63a6f564f4e2696de3cbd329abaebebcc318de1b237ef8e99f152bb27c079000e00633de8e0ccb7fde811f0979fb9a598a490c3c6642"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 14:27:01.448890) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:27:01.449171) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462827982.67064-2123503280 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002208 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:27:01.528883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 14:27:01.529148) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 14:27:01.529417) ========= ========= Total master_lag: 0.15 =========