builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1461430093.22 results: success (0) buildid: 20160423090652 builduid: 9592fd3c8dd54344847d320615434aff revision: e5962142ff0a538f42abfd5518cbb2477e987dd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.220260) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.220727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.221000) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.299340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.299596) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 09:48:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-04-23 09:48:13 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.443076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.443358) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015775 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.493096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:13.493397) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e5962142ff0a538f42abfd5518cbb2477e987dd8 --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 e5962142ff0a538f42abfd5518cbb2477e987dd8 --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=9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 09:48:13,754 truncating revision to first 12 chars 2016-04-23 09:48:13,754 Setting DEBUG logging. 2016-04-23 09:48:13,754 attempt 1/10 2016-04-23 09:48:13,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e5962142ff0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 09:48:14,146 unpacking tar archive at: fx-team-e5962142ff0a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.702781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:14.208878) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:14.209169) ========= script_repo_revision: e5962142ff0a538f42abfd5518cbb2477e987dd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:14.209547) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:14.209944) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 09:48:14.219004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-23 09:48:14.219283) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:14 INFO - MultiFileLogger online at 20160423 09:48:14 in /builds/slave/test 09:48:14 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 09:48:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:14 INFO - {'append_to_log': False, 09:48:14 INFO - 'base_work_dir': '/builds/slave/test', 09:48:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:48:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:14 INFO - 'branch': 'Fx-Team-Non-PGO', 09:48:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:14 INFO - 'config_files': ('talos/linux_config.py',), 09:48:14 INFO - 'default_actions': ('clobber', 09:48:14 INFO - 'read-buildbot-config', 09:48:14 INFO - 'download-and-extract', 09:48:14 INFO - 'populate-webroot', 09:48:14 INFO - 'create-virtualenv', 09:48:14 INFO - 'install', 09:48:14 INFO - 'run-tests'), 09:48:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:14 INFO - 'download_minidump_stackwalk': True, 09:48:14 INFO - 'download_symbols': 'ondemand', 09:48:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:14 INFO - 'installer_path': 'installer.exe', 09:48:14 INFO - 'log_level': 'info', 09:48:14 INFO - 'log_name': 'talos', 09:48:14 INFO - 'log_to_console': True, 09:48:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:14 INFO - 'opt_config_files': (), 09:48:14 INFO - 'pip_index': False, 09:48:14 INFO - 'sps_profile': False, 09:48:14 INFO - 'sps_profile_interval': 0, 09:48:14 INFO - 'suite': 'dromaeojs', 09:48:14 INFO - 'system_bits': '32', 09:48:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:14 INFO - 'title': 'talos-linux64-ix-040', 09:48:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:14 INFO - 'use_talos_json': True, 09:48:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:14 INFO - 'work_dir': 'build'} 09:48:14 INFO - ##### 09:48:14 INFO - ##### Running clobber step. 09:48:14 INFO - ##### 09:48:14 INFO - Running pre-action listener: _resource_record_pre_action 09:48:14 INFO - Running main action method: clobber 09:48:14 INFO - rmtree: /builds/slave/test/build 09:48:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:15 INFO - Running post-action listener: _resource_record_post_action 09:48:15 INFO - ##### 09:48:15 INFO - ##### Running read-buildbot-config step. 09:48:15 INFO - ##### 09:48:15 INFO - Running pre-action listener: _resource_record_pre_action 09:48:15 INFO - Running main action method: read_buildbot_config 09:48:15 INFO - Using buildbot properties: 09:48:15 INFO - { 09:48:15 INFO - "project": "", 09:48:15 INFO - "product": "firefox", 09:48:15 INFO - "script_repo_revision": "production", 09:48:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:48:15 INFO - "repository": "", 09:48:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:48:15 INFO - "buildid": "20160423090652", 09:48:15 INFO - "pgo_build": "False", 09:48:15 INFO - "basedir": "/builds/slave/test", 09:48:15 INFO - "buildnumber": 2872, 09:48:15 INFO - "slavename": "talos-linux64-ix-040", 09:48:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:48:15 INFO - "platform": "ubuntu64_hw", 09:48:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:48:15 INFO - "branch": "fx-team", 09:48:15 INFO - "repo_path": "integration/fx-team", 09:48:15 INFO - "revision": "e5962142ff0a538f42abfd5518cbb2477e987dd8", 09:48:15 INFO - "stage_platform": "linux64", 09:48:15 INFO - "builduid": "9592fd3c8dd54344847d320615434aff", 09:48:15 INFO - "slavebuilddir": "test" 09:48:15 INFO - } 09:48:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 09:48:15 INFO - Running post-action listener: _resource_record_post_action 09:48:15 INFO - ##### 09:48:15 INFO - ##### Running download-and-extract step. 09:48:15 INFO - ##### 09:48:15 INFO - Running pre-action listener: _resource_record_pre_action 09:48:15 INFO - Running main action method: download_and_extract 09:48:15 INFO - mkdir: /builds/slave/test/build/tests 09:48: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')]} 09:48:15 INFO - https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:48:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:48:23 INFO - Downloaded 1361 bytes. 09:48:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 09:48:23 INFO - Using the following test package requirements: 09:48:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:48:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:48:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'jsshell-linux-x86_64.zip'], 09:48:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:48:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 09:48:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:48:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:48:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:48:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 09:48:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:48:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:23 INFO - https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:27 INFO - Downloaded 22285608 bytes. 09:48:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:29 INFO - Return code: 0 09:48:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:48:29 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')]} 09:48:29 INFO - https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:48:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 09:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:48:33 INFO - Downloaded 22285608 bytes. 09:48:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:48:34 INFO - Return code: 0 09:48: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')]} 09:48:34 INFO - https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:48:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 09:48:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:48:35 INFO - Downloaded 10840145 bytes. 09:48:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:48:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:48:35 INFO - Return code: 0 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:35 INFO - https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:48:36 INFO - Downloaded 54749507 bytes. 09:48:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:36 INFO - mkdir: /builds/slave/test/properties 09:48:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:36 INFO - Contents: 09:48:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 09:48:37 INFO - Running post-action listener: _resource_record_post_action 09:48:37 INFO - Running post-action listener: set_extra_try_arguments 09:48:37 INFO - ##### 09:48:37 INFO - ##### Running populate-webroot step. 09:48:37 INFO - ##### 09:48:37 INFO - Running pre-action listener: _resource_record_pre_action 09:48:37 INFO - Running main action method: populate_webroot 09:48:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:37 INFO - '--tppagecycles', 09:48:37 INFO - '7'], 09:48:37 INFO - 'tests': ['tsvgm']}}, 09:48:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['damp', 'tps']}, 09:48:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'tests': ['damp', 'tps']}, 09:48:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['dromaeo_dom']}, 09:48:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['a11yr', 09:48:37 INFO - 'ts_paint', 09:48:37 INFO - 'tpaint', 09:48:37 INFO - 'sessionrestore', 09:48:37 INFO - 'sessionrestore_no_auto_restore', 09:48:37 INFO - 'tabpaint']}, 09:48:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:37 INFO - 'ts_paint', 09:48:37 INFO - 'tpaint', 09:48:37 INFO - 'sessionrestore', 09:48:37 INFO - 'sessionrestore_no_auto_restore', 09:48:37 INFO - 'tabpaint']}, 09:48:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:37 INFO - 'ts_paint', 09:48:37 INFO - 'tpaint', 09:48:37 INFO - 'sessionrestore', 09:48:37 INFO - 'sessionrestore_no_auto_restore', 09:48:37 INFO - 'tabpaint']}, 09:48:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:37 INFO - 'ts_paint', 09:48:37 INFO - 'tpaint', 09:48:37 INFO - 'sessionrestore', 09:48:37 INFO - 'sessionrestore_no_auto_restore', 09:48:37 INFO - 'tabpaint']}, 09:48:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['a11yr', 09:48:37 INFO - 'ts_paint', 09:48:37 INFO - 'tpaint', 09:48:37 INFO - 'sessionrestore', 09:48:37 INFO - 'sessionrestore_no_auto_restore', 09:48:37 INFO - 'tabpaint']}, 09:48:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['a11yr', 09:48:37 INFO - 'ts_paint', 09:48:37 INFO - 'tpaint', 09:48:37 INFO - 'sessionrestore', 09:48:37 INFO - 'sessionrestore_no_auto_restore', 09:48:37 INFO - 'tabpaint']}, 09:48:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['tsvgx', 09:48:37 INFO - 'tsvgr_opacity', 09:48:37 INFO - 'tart', 09:48:37 INFO - 'tscrollx', 09:48:37 INFO - 'cart']}, 09:48:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:37 INFO - 'tsvgr_opacity', 09:48:37 INFO - 'tart', 09:48:37 INFO - 'tscrollx', 09:48:37 INFO - 'cart']}, 09:48:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'talos_options': ['--disable-e10s'], 09:48:37 INFO - 'tests': ['tp5o']}, 09:48:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'tests': ['tp5o']}, 09:48:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'talos_options': ['--disable-e10s', 09:48:37 INFO - '--xperf_path', 09:48:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:37 INFO - 'tests': ['tp5n']}, 09:48:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:37 INFO - 'talos_options': ['--xperf_path', 09:48:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:37 INFO - 'tests': ['tp5n']}}, 09:48:37 INFO - 'talos.zip': {'path': '', 09:48:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:37 INFO - Running post-action listener: _resource_record_post_action 09:48:37 INFO - ##### 09:48:37 INFO - ##### Running create-virtualenv step. 09:48:37 INFO - ##### 09:48:37 INFO - Running pre-action listener: _resource_record_pre_action 09:48:37 INFO - Running main action method: create_virtualenv 09:48:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:37 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 09:48:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:37 INFO - Using real prefix '/usr' 09:48:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:40 INFO - Installing pip.................done. 09:48:40 INFO - Return code: 0 09:48:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:40 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 09:48:40 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 09:48:40 INFO - Using env: {'DISPLAY': ':0', 09:48:40 INFO - 'HOME': '/home/cltbld', 09:48:40 INFO - 'LANG': 'en_US.UTF-8', 09:48:40 INFO - 'LANGUAGE': 'en_US:en', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MAIL': '/var/mail/cltbld', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SHLVL': '1', 09:48:40 INFO - 'TERM': 'linux', 09:48:40 INFO - 'TMOUT': '86400', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - '_': '/tools/buildbot/bin/python'} 09:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:40 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 09:48:40 INFO - Cleaning up... 09:48:40 INFO - Return code: 0 09:48:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:40 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 09:48:40 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 09:48:40 INFO - Using env: {'DISPLAY': ':0', 09:48:40 INFO - 'HOME': '/home/cltbld', 09:48:40 INFO - 'LANG': 'en_US.UTF-8', 09:48:40 INFO - 'LANGUAGE': 'en_US:en', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MAIL': '/var/mail/cltbld', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SHLVL': '1', 09:48:40 INFO - 'TERM': 'linux', 09:48:40 INFO - 'TMOUT': '86400', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - '_': '/tools/buildbot/bin/python'} 09:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:40 INFO - Downloading/unpacking psutil>=0.7.1 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:42 INFO - Installing collected packages: psutil 09:48:42 INFO - Running setup.py install for psutil 09:48:42 INFO - building 'psutil._psutil_linux' extension 09:48:42 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 09:48:43 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 09:48:43 INFO - building 'psutil._psutil_posix' extension 09:48:43 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 09:48:43 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 09:48:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:43 INFO - Successfully installed psutil 09:48:43 INFO - Cleaning up... 09:48:43 INFO - Return code: 0 09:48:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:43 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:43 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 09:48:43 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 09:48:43 INFO - Using env: {'DISPLAY': ':0', 09:48:43 INFO - 'HOME': '/home/cltbld', 09:48:43 INFO - 'LANG': 'en_US.UTF-8', 09:48:43 INFO - 'LANGUAGE': 'en_US:en', 09:48:43 INFO - 'LOGNAME': 'cltbld', 09:48:43 INFO - 'MAIL': '/var/mail/cltbld', 09:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:43 INFO - 'MOZ_NO_REMOTE': '1', 09:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:43 INFO - 'NO_EM_RESTART': '1', 09:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:43 INFO - 'PWD': '/builds/slave/test', 09:48:43 INFO - 'SHELL': '/bin/bash', 09:48:43 INFO - 'SHLVL': '1', 09:48:43 INFO - 'TERM': 'linux', 09:48:43 INFO - 'TMOUT': '86400', 09:48:43 INFO - 'USER': 'cltbld', 09:48:43 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:43 INFO - '_': '/tools/buildbot/bin/python'} 09:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:48:43 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 09:48:43 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 09:48:43 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 09:48:43 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 09:48:43 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 09:48:43 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 09:48:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:48:45 INFO - Installing collected packages: mozsystemmonitor 09:48:45 INFO - Running setup.py install for mozsystemmonitor 09:48:45 INFO - Successfully installed mozsystemmonitor 09:48:45 INFO - Cleaning up... 09:48:45 INFO - Return code: 0 09:48:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:45 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:45 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 09:48:45 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 09:48:45 INFO - Using env: {'DISPLAY': ':0', 09:48:45 INFO - 'HOME': '/home/cltbld', 09:48:45 INFO - 'LANG': 'en_US.UTF-8', 09:48:45 INFO - 'LANGUAGE': 'en_US:en', 09:48:45 INFO - 'LOGNAME': 'cltbld', 09:48:45 INFO - 'MAIL': '/var/mail/cltbld', 09:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:45 INFO - 'MOZ_NO_REMOTE': '1', 09:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:45 INFO - 'NO_EM_RESTART': '1', 09:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:45 INFO - 'PWD': '/builds/slave/test', 09:48:45 INFO - 'SHELL': '/bin/bash', 09:48:45 INFO - 'SHLVL': '1', 09:48:45 INFO - 'TERM': 'linux', 09:48:45 INFO - 'TMOUT': '86400', 09:48:45 INFO - 'USER': 'cltbld', 09:48:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:45 INFO - '_': '/tools/buildbot/bin/python'} 09:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:45 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 09:48:45 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 09:48:45 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 09:48:45 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 09:48:45 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 09:48:45 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 09:48:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:48 INFO - Downloading docopt-0.6.1.tar.gz 09:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:48 INFO - Running setup.py install for blobuploader 09:48:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:48 INFO - Running setup.py install for requests 09:48:48 INFO - Running setup.py install for docopt 09:48:49 INFO - Successfully installed blobuploader requests docopt 09:48:49 INFO - Cleaning up... 09:48:49 INFO - Return code: 0 09:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:49 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 09:48:49 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 09:48:49 INFO - Using env: {'DISPLAY': ':0', 09:48:49 INFO - 'HOME': '/home/cltbld', 09:48:49 INFO - 'LANG': 'en_US.UTF-8', 09:48:49 INFO - 'LANGUAGE': 'en_US:en', 09:48:49 INFO - 'LOGNAME': 'cltbld', 09:48:49 INFO - 'MAIL': '/var/mail/cltbld', 09:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:49 INFO - 'MOZ_NO_REMOTE': '1', 09:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:49 INFO - 'NO_EM_RESTART': '1', 09:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:49 INFO - 'PWD': '/builds/slave/test', 09:48:49 INFO - 'SHELL': '/bin/bash', 09:48:49 INFO - 'SHLVL': '1', 09:48:49 INFO - 'TERM': 'linux', 09:48:49 INFO - 'TMOUT': '86400', 09:48:49 INFO - 'USER': 'cltbld', 09:48:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:49 INFO - '_': '/tools/buildbot/bin/python'} 09:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:49 INFO - Running setup.py (path:/tmp/pip-AAZ9VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:49 INFO - Running setup.py (path:/tmp/pip-lya22N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:49 INFO - Running setup.py (path:/tmp/pip-cn5ISc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:49 INFO - Running setup.py (path:/tmp/pip-4uMY3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:49 INFO - Running setup.py (path:/tmp/pip-xd6A0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:49 INFO - Running setup.py (path:/tmp/pip-DIUSb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:49 INFO - Running setup.py (path:/tmp/pip-vDWOgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:49 INFO - Running setup.py (path:/tmp/pip-hDMR6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:49 INFO - Running setup.py (path:/tmp/pip-084h15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:49 INFO - Running setup.py (path:/tmp/pip-uN9WXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:50 INFO - Running setup.py (path:/tmp/pip-l3JG_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:50 INFO - Running setup.py (path:/tmp/pip-2NqwgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:50 INFO - Running setup.py (path:/tmp/pip-1k9dWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:50 INFO - Running setup.py (path:/tmp/pip-w3B4jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:50 INFO - Running setup.py (path:/tmp/pip-s8IABD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:50 INFO - Running setup.py (path:/tmp/pip-y7aSve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:50 INFO - Running setup.py (path:/tmp/pip-DjbH13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:50 INFO - Running setup.py install for manifestparser 09:48:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:50 INFO - Running setup.py install for mozcrash 09:48:50 INFO - Running setup.py install for mozdebug 09:48:50 INFO - Running setup.py install for mozdevice 09:48:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:50 INFO - Running setup.py install for mozfile 09:48:51 INFO - Running setup.py install for mozhttpd 09:48:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Running setup.py install for mozinfo 09:48:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Running setup.py install for mozInstall 09:48:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Running setup.py install for mozleak 09:48:51 INFO - Running setup.py install for mozlog 09:48:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Running setup.py install for moznetwork 09:48:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Running setup.py install for mozprocess 09:48:51 INFO - Running setup.py install for mozprofile 09:48:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Running setup.py install for mozrunner 09:48:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:51 INFO - Running setup.py install for mozscreenshot 09:48:52 INFO - Running setup.py install for moztest 09:48:52 INFO - Running setup.py install for mozversion 09:48:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:52 INFO - Cleaning up... 09:48:52 INFO - Return code: 0 09:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:52 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:52 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 09:48:52 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 09:48:52 INFO - Using env: {'DISPLAY': ':0', 09:48:52 INFO - 'HOME': '/home/cltbld', 09:48:52 INFO - 'LANG': 'en_US.UTF-8', 09:48:52 INFO - 'LANGUAGE': 'en_US:en', 09:48:52 INFO - 'LOGNAME': 'cltbld', 09:48:52 INFO - 'MAIL': '/var/mail/cltbld', 09:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:52 INFO - 'MOZ_NO_REMOTE': '1', 09:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:52 INFO - 'NO_EM_RESTART': '1', 09:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:52 INFO - 'PWD': '/builds/slave/test', 09:48:52 INFO - 'SHELL': '/bin/bash', 09:48:52 INFO - 'SHLVL': '1', 09:48:52 INFO - 'TERM': 'linux', 09:48:52 INFO - 'TMOUT': '86400', 09:48:52 INFO - 'USER': 'cltbld', 09:48:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:52 INFO - '_': '/tools/buildbot/bin/python'} 09:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:52 INFO - Running setup.py (path:/tmp/pip-nu0XCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:52 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)) 09:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:52 INFO - Running setup.py (path:/tmp/pip-JZxGgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:52 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)) 09:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:52 INFO - Running setup.py (path:/tmp/pip-xn95Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:52 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)) 09:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:52 INFO - Running setup.py (path:/tmp/pip-KkXV2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:52 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)) 09:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:52 INFO - Running setup.py (path:/tmp/pip-ZaSDXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:52 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)) 09:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:52 INFO - Running setup.py (path:/tmp/pip-XFZAWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:52 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)) 09:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:52 INFO - Running setup.py (path:/tmp/pip-nXjFog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:53 INFO - Running setup.py (path:/tmp/pip-QQrm4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:53 INFO - Running setup.py (path:/tmp/pip-0Vs2yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:53 INFO - Running setup.py (path:/tmp/pip-oq68un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:53 INFO - Running setup.py (path:/tmp/pip-FSFPTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:53 INFO - Running setup.py (path:/tmp/pip-cK3ajR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:53 INFO - Running setup.py (path:/tmp/pip-SZU4Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:53 INFO - Running setup.py (path:/tmp/pip-TCreXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:53 INFO - Running setup.py (path:/tmp/pip-4WYbw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:53 INFO - Running setup.py (path:/tmp/pip-IvS4QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:53 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)) 09:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:53 INFO - Running setup.py (path:/tmp/pip-rxHuHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:53 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)) 09:48:53 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)) 09:48:53 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)) 09:48:53 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)) 09:48:53 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)) 09:48:53 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)) 09:48:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:55 INFO - Downloading blessings-1.6.tar.gz 09:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:55 INFO - Installing collected packages: blessings 09:48:55 INFO - Running setup.py install for blessings 09:48:55 INFO - Successfully installed blessings 09:48:55 INFO - Cleaning up... 09:48:55 INFO - Return code: 0 09:48:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:56 INFO - Reading from file tmpfile_stdout 09:48:56 INFO - Current package versions: 09:48:56 INFO - argparse == 1.2.1 09:48:56 INFO - blessings == 1.6 09:48:56 INFO - blobuploader == 1.2.4 09:48:56 INFO - docopt == 0.6.1 09:48:56 INFO - manifestparser == 1.1 09:48:56 INFO - mozInstall == 1.12 09:48:56 INFO - mozcrash == 0.17 09:48:56 INFO - mozdebug == 0.1 09:48:56 INFO - mozdevice == 0.48 09:48:56 INFO - mozfile == 1.2 09:48:56 INFO - mozhttpd == 0.7 09:48:56 INFO - mozinfo == 0.9 09:48:56 INFO - mozleak == 0.1 09:48:56 INFO - mozlog == 3.1 09:48:56 INFO - moznetwork == 0.27 09:48:56 INFO - mozprocess == 0.22 09:48:56 INFO - mozprofile == 0.28 09:48:56 INFO - mozrunner == 6.11 09:48:56 INFO - mozscreenshot == 0.1 09:48:56 INFO - mozsystemmonitor == 0.0 09:48:56 INFO - moztest == 0.7 09:48:56 INFO - mozversion == 1.4 09:48:56 INFO - psutil == 3.1.1 09:48:56 INFO - requests == 1.2.3 09:48:56 INFO - wsgiref == 0.1.2 09:48:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:56 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:56 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 09:48:56 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 09:48:56 INFO - Using env: {'DISPLAY': ':0', 09:48:56 INFO - 'HOME': '/home/cltbld', 09:48:56 INFO - 'LANG': 'en_US.UTF-8', 09:48:56 INFO - 'LANGUAGE': 'en_US:en', 09:48:56 INFO - 'LOGNAME': 'cltbld', 09:48:56 INFO - 'MAIL': '/var/mail/cltbld', 09:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:56 INFO - 'MOZ_NO_REMOTE': '1', 09:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:56 INFO - 'NO_EM_RESTART': '1', 09:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:56 INFO - 'PWD': '/builds/slave/test', 09:48:56 INFO - 'SHELL': '/bin/bash', 09:48:56 INFO - 'SHLVL': '1', 09:48:56 INFO - 'TERM': 'linux', 09:48:56 INFO - 'TMOUT': '86400', 09:48:56 INFO - 'USER': 'cltbld', 09:48:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:56 INFO - '_': '/tools/buildbot/bin/python'} 09:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 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)) 09:48:56 INFO - Cleaning up... 09:48:56 INFO - Return code: 0 09:48:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48: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')]} 09:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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')]} 09:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48: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', 'jsonschema'] in /builds/slave/test/build 09:48: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 jsonschema 09:48:56 INFO - Using env: {'DISPLAY': ':0', 09:48:56 INFO - 'HOME': '/home/cltbld', 09:48:56 INFO - 'LANG': 'en_US.UTF-8', 09:48:56 INFO - 'LANGUAGE': 'en_US:en', 09:48:56 INFO - 'LOGNAME': 'cltbld', 09:48:56 INFO - 'MAIL': '/var/mail/cltbld', 09:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:56 INFO - 'MOZ_NO_REMOTE': '1', 09:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:56 INFO - 'NO_EM_RESTART': '1', 09:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:56 INFO - 'PWD': '/builds/slave/test', 09:48:56 INFO - 'SHELL': '/bin/bash', 09:48:56 INFO - 'SHLVL': '1', 09:48:56 INFO - 'TERM': 'linux', 09:48:56 INFO - 'TMOUT': '86400', 09:48:56 INFO - 'USER': 'cltbld', 09:48:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:56 INFO - '_': '/tools/buildbot/bin/python'} 09:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:56 INFO - Downloading/unpacking jsonschema 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:58 INFO - Downloading/unpacking functools32 (from jsonschema) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:58 INFO - warning: no files found matching '*.txt' 09:48:58 INFO - no previously-included directories found matching 'build' 09:48:58 INFO - no previously-included directories found matching 'dist' 09:48:58 INFO - no previously-included directories found matching '.git*' 09:48:58 INFO - Installing collected packages: jsonschema, functools32 09:48:58 INFO - Running setup.py install for functools32 09:48:58 INFO - warning: no files found matching '*.txt' 09:48:58 INFO - no previously-included directories found matching 'build' 09:48:58 INFO - no previously-included directories found matching 'dist' 09:48:58 INFO - no previously-included directories found matching '.git*' 09:48:58 INFO - Successfully installed jsonschema functools32 09:48:58 INFO - Cleaning up... 09:48:58 INFO - Return code: 0 09:48:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:48:58 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')]} 09:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 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')]} 09:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:58 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 0x7f03b0d81f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24005a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', '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 09:48:58 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 09:48:58 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 09:48:58 INFO - Using env: {'DISPLAY': ':0', 09:48:58 INFO - 'HOME': '/home/cltbld', 09:48:58 INFO - 'LANG': 'en_US.UTF-8', 09:48:58 INFO - 'LANGUAGE': 'en_US:en', 09:48:58 INFO - 'LOGNAME': 'cltbld', 09:48:58 INFO - 'MAIL': '/var/mail/cltbld', 09:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:58 INFO - 'MOZ_NO_REMOTE': '1', 09:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:48:58 INFO - 'NO_EM_RESTART': '1', 09:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:58 INFO - 'PWD': '/builds/slave/test', 09:48:58 INFO - 'SHELL': '/bin/bash', 09:48:58 INFO - 'SHLVL': '1', 09:48:58 INFO - 'TERM': 'linux', 09:48:58 INFO - 'TMOUT': '86400', 09:48:58 INFO - 'USER': 'cltbld', 09:48:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:58 INFO - '_': '/tools/buildbot/bin/python'} 09:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:59 INFO - Downloading/unpacking flake8 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:49:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:49:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:49:00 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 09:49:00 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 09:49:00 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 09:49:00 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 09:49:00 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 09:49:00 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 09:49:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:49:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:01 INFO - no previously-included directories found matching 'docs/_build' 09:49:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:49:01 INFO - Running setup.py install for pep8 09:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:49:01 INFO - no previously-included directories found matching 'docs/_build' 09:49:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:49:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:49:01 INFO - Cleaning up... 09:49:01 INFO - Return code: 0 09:49:01 INFO - Running post-action listener: _resource_record_post_action 09:49:01 INFO - Running post-action listener: _start_resource_monitoring 09:49:01 INFO - Starting resource monitoring. 09:49:01 INFO - ##### 09:49:01 INFO - ##### Running install step. 09:49:01 INFO - ##### 09:49:01 INFO - Running pre-action listener: _resource_record_pre_action 09:49:01 INFO - Running main action method: install 09:49:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:02 INFO - Reading from file tmpfile_stdout 09:49:02 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:02 INFO - Reading from file tmpfile_stdout 09:49:02 INFO - Output received: 09:49:02 INFO - Usage: mozinstall [options] installer 09:49:02 INFO - Options: 09:49:02 INFO - -h, --help show this help message and exit 09:49:02 INFO - -d DEST, --destination=DEST 09:49:02 INFO - Directory to install application into. [default: 09:49:02 INFO - "/builds/slave/test"] 09:49:02 INFO - --app=APP Application being installed. [default: firefox] 09:49:02 INFO - mkdir: /builds/slave/test/build/application 09:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:49:17 INFO - Reading from file tmpfile_stdout 09:49:17 INFO - Output received: 09:49:17 INFO - /builds/slave/test/build/application/firefox/firefox 09:49:17 INFO - Running post-action listener: _resource_record_post_action 09:49:17 INFO - ##### 09:49:17 INFO - ##### Running run-tests step. 09:49:17 INFO - ##### 09:49:17 INFO - Running pre-action listener: _resource_record_pre_action 09:49:17 INFO - Running main action method: run_tests 09:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:17 INFO - Python 2.7.3 09:49:17 INFO - Return code: 0 09:49:17 INFO - grabbing minidump binary from tooltool 09:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:17 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 0x248f410>, '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 0x2490310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24907a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:17 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 09:49:17 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 09:49:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:17 INFO - Return code: 0 09:49:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:49:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:49:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:49:18 INFO - Return code: 0 09:49:18 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/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 09:49:18 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/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 09:49:18 INFO - Using env: {'DISPLAY': ':0', 09:49:18 INFO - 'HOME': '/home/cltbld', 09:49:18 INFO - 'LANG': 'en_US.UTF-8', 09:49:18 INFO - 'LANGUAGE': 'en_US:en', 09:49:18 INFO - 'LOGNAME': 'cltbld', 09:49:18 INFO - 'MAIL': '/var/mail/cltbld', 09:49:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:18 INFO - 'MOZ_NO_REMOTE': '1', 09:49:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:18 INFO - 'NO_EM_RESTART': '1', 09:49:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:18 INFO - 'PWD': '/builds/slave/test', 09:49:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:18 INFO - 'SHELL': '/bin/bash', 09:49:18 INFO - 'SHLVL': '1', 09:49:18 INFO - 'TERM': 'linux', 09:49:18 INFO - 'TMOUT': '86400', 09:49:18 INFO - 'USER': 'cltbld', 09:49:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827', 09:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:18 INFO - '_': '/tools/buildbot/bin/python'} 09:49:18 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/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 09:49:19 INFO - mozversion application_buildid: 20160423090652 09:49:19 INFO - mozversion application_changeset: e5962142ff0a538f42abfd5518cbb2477e987dd8 09:49:19 INFO - mozversion application_display_name: Nightly 09:49:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:19 INFO - mozversion application_name: Firefox 09:49:19 INFO - mozversion application_remotingname: firefox 09:49:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:49:19 INFO - mozversion application_vendor: Mozilla 09:49:19 INFO - mozversion application_version: 48.0a1 09:49:19 INFO - mozversion platform_buildid: 20160423090652 09:49:19 INFO - mozversion platform_changeset: e5962142ff0a538f42abfd5518cbb2477e987dd8 09:49:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:49:19 INFO - mozversion platform_version: 48.0a1 09:49:19 INFO - using testdate: 1461430159 09:49:19 INFO - actual date: 1461430159 09:49:19 INFO - starting webserver on 'localhost:53909' 09:49:19 INFO - SUITE-START | Running 2 tests 09:49:19 INFO - TEST-START | dromaeo_css 09:49:19 INFO - operating with platform_type : linux_ 09:49:19 INFO - Initialising browser for dromaeo_css test... 09:49:19 INFO - TEST-INFO | started process 20873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpShn5ss/profile http://localhost:53909/getInfo.html) 09:49:23 INFO - PROCESS | 20873 | __metrics Screen width/height:1600/1200 09:49:23 INFO - PROCESS | 20873 | colorDepth:24 09:49:23 INFO - PROCESS | 20873 | Browser inner width/height: 1024/697 09:49:23 INFO - PROCESS | 20873 | __metrics 09:49:24 ERROR - PROCESS | 20873 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:49:25 INFO - TEST-INFO | 20873: exit 0 09:49:25 INFO - Browser initialized. 09:49:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:25 INFO - TEST-INFO | started process 20955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpShn5ss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:37 INFO - PROCESS | 20955 | RSS: Main: 155701248 09:49:37 INFO - PROCESS | 20955 | 09:50:28 INFO - PROCESS | 20955 | 1461430228664 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] 09:52:40 INFO - PROCESS | 20955 | Cycle 1(1): loaded http://localhost:53909/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53909/tests/dromaeo/cssquery-ext.html) 09:52:41 INFO - PROCESS | 20955 | RSS: Main: 272392192 09:52:41 INFO - PROCESS | 20955 | 09:55:43 INFO - PROCESS | 20955 | Cycle 1(1): loaded http://localhost:53909/tests/dromaeo/cssquery-ext.html (next: http://localhost:53909/tests/dromaeo/cssquery-jquery.html) 09:55:44 INFO - PROCESS | 20955 | RSS: Main: 241008640 09:55:44 INFO - PROCESS | 20955 | 09:58:46 INFO - PROCESS | 20955 | Cycle 1(1): loaded http://localhost:53909/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53909/tests/dromaeo/cssquery-mootools.html) 09:58:47 INFO - PROCESS | 20955 | RSS: Main: 243351552 09:58:47 INFO - PROCESS | 20955 | 10:01:49 INFO - PROCESS | 20955 | Cycle 1(1): loaded http://localhost:53909/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53909/tests/dromaeo/cssquery-prototype.html) 10:01:50 INFO - PROCESS | 20955 | RSS: Main: 232075264 10:01:50 INFO - PROCESS | 20955 | 10:04:53 INFO - PROCESS | 20955 | Cycle 1(1): loaded http://localhost:53909/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53909/tests/dromaeo/cssquery-yui.html) 10:04:53 INFO - PROCESS | 20955 | RSS: Main: 221990912 10:04:53 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | Cycle 1(1): loaded http://localhost:53909/tests/dromaeo/cssquery-yui.html (next: http://localhost:53909/tests/dromaeo/cssquery-dojo.html) 10:07:56 INFO - PROCESS | 20955 | RSS: Main: 268062720 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | __start_tp_report 10:07:56 INFO - PROCESS | 20955 | _x_x_mozilla_page_load 10:07:56 INFO - PROCESS | 20955 | _x_x_mozilla_page_load_details 10:07:56 INFO - PROCESS | 20955 | |i|pagename|runs| 10:07:56 INFO - PROCESS | 20955 | |0;dojo.html;2626.684797824261;2694.110943388682;2696.7707744841687;2716.3480764616484;2729.6724393072836;4624.583787459136;4715.669903106784;4717.528247175281;4725.669203155776;4736.715797052175;4618.2379907315335;4715.599174070199;4724.976375118128;4727.1727447696685;4749.073930583538;4240.597143271384;4244.851430199951;4257.6806739494505;4288.206681763868;4425.734455932655;4358.869233922987;4386.1008493258805;4401.449818772653;4428.512863585019;4441.3115967025005;4258.382534532476;4280.122574872144;4314.741115533062;4339.218940590692;4358.237308471036;4285.121550082225;4300.22595932732;4343.674224433149;4346.500152482474;4353.25994580922;4293.441852559178;4310.48274207094;4330.480342358937;4330.870073897788;4363.541828108035;4502.144592527442;4533.206688829442;4618.468876079227;4638.234691275936;4683.859484215479;4991.151504244287;5009.499050094998;5013.197888337849;5013.749312534395;5015.172496538104;5044.192929131358;5049.4950504949575;5051.9494805051845;5064.215046667736;5084.491550844923;4534.342520334533;4678.8596342109795;4719.716816990923;4759.952400476021;4760.904781904343;5185.870353241199;5217.660852044605;5233.738313084331;5239.580833533309;5244.921326180111;4732.479427262998;4980.7509624518625;5010.148274793294;5013.498650134958;5064.898702025939;5027.648064635514;5109.693418394908;5120.308758317654;5126.102931986888;5127.051495473274;4954.702717836942;4962.8511144665;4967.081089998362;4969.403671559436;5006.849794506171;4938.555530002317;4945.975270123627;4948.529889660476;4949.727764972889;4972.5276098770555;4202.558731333227;4278.187144442546;4293.0769884474985;4359.17175736609;4366.235908715962;3763.6424539668687;3764.5106136202116;3773.716971227169;3797.9430308545393;3833.4058220975235;4348.978255108767;4352.368906508538;4357.477102747627;4395.626371758372;4406.4051353066925;4995.950040499549;5076.898462030813;5108.157154069611;5162.793488260428;5163.586913046947;4318.265894797892;4319.632831209383;4327.17783621111;4336.501302350207;4347.043650396908;4550.203714350042;4552.453705555355;4556.248219043887;4562.794674239667;4605.194091034055;4648.1168577970075;4761.285807128958;4799.688020278671;4837.129316723023;4841.636877234292;5067.163917953644;5072.59419246452;5086.415062267886;5095.719735414439;5145.897082058263;4658.440987081572;4791.712497250176;4793.544613261734;4796.25658023007;4843.055604157155;4931.679440836334;4973.776180071833;5001.199808030698;5030.170021946338;5045.772940217773;5070.264811602371;5075.771590278372;5077.339945807022;5086.491350864884;5132.10188217053;4844.103840789465;4867.756612169306;4942.521853670242;4946.777395017161;4946.975265123651;4863.902721945612;4887.853364399074;4889.804407823647;4909.656324057281;4937.01259748059;4798.808047678054;4802.543758342952;4804.0872234275375;4814.7833347498745;4862.41651001882;4781.641376896677;4894.755262236803;4974.801007959786;4977.552020318189;4988.376452943382;4745.193317136164;4780.282957556395;4788.377510923558;4789.640776941674;4884.242942343943 10:07:56 INFO - PROCESS | 20955 | |1;ext.html;563.7801257509569;600.6696317025636;619.4486906653077;621.5928566788753;622.5175488996027;27411.451770964595;27823;27920.581191282123;27935.860320698393;33706.83146584264;34291.65708342922;35047.12382190447;35167.648323516754;35255.11862203446;36488.81755591218;7517.24827517248;7742.496737712059;7811.492253003565;7822.217778222161;7822.217778222189;7507.587082710449;7589.241075892422;7757.301842834144;9495.097965693283;9761.511924403787;9679.564419601134;9853.65512207073;9864.408135511892;9865.506724663774;9897.257705672104;9674.22606191503;9711.61153553857;9807.411555306633;9812.411255324632;9815.607375705034;9576.377535460173;9703.805923881553;9704;9760.072793084646;9824.263180261438;37965.43051854224;38368.42447363292;38570;38572.61427385718;38580;3335.7831740936763;3355.295387968505;3419.743519236067;3439.07145070832;3704.6480584344445;29100.70899291001;29501;29679.25801854949;30387;31025.22436939072;3425.811580363079;3491.9650803491895;3553.982230088833;3589.892303230907;3592.1019745063736;238239;239024;239544.99999999825;239906;240845.79577102177;57694.71152644294;58683;58755.41244587585;58769.70615146982;58788;60284.397156028754;60479.395206047375;60536;60629.69685151634;60696.696516517135;12655.114142010156;14274.857251427353;14507.782383264259;14523.78214326786;14560.126392416489;9122.726318210463;9136.771580710403;9149.542522873962;9154.954225228965;10998.34009959389;18815.435536933914;19181.520461988563;19386.4184074478;19442.125104370054;19624.901875490817;6858;7075.858482830315;7110.288971102848;7171.211166771651;7313.597752123685;921.6037104045325;927.1562877781187;959.7744530035436;1004.8542961270575;1013.4122209118693;25384;26371.340716481856;26560.46879062408;26639;26701.19896403111;956.6125719083643;959.3764053365369;969.6170012844887;974.8294048541477;1031.9277650564538;14809.92595037018;15052.774208386883;15106.622334441727;15148.772768408482;15319.617009574627;342896;349846;352070;353293;353592;48870.51129488731;49492;49694.75152624214;49804.50195497998;49901;1147.260017288844;1197.3534291482501;1197.9101567382656;1278.1564167649308;1313.0152385710717;27040.45919081568;27542;29423.55864661989;29464.852675736485;30089;43790;44030.33954490621;44684.776576116914;44804.32793508165;44961.32558011567;327215;335737;336049;336137;337976;33605;38386.040348990384;40569;41550;41639.167216656104;42759;43842.12315753731;43932;44692;45036.77481612702;36620;37258.813705931294;37347.439788402655;37951.240975180895;38197;36515.452268216526;36804.37248015373;37311.2537749238;37348.25303493969;37530.6246937538;37054.44418333673;37449.4382584256;37734.81132594319;38202;38295.42556861594;33230.833845831585;33628.66371336353;33719.4942075874;34159.31681366408;34335.828320858236;25411.110611128523;25679.614805778303;25848.612270815578;25934.092306769173;26111 10:07:56 INFO - PROCESS | 20955 | |2;jquery.html;367.874922526341;369.2614770459083;373.3503703555812;374.36358191075163;385.114237254315;15934.362625494981;16649.500514984557;17140.057296848667;17142.742858857113;17181;14328.928355358208;14346.497872574462;14383.208923509203;14393;14395;4772.188727916246;5162.096633089194;5169;5172.327597412331;5178.7669554869935;3665.2303016366595;4894.97552512237;5710.114932185518;6030.155778191057;6061.696915154247;5988.790392336269;5996.640201587897;6001.039833626621;6011.248593925759;6013.458788709037;5950.761969521214;6018.6990650467305;6029.668368239745;6044.788432404889;6048.304444988838;3408.1820363112924;5005.449400565934;5087.135187018179;5264.7367631618645;5268.8155914543195;18633.813661863478;19472.221111155537;19495.317663881837;19548.609027819508;19568.217271309273;1936.4965109071602;2072.616565935307;2114.9365519034454;2173.847830651855;2614.686237651494;8714.520701361422;9027.36808423404;9310.627574896997;9334.159925606727;13217.73564528704;1746.1531157388656;1847.6951303034982;1855;1855.4155441036166;1910.484169274302;68712.6564367175;69613.65193174002;71108.28891711068;71712.28287717108;71877;10158.898411015944;10295.330803497749;10324.535395907053;10399.32404393712;10534.157267418588;14296.142231466145;14339.641508962151;14369.281535923163;14408.927955360155;14426.495072672406;7082.929170708227;7234.421246300283;7275.769381178422;7321.194668586451;7340.632968351561;6583.63789991555;6588.143541339691;6632.071509988606;6686.565373250821;6726.159230096238;4419.447569053868;4457.955420445819;4466.620337271368;4471.485779135441;4581.79381927814;1712.3921008042214;1791.7133258678548;1801.5766294920684;1806.2594336322309;1814.3105619864632;859.5487369131256;898.2544488074882;917.6696389299847;941.1623654947102;948.5636607160783;15484.612884677974;16667.166641667867;17109;17482.562935926704;17692.76150669441;856.9400141990001;866.1425189062783;879.2438502887512;880.933929955256;883.5052370672444;9417.717468475958;9650.95174524137;9715.07706767856;9724.124828765303;9741.318107732392;392326;396369;404625;407911;408107;81393.18606813856;81829;82473;83743.16256837353;84289;917.8439665256923;924.3529529329496;928.5914197753102;935.5182081228173;935.9110884465965;15076.698466030399;15126.546203613909;15268.808605074328;15285.694286113992;15408;26305.210843674722;32009.519857201696;35224.47163292604;35390.46914296339;35795;49072.263916042;49694.75152624214;51185.23222151745;51295;51796;7735.458517903693;7757.495762775401;7843.372530197456;7897.763067107996;8047.195280471906;11341.603043893425;12203.450844711831;12233.3271670059;12322.260664360167;12381.690457738629;10397.896021039693;10525.052745252964;10755.623553175601;10794.460276985963;10851.186161037796;10113.544890480092;10341.84487232677;10351.120154786928;10455.372677639061;10596.15230781551;10397.428141452292;10436.582536698446;10912.672619821418;10921.890781092405;10988.670339889815;7295.192958699958;7509.211532789197;7693.88459173124;7721.459497835098;8193.549354785544;10019.198464123;10774.892251077388;10881.347119172875;10922.235443519196;11048.337099774039 10:07:56 INFO - PROCESS | 20955 | |3;mootools.html;1024.7694268789528;1393.0736060519753;1420.0840457904649;1469.1258701072863;1554.5103292462873;7421.5547067176;7806.258405451487;7810.414218933582;7811.6094195290225;7830.530168189898;7562.62186890656;7726.304632583066;7727.536347819121;7735.845283094349;7748.612569371523;1904.476269026022;2119.9894000529976;2169.6962425260476;2207.6467765157618;2233.8659680419146;2194.18815038436;2211.9447013824624;2219.82241420686;2220.0786673530547;2221.2336743823435;2168.078566609193;2224.1881713174735;2227.8440509164366;2231.8884055797225;2233.6761169630395;1856.4059500959697;2126.1282874021654;2206.9889650551645;2208.028467474306;2208.061573831131;2063.1541068161982;2102.495401103724;2109.5148115933266;2110.693949377347;2112.0706888968803;7638.312551870303;7664.080310362792;7694.961525192338;7700.884486732703;7723.845523089563;4631.120087183424;4761;4792.9281060784115;4800.159972004885;4838.201696720037;3069.4628440022907;3094.9535756963664;3095.148834070626;3104.6584875663657;3154.3375891062906;925.8935222449437;938.9342746007782;941.1717688434203;951.9428834269966;964.5852283518085;10743.83884241737;10747.677569672922;10762.569497220102;10763.515641796217;10769.299995500267;4296.2696341621995;4301.182775272689;4452.755098469551;4500.392447019676;4516.638668906546;9055.773605659911;9072.183503484717;9160.267178625827;9169.40398874071;9198.2181514572;4028.274910516135;4774.4509381420885;4788.497207793202;4816.710997340171;4820.011897561062;4251.829926802955;4374.103308821684;4387;4389.473263208435;4421.358902959053;3687.483752274684;3692.372296709566;3811.7712937223855;3821.8280177392085;3843.404272337792;1189.41718557906;1196.8862958018974;1202.909781766371;1207.7403358277836;1215.5077193736552;819.8032472206628;828.2793969246794;830.7009476588423;850.2815121222557;856.4903882190087;5454;5463.48096930791;5523.088690366045;5602.52378547828;5719.570107473131;418.98114584843756;420.1303302164551;420.9410682504452;940.8071345374182;945.3004776465366;3738.3084129436143;3800.239952009609;3844.308024555607;3866.439366291872;3875.457435958968;9364.625414983324;9720.31957762964;9826.508674566243;9853.704388868346;9877.456739879375;9295.953520232355;9754;9768.169705574963;9788.804223915624;9790.510474476248;7197.4961752677855;7273.963630181921;7333.376662983599;7353;7355;5382.892342153056;5629.493345598916;5635.520980716521;5724.084146536534;5797.768089276382;8648.654053837776;8732.607032683418;8832.558372081241;8868.11318868108;8948.642054317754;8948.776280593038;9022.052684468037;9208.447493150432;9341.859872102059;9375.906240937777;6140.109684095871;6710.261871194067;6805.89791153143;6908.240093589801;7012.263712310338;7514.511556748794;7524.586147761706;7577.318041376303;7580.0145981022115;7596.240375962359;6559.868802623825;6778.186617605918;6782.96608516974;6879.346462086094;6924.619145947021;6637.1703537057865;6661.4004739573675;6705.932940670531;6759.594424334556;6817.761378351932;6422.3577642235405;6575.769848055295;6618.338166183343;6635.6350400728425;6640.83397915056;4770.356001939694;4803.615710743202;4869.638225460578;4921.557059864486;4930.285108659296;4774.164521208844;4806.7836947338155;4810.158222311012;4839.467658557485;4959.752012399438 10:07:56 INFO - PROCESS | 20955 | |4;prototype.html;309.088189839972;316.36568679797006;317.40011378494637;322.46309894026444;326.5901293876185;5205.349331333583;5230.8692282692955;5235.188545775406;5235.424103348629;5257.395399529055;5161.974190129054;5162.870928226786;5164.354455693038;5189.766460509277;5193.272941788153;3801.676857467112;3906.785126818024;3946.4474973503734;4064.959350406488;4068.3083875741195;4063.553009168989;4075.6535694465856;4082.2447847148223;4099.364598487239;4103.138340948404;3836.9232615347814;4064.6748260139116;4066.742957658498;4070.9185816283803;4074.0629655179328;3937.645611894929;4031.3549832026883;4038.5557588665224;4058.310087285139;4070.1452694933805;3583.1692962559546;3598.298331825295;3602.2975519773654;3608.564219152062;3612.24142929985;4965.280034395028;4978.950210497921;4994;4999.375078115236;5011.423686276052;4560.817567297304;4639.5824375806005;4647.651426143019;4648.907021859543;4656.441227052742;5404.756785944603;5421.376541697716;5427;5428.647137936022;5433.8369848904595;3880.2821478026653;3883.417487376888;3891.6302951219873;3899.2786334528205;3902.083010492532;5532.972335138298;5715.628484148517;5718.228039214694;5744.22452968848;5751.281089863767;3957.45659192915;3971.7219794614675;3983.1635356574866;3992.4210989406956;4005.4792876925812;4024.95351208682;4038.9394159087637;4039.979800100981;4044;4052.675785937118;4300.268954277781;4558.817647294138;4604.194266003436;4606.424196975378;4610.170169369546;5453.809116680976;5475.5907400743545;5481.972590137104;5484.890302193934;5495.395506494282;1350.8990173008967;1354.552997510819;1362.884154846849;1363.1275983370651;1363.8090667306585;882.3206131279007;891.5007595746403;912.2565109435789;917.554985831871;920.2545937790411;4711.8350857719815;4712.246040633482;4727.2909063640045;4735.692180008288;4750.976245118822;5589.385167631557;5597.888042239214;5602.13166959122;5602.943970560243;5608.6073974821375;4558.6978575819;4703.270992996091;4710.387649605598;4722.693024953367;4824.300476430898;3022.561728549348;3030.196997795586;3035.635723713124;3050.115466514686;3059.3116548776347;5368.302120724281;5373.005993891143;5380.300560927054;5380.354357477127;5383.5423988961375;5624.690642014647;5869.354371019184;5886.58649953517;5900.350961394243;5901.940980590225;5359;5381.708389986454;5389.272448219519;5396;5403.108487099663;5438.347398312228;5698.914516282176;5723.742431590672;5733.799317023884;5736.139579063174;5580.1629755537;5591.692456914909;5592.496675299242;5597.5521958242425;5605.523530499953;5351.866203344947;5352.919706204488;5353.866153346197;5359.705216213146;5381.838544843661;3746.1009357754488;3931.095847954929;3950.807301947447;3954.4859168309085;3957.149212919236;5618;5631.436856314336;5634.295713035871;5655.377908429987;5676.176954341515;5461.508464238079;5483.095289277225;5483.7806487740045;5487.780488780404;5490.0941344677685;5337.706426146599;5433.185022246536;5481.342238931354;5486.588505861996;5488;5121.362498313446;5349.2778474906945;5359.678419294854;5360.276362691143;5367.812126575551;5392.352917649907;5396.1366181410785;5401.567874570103;5405.621606487508;5409.29679141709;5016.197408414636;5328.946710532845;5403.621746477709;5407.891842163213;5411.756470958738 10:07:56 INFO - PROCESS | 20955 | |5;yui.html;749.8875168724692;751.27501960608;763.732693557255;775.1589525364978;790.426940468161;12244.571439999601;12537.37313134342;12574.245545267291;12608.747825043505;12613.621591352263;12234.510619575229;12266.202696824701;12273.079519036064;12277.140600157993;12333.629991100259;639.7664852328913;778.7196609220676;801.7033697531922;813.0690359538326;815.1481701621819;806.6128258435954;809.4293523066253;809.9635516401746;810.8175660476404;811.0956283743612;858.5363903492107;862.4782006885838;862.7023676831515;863.2921004776086;863.43876480288;576.5819780659031;824.5877061469265;849.1084361420515;860.4020205956863;861.2335021830576;631.6936285901335;631.7662464887975;631.8515148939996;632.1434456311678;632.7437387857925;11931.522739090426;11989.880101198964;12007.039436845118;12023.819642705279;12029.458674359676;11759.58841440554;12356.938215308955;12662.430190641444;12774.808377874338;12999.285039322833;10971.122310215163;10979.451027448597;11192.216544841864;11301.26541774782;11662.650120496399;3310.668933106694;3327.9168020799675;3349.7990120592845;3468.4450487921813;3471.7743346682637;45116;46471;46494.767526162155;47139;47155.29267060997;9638.95180524093;9672.661456848977;9686.660966866268;9726.465044422624;10253.33353332031;16289.51131466058;16420.507384778477;16451.012939223445;16460.83539164617;16513.91743041301;6886.449084073262;6913.032175495435;6945.131858517685;7037.894431583531;7193.89209161863;3907.0427745202037;3908.101136738566;3942.743721658083;4007.458993035961;4038.0914294283552;2751.380939288684;2814.5496720524616;2826.816256943292;2829.3916807886403;2833.079249244004;472.4401584122825;485.8639580917278;519.4390058736556;523.1263789471592;526.18178732072;501.9598432125421;544.1266766839245;563.3211979564614;625.6183727925961;626.6428135962549;7576.886346704804;7807.804804879924;8183.222593853575;8268.958655206685;8374.120717324715;504.64662318890765;568.6275489554348;616.8057062025448;626.3923993726079;635.9109724638554;3734.2531493701367;3738.8035828534607;3765.9435108473394;3811.676007539335;3933.8819835404984;48864;49734.25398619023;51452.742736286826;51653;53571;46775.06449871052;47875.5212447878;48242.5175748245;48622;48798.51201488011;43898.78050609727;43970.560294397284;43977.34033989493;45024.54975450203;45038.32442513365;7476.439267054884;7476.962615186889;8273.131321211427;8334.166583341617;8417.158284171779;27258.863705681346;27731.44537109206;28277.15168544947;29168.854155729085;29703.702962970092;38654.42018369783;39475.80262098671;39524.604753952095;40036.799816000734;40671.796641016605;11290.242026509992;11425.885741142481;11431.714207144887;11611.6516504505;11786.46960886745;11414;11827;12128.151029427856;12304.446299916346;12386.442610082388;8038.87941680887;9915.900840991499;10803.567857285621;10870.130389568974;10977.506012229629;11334.94332528332;11341.886581134084;11382.715432114263;11408.315501069963;11894.34581098048;10364.119049880845;10636.84044739314;10753;10898.673039808818;10988;9018.774530636787;9182.816343672956;9216.677416290398;9442.244620430487;9649.855252171083;8549;8762.167594078552;8840.911590884267;9358.953205233931;9387.342885998189 10:07:56 INFO - PROCESS | 20955 | __end_tp_report 10:07:56 INFO - PROCESS | 20955 | __start_cc_report 10:07:56 INFO - PROCESS | 20955 | _x_x_mozilla_cycle_collect,1080 10:07:56 INFO - PROCESS | 20955 | __end_cc_report 10:07:56 INFO - PROCESS | 20955 | __startTimestamp1461431276885__endTimestamp 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | ------- Summary: start ------- 10:07:56 INFO - PROCESS | 20955 | Number of tests: 6 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | [#0] dojo.html Cycles:165 Average:4662.31 Median:4788.38 stddev:481.35 (10.1%) stddev-sans-first:455.57 10:07:56 INFO - PROCESS | 20955 | Values: 2626.7 2694.1 2696.8 2716.3 2729.7 4624.6 4715.7 4717.5 4725.7 4736.7 4618.2 4715.6 4725.0 4727.2 4749.1 4240.6 4244.9 4257.7 4288.2 4425.7 4358.9 4386.1 4401.4 4428.5 4441.3 4258.4 4280.1 4314.7 4339.2 4358.2 4285.1 4300.2 4343.7 4346.5 4353.3 4293.4 4310.5 4330.5 4330.9 4363.5 4502.1 4533.2 4618.5 4638.2 4683.9 4991.2 5009.5 5013.2 5013.7 5015.2 5044.2 5049.5 5051.9 5064.2 5084.5 4534.3 4678.9 4719.7 4760.0 4760.9 5185.9 5217.7 5233.7 5239.6 5244.9 4732.5 4980.8 5010.1 5013.5 5064.9 5027.6 5109.7 5120.3 5126.1 5127.1 4954.7 4962.9 4967.1 4969.4 5006.8 4938.6 4946.0 4948.5 4949.7 4972.5 4202.6 4278.2 4293.1 4359.2 4366.2 3763.6 3764.5 3773.7 3797.9 3833.4 4349.0 4352.4 4357.5 4395.6 4406.4 4996.0 5076.9 5108.2 5162.8 5163.6 4318.3 4319.6 4327.2 4336.5 4347.0 4550.2 4552.5 4556.2 4562.8 4605.2 4648.1 4761.3 4799.7 4837.1 4841.6 5067.2 5072.6 5086.4 5095.7 5145.9 4658.4 4791.7 4793.5 4796.3 4843.1 4931.7 4973.8 5001.2 5030.2 5045.8 5070.3 5075.8 5077.3 5086.5 5132.1 4844.1 4867.8 4942.5 4946.8 4947.0 4863.9 4887.9 4889.8 4909.7 4937.0 4798.8 4802.5 4804.1 4814.8 4862.4 4781.6 4894.8 4974.8 4977.6 4988.4 4745.2 4780.3 4788.4 4789.6 4884.2 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | [#1] ext.html Cycles:180 Average:47267.18 Median:37329.35 stddev:81888.19 (219.4%) stddev-sans-first:82042.83 10:07:56 INFO - PROCESS | 20955 | Values: 563.8 600.7 619.4 621.6 622.5 27411.5 27823.0 27920.6 27935.9 33706.8 34291.7 35047.1 35167.6 35255.1 36488.8 7517.2 7742.5 7811.5 7822.2 7822.2 7507.6 7589.2 7757.3 9495.1 9761.5 9679.6 9853.7 9864.4 9865.5 9897.3 9674.2 9711.6 9807.4 9812.4 9815.6 9576.4 9703.8 9704.0 9760.1 9824.3 37965.4 38368.4 38570.0 38572.6 38580.0 3335.8 3355.3 3419.7 3439.1 3704.6 29100.7 29501.0 29679.3 30387.0 31025.2 3425.8 3492.0 3554.0 3589.9 3592.1 238239.0 239024.0 239545.0 239906.0 240845.8 57694.7 58683.0 58755.4 58769.7 58788.0 60284.4 60479.4 60536.0 60629.7 60696.7 12655.1 14274.9 14507.8 14523.8 14560.1 9122.7 9136.8 9149.5 9155.0 10998.3 18815.4 19181.5 19386.4 19442.1 19624.9 6858.0 7075.9 7110.3 7171.2 7313.6 921.6 927.2 959.8 1004.9 1013.4 25384.0 26371.3 26560.5 26639.0 26701.2 956.6 959.4 969.6 974.8 1031.9 14809.9 15052.8 15106.6 15148.8 15319.6 342896.0 349846.0 352070.0 353293.0 353592.0 48870.5 49492.0 49694.8 49804.5 49901.0 1147.3 1197.4 1197.9 1278.2 1313.0 27040.5 27542.0 29423.6 29464.9 30089.0 43790.0 44030.3 44684.8 44804.3 44961.3 327215.0 335737.0 336049.0 336137.0 337976.0 33605.0 38386.0 40569.0 41550.0 41639.2 42759.0 43842.1 43932.0 44692.0 45036.8 36620.0 37258.8 37347.4 37951.2 38197.0 36515.5 36804.4 37311.3 37348.3 37530.6 37054.4 37449.4 37734.8 38202.0 38295.4 33230.8 33628.7 33719.5 34159.3 34335.8 25411.1 25679.6 25848.6 25934.1 26111.0 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | [#2] jquery.html Cycles:180 Average:24730.34 Median:406268.00 stddev:66413.70 (16.3%) stddev-sans-first:66574.81 10:07:56 INFO - PROCESS | 20955 | Values: 367.9 369.3 373.4 374.4 385.1 15934.4 16649.5 17140.1 17142.7 17181.0 14328.9 14346.5 14383.2 14393.0 14395.0 4772.2 5162.1 5169.0 5172.3 5178.8 3665.2 4895.0 5710.1 6030.2 6061.7 5988.8 5996.6 6001.0 6011.2 6013.5 5950.8 6018.7 6029.7 6044.8 6048.3 3408.2 5005.4 5087.1 5264.7 5268.8 18633.8 19472.2 19495.3 19548.6 19568.2 1936.5 2072.6 2114.9 2173.8 2614.7 8714.5 9027.4 9310.6 9334.2 13217.7 1746.2 1847.7 1855.0 1855.4 1910.5 68712.7 69613.7 71108.3 71712.3 71877.0 10158.9 10295.3 10324.5 10399.3 10534.2 14296.1 14339.6 14369.3 14408.9 14426.5 7082.9 7234.4 7275.8 7321.2 7340.6 6583.6 6588.1 6632.1 6686.6 6726.2 4419.4 4458.0 4466.6 4471.5 4581.8 1712.4 1791.7 1801.6 1806.3 1814.3 859.5 898.3 917.7 941.2 948.6 15484.6 16667.2 17109.0 17482.6 17692.8 856.9 866.1 879.2 880.9 883.5 9417.7 9651.0 9715.1 9724.1 9741.3 392326.0 396369.0 404625.0 407911.0 408107.0 81393.2 81829.0 82473.0 83743.2 84289.0 917.8 924.4 928.6 935.5 935.9 15076.7 15126.5 15268.8 15285.7 15408.0 26305.2 32009.5 35224.5 35390.5 35795.0 49072.3 49694.8 51185.2 51295.0 51796.0 7735.5 7757.5 7843.4 7897.8 8047.2 11341.6 12203.5 12233.3 12322.3 12381.7 10397.9 10525.1 10755.6 10794.5 10851.2 10113.5 10341.8 10351.1 10455.4 10596.2 10397.4 10436.6 10912.7 10921.9 10988.7 7295.2 7509.2 7693.9 7721.5 8193.5 10019.2 10774.9 10881.3 10922.2 11048.3 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | [#3] mootools.html Cycles:180 Average:5210.98 Median:5493.28 stddev:2894.20 (52.7%) stddev-sans-first:2885.21 10:07:56 INFO - PROCESS | 20955 | Values: 1024.8 1393.1 1420.1 1469.1 1554.5 7421.6 7806.3 7810.4 7811.6 7830.5 7562.6 7726.3 7727.5 7735.8 7748.6 1904.5 2120.0 2169.7 2207.6 2233.9 2194.2 2211.9 2219.8 2220.1 2221.2 2168.1 2224.2 2227.8 2231.9 2233.7 1856.4 2126.1 2207.0 2208.0 2208.1 2063.2 2102.5 2109.5 2110.7 2112.1 7638.3 7664.1 7695.0 7700.9 7723.8 4631.1 4761.0 4792.9 4800.2 4838.2 3069.5 3095.0 3095.1 3104.7 3154.3 925.9 938.9 941.2 951.9 964.6 10743.8 10747.7 10762.6 10763.5 10769.3 4296.3 4301.2 4452.8 4500.4 4516.6 9055.8 9072.2 9160.3 9169.4 9198.2 4028.3 4774.5 4788.5 4816.7 4820.0 4251.8 4374.1 4387.0 4389.5 4421.4 3687.5 3692.4 3811.8 3821.8 3843.4 1189.4 1196.9 1202.9 1207.7 1215.5 819.8 828.3 830.7 850.3 856.5 5454.0 5463.5 5523.1 5602.5 5719.6 419.0 420.1 420.9 940.8 945.3 3738.3 3800.2 3844.3 3866.4 3875.5 9364.6 9720.3 9826.5 9853.7 9877.5 9296.0 9754.0 9768.2 9788.8 9790.5 7197.5 7274.0 7333.4 7353.0 7355.0 5382.9 5629.5 5635.5 5724.1 5797.8 8648.7 8732.6 8832.6 8868.1 8948.6 8948.8 9022.1 9208.4 9341.9 9375.9 6140.1 6710.3 6805.9 6908.2 7012.3 7514.5 7524.6 7577.3 7580.0 7596.2 6559.9 6778.2 6783.0 6879.3 6924.6 6637.2 6661.4 6705.9 6759.6 6817.8 6422.4 6575.8 6618.3 6635.6 6640.8 4770.4 4803.6 4869.6 4921.6 4930.3 4774.2 4806.8 4810.2 4839.5 4959.8 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | [#4] prototype.html Cycles:180 Average:4531.69 Median:5191.52 stddev:1328.02 (25.6%) stddev-sans-first:1293.37 10:07:56 INFO - PROCESS | 20955 | Values: 309.1 316.4 317.4 322.5 326.6 5205.3 5230.9 5235.2 5235.4 5257.4 5162.0 5162.9 5164.4 5189.8 5193.3 3801.7 3906.8 3946.4 4065.0 4068.3 4063.6 4075.7 4082.2 4099.4 4103.1 3836.9 4064.7 4066.7 4070.9 4074.1 3937.6 4031.4 4038.6 4058.3 4070.1 3583.2 3598.3 3602.3 3608.6 3612.2 4965.3 4979.0 4994.0 4999.4 5011.4 4560.8 4639.6 4647.7 4648.9 4656.4 5404.8 5421.4 5427.0 5428.6 5433.8 3880.3 3883.4 3891.6 3899.3 3902.1 5533.0 5715.6 5718.2 5744.2 5751.3 3957.5 3971.7 3983.2 3992.4 4005.5 4025.0 4038.9 4040.0 4044.0 4052.7 4300.3 4558.8 4604.2 4606.4 4610.2 5453.8 5475.6 5482.0 5484.9 5495.4 1350.9 1354.6 1362.9 1363.1 1363.8 882.3 891.5 912.3 917.6 920.3 4711.8 4712.2 4727.3 4735.7 4751.0 5589.4 5597.9 5602.1 5602.9 5608.6 4558.7 4703.3 4710.4 4722.7 4824.3 3022.6 3030.2 3035.6 3050.1 3059.3 5368.3 5373.0 5380.3 5380.4 5383.5 5624.7 5869.4 5886.6 5900.4 5901.9 5359.0 5381.7 5389.3 5396.0 5403.1 5438.3 5698.9 5723.7 5733.8 5736.1 5580.2 5591.7 5592.5 5597.6 5605.5 5351.9 5352.9 5353.9 5359.7 5381.8 3746.1 3931.1 3950.8 3954.5 3957.1 5618.0 5631.4 5634.3 5655.4 5676.2 5461.5 5483.1 5483.8 5487.8 5490.1 5337.7 5433.2 5481.3 5486.6 5488.0 5121.4 5349.3 5359.7 5360.3 5367.8 5392.4 5396.1 5401.6 5405.6 5409.3 5016.2 5328.9 5403.6 5407.9 5411.8 10:07:56 INFO - PROCESS | 20955 | 10:07:56 INFO - PROCESS | 20955 | [#5] yui.html Cycles:180 Average:12839.82 Median:46482.88 stddev:14594.25 (31.4%) stddev-sans-first:14606.94 10:07:56 INFO - PROCESS | 20955 | Values: 749.9 751.3 763.7 775.2 790.4 12244.6 12537.4 12574.2 12608.7 12613.6 12234.5 12266.2 12273.1 12277.1 12333.6 639.8 778.7 801.7 813.1 815.1 806.6 809.4 810.0 810.8 811.1 858.5 862.5 862.7 863.3 863.4 576.6 824.6 849.1 860.4 861.2 631.7 631.8 631.9 632.1 632.7 11931.5 11989.9 12007.0 12023.8 12029.5 11759.6 12356.9 12662.4 12774.8 12999.3 10971.1 10979.5 11192.2 11301.3 11662.7 3310.7 3327.9 3349.8 3468.4 3471.8 45116.0 46471.0 46494.8 47139.0 47155.3 9639.0 9672.7 9686.7 9726.5 10253.3 16289.5 16420.5 16451.0 16460.8 16513.9 6886.4 6913.0 6945.1 7037.9 7193.9 3907.0 3908.1 3942.7 4007.5 4038.1 2751.4 2814.5 2826.8 2829.4 2833.1 472.4 485.9 519.4 523.1 526.2 502.0 544.1 563.3 625.6 626.6 7576.9 7807.8 8183.2 8269.0 8374.1 504.6 568.6 616.8 626.4 635.9 3734.3 3738.8 3765.9 3811.7 3933.9 48864.0 49734.3 51452.7 51653.0 53571.0 46775.1 47875.5 48242.5 48622.0 48798.5 43898.8 43970.6 43977.3 45024.5 45038.3 7476.4 7477.0 8273.1 8334.2 8417.2 27258.9 27731.4 28277.2 29168.9 29703.7 38654.4 39475.8 39524.6 40036.8 40671.8 11290.2 11425.9 11431.7 11611.7 11786.5 11414.0 11827.0 12128.2 12304.4 12386.4 8038.9 9915.9 10803.6 10870.1 10977.5 11334.9 11341.9 11382.7 11408.3 11894.3 10364.1 10636.8 10753.0 10898.7 10988.0 9018.8 9182.8 9216.7 9442.2 9649.9 8549.0 8762.2 8840.9 9359.0 9387.3 10:07:56 INFO - PROCESS | 20955 | -------- Summary: end -------- 10:07:56 INFO - PROCESS | 20955 | 10:07:57 INFO - TEST-INFO | 20955: exit 0 10:07:57 INFO - TEST-OK | dromaeo_css | took 1118502ms 10:07:57 INFO - TEST-START | kraken 10:07:57 INFO - operating with platform_type : linux_ 10:07:57 INFO - Initialising browser for kraken test... 10:07:57 INFO - TEST-INFO | started process 21131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWyDXVL/profile http://localhost:53909/getInfo.html) 10:08:01 INFO - PROCESS | 21131 | __metrics Screen width/height:1600/1200 10:08:01 INFO - PROCESS | 21131 | colorDepth:24 10:08:01 INFO - PROCESS | 21131 | Browser inner width/height: 1024/697 10:08:01 INFO - PROCESS | 21131 | __metrics 10:08:02 ERROR - PROCESS | 21131 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:08:03 INFO - TEST-INFO | 21131: exit 0 10:08:03 INFO - Browser initialized. 10:08:03 INFO - Running cycle 1/1 for kraken test... 10:08:03 INFO - TEST-INFO | started process 21210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWyDXVL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:15 INFO - PROCESS | 21210 | RSS: Main: 155914240 10:08:15 INFO - PROCESS | 21210 | 10:08:17 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53909/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:18 INFO - PROCESS | 21210 | RSS: Main: 210956288 10:08:18 INFO - PROCESS | 21210 | 10:08:21 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53909/tests/kraken/driver.html?testName=audio-dft) 10:08:22 INFO - PROCESS | 21210 | RSS: Main: 196186112 10:08:22 INFO - PROCESS | 21210 | 10:08:25 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53909/tests/kraken/driver.html?testName=audio-fft) 10:08:26 INFO - PROCESS | 21210 | RSS: Main: 265945088 10:08:26 INFO - PROCESS | 21210 | 10:08:28 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53909/tests/kraken/driver.html?testName=audio-oscillator) 10:08:28 INFO - PROCESS | 21210 | RSS: Main: 174800896 10:08:28 INFO - PROCESS | 21210 | 10:08:31 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53909/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:31 INFO - PROCESS | 21210 | RSS: Main: 179253248 10:08:31 INFO - PROCESS | 21210 | 10:08:34 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53909/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:35 INFO - PROCESS | 21210 | RSS: Main: 215007232 10:08:35 INFO - PROCESS | 21210 | 10:08:38 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53909/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:39 INFO - PROCESS | 21210 | RSS: Main: 216268800 10:08:39 INFO - PROCESS | 21210 | 10:08:42 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53909/tests/kraken/driver.html?testName=json-parse-financial) 10:08:43 INFO - PROCESS | 21210 | RSS: Main: 216137728 10:08:43 INFO - PROCESS | 21210 | 10:08:44 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53909/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:45 INFO - PROCESS | 21210 | RSS: Main: 201666560 10:08:45 INFO - PROCESS | 21210 | 10:08:47 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:47 INFO - PROCESS | 21210 | RSS: Main: 204791808 10:08:47 INFO - PROCESS | 21210 | 10:08:49 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:50 INFO - PROCESS | 21210 | RSS: Main: 215572480 10:08:50 INFO - PROCESS | 21210 | 10:08:53 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:53 INFO - PROCESS | 21210 | RSS: Main: 220823552 10:08:53 INFO - PROCESS | 21210 | 10:08:56 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:57 INFO - PROCESS | 21210 | RSS: Main: 220303360 10:08:57 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | Cycle 1(1): loaded http://localhost:53909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53909/tests/kraken/driver.html?testName=ai-astar) 10:08:59 INFO - PROCESS | 21210 | RSS: Main: 283660288 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | __start_tp_report 10:08:59 INFO - PROCESS | 21210 | _x_x_mozilla_page_load 10:08:59 INFO - PROCESS | 21210 | _x_x_mozilla_page_load_details 10:08:59 INFO - PROCESS | 21210 | |i|pagename|runs| 10:08:59 INFO - PROCESS | 21210 | |0;ai-astar;111;113;108;112;112;112;103;112;113;112 10:08:59 INFO - PROCESS | 21210 | |1;audio-beat-detection;150;139;157;199;134;161;157;132;193;130 10:08:59 INFO - PROCESS | 21210 | |2;audio-dft;161;160;161;159;162;162;161;161;162;161 10:08:59 INFO - PROCESS | 21210 | |3;audio-fft;78;74;119;115;75;74;73;120;103;73 10:08:59 INFO - PROCESS | 21210 | |4;audio-oscillator;94;94;145;96;94;94;141;94;93;145 10:08:59 INFO - PROCESS | 21210 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 10:08:59 INFO - PROCESS | 21210 | |6;imaging-darkroom;147;146;147;147;146;145;146;146;146;146 10:08:59 INFO - PROCESS | 21210 | |7;imaging-desaturate;94;94;95;94;94;95;95;94;94;95 10:08:59 INFO - PROCESS | 21210 | |8;json-parse-financial;65;66;65;65;66;65;65;79;64;64 10:08:59 INFO - PROCESS | 21210 | |9;json-stringify-tinderbox;64;64;65;64;65;67;65;71;65;65 10:08:59 INFO - PROCESS | 21210 | |10;stanford-crypto-aes;78;84;77;86;78;80;79;78;80;78 10:08:59 INFO - PROCESS | 21210 | |11;stanford-crypto-ccm;137;133;135;131;138;129;131;134;222;131 10:08:59 INFO - PROCESS | 21210 | |12;stanford-crypto-pbkdf2;176;177;174;175;170;173;173;172;177;173 10:08:59 INFO - PROCESS | 21210 | |13;stanford-crypto-sha256-iterative;72;71;74;73;72;73;72;68;70;69 10:08:59 INFO - PROCESS | 21210 | __end_tp_report 10:08:59 INFO - PROCESS | 21210 | __start_cc_report 10:08:59 INFO - PROCESS | 21210 | _x_x_mozilla_cycle_collect,1910 10:08:59 INFO - PROCESS | 21210 | __end_cc_report 10:08:59 INFO - PROCESS | 21210 | __startTimestamp1461431339600__endTimestamp 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | ------- Summary: start ------- 10:08:59 INFO - PROCESS | 21210 | Number of tests: 14 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.08 (2.8%) stddev-sans-first:3.27 10:08:59 INFO - PROCESS | 21210 | Values: 111.0 113.0 108.0 112.0 112.0 112.0 103.0 112.0 113.0 112.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:157.00 stddev:24.27 (15.5%) stddev-sans-first:25.67 10:08:59 INFO - PROCESS | 21210 | Values: 150.0 139.0 157.0 199.0 134.0 161.0 157.0 132.0 193.0 130.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 10:08:59 INFO - PROCESS | 21210 | Values: 161.0 160.0 161.0 159.0 162.0 162.0 161.0 161.0 162.0 161.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#3] audio-fft Cycles:10 Average:90.40 Median:73.50 stddev:21.06 (28.7%) stddev-sans-first:21.86 10:08:59 INFO - PROCESS | 21210 | Values: 78.0 74.0 119.0 115.0 75.0 74.0 73.0 120.0 103.0 73.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.00 stddev:23.96 (25.5%) stddev-sans-first:24.79 10:08:59 INFO - PROCESS | 21210 | Values: 94.0 94.0 145.0 96.0 94.0 94.0 141.0 94.0 93.0 145.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:08:59 INFO - PROCESS | 21210 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:08:59 INFO - PROCESS | 21210 | Values: 147.0 146.0 147.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:08:59 INFO - PROCESS | 21210 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.00 stddev:4.48 (6.9%) stddev-sans-first:4.72 10:08:59 INFO - PROCESS | 21210 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 65.0 79.0 64.0 64.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:2.12 (3.3%) stddev-sans-first:2.18 10:08:59 INFO - PROCESS | 21210 | Values: 64.0 64.0 65.0 64.0 65.0 67.0 65.0 71.0 65.0 65.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.50 stddev:2.94 (3.7%) stddev-sans-first:3.04 10:08:59 INFO - PROCESS | 21210 | Values: 78.0 84.0 77.0 86.0 78.0 80.0 79.0 78.0 80.0 78.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:134.50 stddev:28.22 (21.0%) stddev-sans-first:29.87 10:08:59 INFO - PROCESS | 21210 | Values: 137.0 133.0 135.0 131.0 138.0 129.0 131.0 134.0 222.0 131.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.50 stddev:2.26 (1.3%) stddev-sans-first:2.28 10:08:59 INFO - PROCESS | 21210 | Values: 176.0 177.0 174.0 175.0 170.0 173.0 173.0 172.0 177.0 173.0 10:08:59 INFO - PROCESS | 21210 | 10:08:59 INFO - PROCESS | 21210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.00 stddev:1.90 (2.6%) stddev-sans-first:2.00 10:08:59 INFO - PROCESS | 21210 | Values: 72.0 71.0 74.0 73.0 72.0 73.0 72.0 68.0 70.0 69.0 10:08:59 INFO - PROCESS | 21210 | -------- Summary: end -------- 10:08:59 INFO - PROCESS | 21210 | 10:09:00 INFO - TEST-INFO | 21210: exit 0 10:09:00 INFO - TEST-OK | kraken | took 63010ms 10:09:00 INFO - SUITE-END | took 1181s 10:09:00 INFO - Completed test suite (00:19:41) 10:09:00 INFO - javascript benchmark 10:09:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.684797824261, 2694.110943388682, 2696.7707744841687, 2716.3480764616484, 2729.6724393072836, 4624.583787459136, 4715.669903106784, 4717.528247175281, 4725.669203155776, 4736.715797052175, 4618.2379907315335, 4715.599174070199, 4724.976375118128, 4727.1727447696685, 4749.073930583538, 4240.597143271384, 4244.851430199951, 4257.6806739494505, 4288.206681763868, 4425.734455932655, 4358.869233922987, 4386.1008493258805, 4401.449818772653, 4428.512863585019, 4441.3115967025005, 4258.382534532476, 4280.122574872144, 4314.741115533062, 4339.218940590692, 4358.237308471036, 4285.121550082225, 4300.22595932732, 4343.674224433149, 4346.500152482474, 4353.25994580922, 4293.441852559178, 4310.48274207094, 4330.480342358937, 4330.870073897788, 4363.541828108035, 4502.144592527442, 4533.206688829442, 4618.468876079227, 4638.234691275936, 4683.859484215479, 4991.151504244287, 5009.499050094998, 5013.197888337849, 5013.749312534395, 5015.172496538104, 5044.192929131358, 5049.4950504949575, 5051.9494805051845, 5064.215046667736, 5084.491550844923, 4534.342520334533, 4678.8596342109795, 4719.716816990923, 4759.952400476021, 4760.904781904343, 5185.870353241199, 5217.660852044605, 5233.738313084331, 5239.580833533309, 5244.921326180111, 4732.479427262998, 4980.7509624518625, 5010.148274793294, 5013.498650134958, 5064.898702025939, 5027.648064635514, 5109.693418394908, 5120.308758317654, 5126.102931986888, 5127.051495473274, 4954.702717836942, 4962.8511144665, 4967.081089998362, 4969.403671559436, 5006.849794506171, 4938.555530002317, 4945.975270123627, 4948.529889660476, 4949.727764972889, 4972.5276098770555, 4202.558731333227, 4278.187144442546, 4293.0769884474985, 4359.17175736609, 4366.235908715962, 3763.6424539668687, 3764.5106136202116, 3773.716971227169, 3797.9430308545393, 3833.4058220975235, 4348.978255108767, 4352.368906508538, 4357.477102747627, 4395.626371758372, 4406.4051353066925, 4995.950040499549, 5076.898462030813, 5108.157154069611, 5162.793488260428, 5163.586913046947, 4318.265894797892, 4319.632831209383, 4327.17783621111, 4336.501302350207, 4347.043650396908, 4550.203714350042, 4552.453705555355, 4556.248219043887, 4562.794674239667, 4605.194091034055, 4648.1168577970075, 4761.285807128958, 4799.688020278671, 4837.129316723023, 4841.636877234292, 5067.163917953644, 5072.59419246452, 5086.415062267886, 5095.719735414439, 5145.897082058263, 4658.440987081572, 4791.712497250176, 4793.544613261734, 4796.25658023007, 4843.055604157155, 4931.679440836334, 4973.776180071833, 5001.199808030698, 5030.170021946338, 5045.772940217773, 5070.264811602371, 5075.771590278372, 5077.339945807022, 5086.491350864884, 5132.10188217053, 4844.103840789465, 4867.756612169306, 4942.521853670242, 4946.777395017161, 4946.975265123651, 4863.902721945612, 4887.853364399074, 4889.804407823647, 4909.656324057281, 4937.01259748059, 4798.808047678054, 4802.543758342952, 4804.0872234275375, 4814.7833347498745, 4862.41651001882, 4781.641376896677, 4894.755262236803, 4974.801007959786, 4977.552020318189, 4988.376452943382, 4745.193317136164, 4780.282957556395, 4788.377510923558, 4789.640776941674, 4884.242942343943], "value": 4632.518825940383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7801257509569, 600.6696317025636, 619.4486906653077, 621.5928566788753, 622.5175488996027, 27411.451770964595, 27823.0, 27920.581191282123, 27935.860320698393, 33706.83146584264, 34291.65708342922, 35047.12382190447, 35167.648323516754, 35255.11862203446, 36488.81755591218, 7517.24827517248, 7742.496737712059, 7811.492253003565, 7822.217778222161, 7822.217778222189, 7507.587082710449, 7589.241075892422, 7757.301842834144, 9495.097965693283, 9761.511924403787, 9679.564419601134, 9853.65512207073, 9864.408135511892, 9865.506724663774, 9897.257705672104, 9674.22606191503, 9711.61153553857, 9807.411555306633, 9812.411255324632, 9815.607375705034, 9576.377535460173, 9703.805923881553, 9704.0, 9760.072793084646, 9824.263180261438, 37965.43051854224, 38368.42447363292, 38570.0, 38572.61427385718, 38580.0, 3335.7831740936763, 3355.295387968505, 3419.743519236067, 3439.07145070832, 3704.6480584344445, 29100.70899291001, 29501.0, 29679.25801854949, 30387.0, 31025.22436939072, 3425.811580363079, 3491.9650803491895, 3553.982230088833, 3589.892303230907, 3592.1019745063736, 238239.0, 239024.0, 239544.99999999825, 239906.0, 240845.79577102177, 57694.71152644294, 58683.0, 58755.41244587585, 58769.70615146982, 58788.0, 60284.397156028754, 60479.395206047375, 60536.0, 60629.69685151634, 60696.696516517135, 12655.114142010156, 14274.857251427353, 14507.782383264259, 14523.78214326786, 14560.126392416489, 9122.726318210463, 9136.771580710403, 9149.542522873962, 9154.954225228965, 10998.34009959389, 18815.435536933914, 19181.520461988563, 19386.4184074478, 19442.125104370054, 19624.901875490817, 6858.0, 7075.858482830315, 7110.288971102848, 7171.211166771651, 7313.597752123685, 921.6037104045325, 927.1562877781187, 959.7744530035436, 1004.8542961270575, 1013.4122209118693, 25384.0, 26371.340716481856, 26560.46879062408, 26639.0, 26701.19896403111, 956.6125719083643, 959.3764053365369, 969.6170012844887, 974.8294048541477, 1031.9277650564538, 14809.92595037018, 15052.774208386883, 15106.622334441727, 15148.772768408482, 15319.617009574627, 342896.0, 349846.0, 352070.0, 353293.0, 353592.0, 48870.51129488731, 49492.0, 49694.75152624214, 49804.50195497998, 49901.0, 1147.260017288844, 1197.3534291482501, 1197.9101567382656, 1278.1564167649308, 1313.0152385710717, 27040.45919081568, 27542.0, 29423.55864661989, 29464.852675736485, 30089.0, 43790.0, 44030.33954490621, 44684.776576116914, 44804.32793508165, 44961.32558011567, 327215.0, 335737.0, 336049.0, 336137.0, 337976.0, 33605.0, 38386.040348990384, 40569.0, 41550.0, 41639.167216656104, 42759.0, 43842.12315753731, 43932.0, 44692.0, 45036.77481612702, 36620.0, 37258.813705931294, 37347.439788402655, 37951.240975180895, 38197.0, 36515.452268216526, 36804.37248015373, 37311.2537749238, 37348.25303493969, 37530.6246937538, 37054.44418333673, 37449.4382584256, 37734.81132594319, 38202.0, 38295.42556861594, 33230.833845831585, 33628.66371336353, 33719.4942075874, 34159.31681366408, 34335.828320858236, 25411.110611128523, 25679.614805778303, 25848.612270815578, 25934.092306769173, 26111.0], "value": 18182.449855465526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.874922526341, 369.2614770459083, 373.3503703555812, 374.36358191075163, 385.114237254315, 15934.362625494981, 16649.500514984557, 17140.057296848667, 17142.742858857113, 17181.0, 14328.928355358208, 14346.497872574462, 14383.208923509203, 14393.0, 14395.0, 4772.188727916246, 5162.096633089194, 5169.0, 5172.327597412331, 5178.7669554869935, 3665.2303016366595, 4894.97552512237, 5710.114932185518, 6030.155778191057, 6061.696915154247, 5988.790392336269, 5996.640201587897, 6001.039833626621, 6011.248593925759, 6013.458788709037, 5950.761969521214, 6018.6990650467305, 6029.668368239745, 6044.788432404889, 6048.304444988838, 3408.1820363112924, 5005.449400565934, 5087.135187018179, 5264.7367631618645, 5268.8155914543195, 18633.813661863478, 19472.221111155537, 19495.317663881837, 19548.609027819508, 19568.217271309273, 1936.4965109071602, 2072.616565935307, 2114.9365519034454, 2173.847830651855, 2614.686237651494, 8714.520701361422, 9027.36808423404, 9310.627574896997, 9334.159925606727, 13217.73564528704, 1746.1531157388656, 1847.6951303034982, 1855.0, 1855.4155441036166, 1910.484169274302, 68712.6564367175, 69613.65193174002, 71108.28891711068, 71712.28287717108, 71877.0, 10158.898411015944, 10295.330803497749, 10324.535395907053, 10399.32404393712, 10534.157267418588, 14296.142231466145, 14339.641508962151, 14369.281535923163, 14408.927955360155, 14426.495072672406, 7082.929170708227, 7234.421246300283, 7275.769381178422, 7321.194668586451, 7340.632968351561, 6583.63789991555, 6588.143541339691, 6632.071509988606, 6686.565373250821, 6726.159230096238, 4419.447569053868, 4457.955420445819, 4466.620337271368, 4471.485779135441, 4581.79381927814, 1712.3921008042214, 1791.7133258678548, 1801.5766294920684, 1806.2594336322309, 1814.3105619864632, 859.5487369131256, 898.2544488074882, 917.6696389299847, 941.1623654947102, 948.5636607160783, 15484.612884677974, 16667.166641667867, 17109.0, 17482.562935926704, 17692.76150669441, 856.9400141990001, 866.1425189062783, 879.2438502887512, 880.933929955256, 883.5052370672444, 9417.717468475958, 9650.95174524137, 9715.07706767856, 9724.124828765303, 9741.318107732392, 392326.0, 396369.0, 404625.0, 407911.0, 408107.0, 81393.18606813856, 81829.0, 82473.0, 83743.16256837353, 84289.0, 917.8439665256923, 924.3529529329496, 928.5914197753102, 935.5182081228173, 935.9110884465965, 15076.698466030399, 15126.546203613909, 15268.808605074328, 15285.694286113992, 15408.0, 26305.210843674722, 32009.519857201696, 35224.47163292604, 35390.46914296339, 35795.0, 49072.263916042, 49694.75152624214, 51185.23222151745, 51295.0, 51796.0, 7735.458517903693, 7757.495762775401, 7843.372530197456, 7897.763067107996, 8047.195280471906, 11341.603043893425, 12203.450844711831, 12233.3271670059, 12322.260664360167, 12381.690457738629, 10397.896021039693, 10525.052745252964, 10755.623553175601, 10794.460276985963, 10851.186161037796, 10113.544890480092, 10341.84487232677, 10351.120154786928, 10455.372677639061, 10596.15230781551, 10397.428141452292, 10436.582536698446, 10912.672619821418, 10921.890781092405, 10988.670339889815, 7295.192958699958, 7509.211532789197, 7693.88459173124, 7721.459497835098, 8193.549354785544, 10019.198464123, 10774.892251077388, 10881.347119172875, 10922.235443519196, 11048.337099774039], "value": 8305.75923672721, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1024.7694268789528, 1393.0736060519753, 1420.0840457904649, 1469.1258701072863, 1554.5103292462873, 7421.5547067176, 7806.258405451487, 7810.414218933582, 7811.6094195290225, 7830.530168189898, 7562.62186890656, 7726.304632583066, 7727.536347819121, 7735.845283094349, 7748.612569371523, 1904.476269026022, 2119.9894000529976, 2169.6962425260476, 2207.6467765157618, 2233.8659680419146, 2194.18815038436, 2211.9447013824624, 2219.82241420686, 2220.0786673530547, 2221.2336743823435, 2168.078566609193, 2224.1881713174735, 2227.8440509164366, 2231.8884055797225, 2233.6761169630395, 1856.4059500959697, 2126.1282874021654, 2206.9889650551645, 2208.028467474306, 2208.061573831131, 2063.1541068161982, 2102.495401103724, 2109.5148115933266, 2110.693949377347, 2112.0706888968803, 7638.312551870303, 7664.080310362792, 7694.961525192338, 7700.884486732703, 7723.845523089563, 4631.120087183424, 4761.0, 4792.9281060784115, 4800.159972004885, 4838.201696720037, 3069.4628440022907, 3094.9535756963664, 3095.148834070626, 3104.6584875663657, 3154.3375891062906, 925.8935222449437, 938.9342746007782, 941.1717688434203, 951.9428834269966, 964.5852283518085, 10743.83884241737, 10747.677569672922, 10762.569497220102, 10763.515641796217, 10769.299995500267, 4296.2696341621995, 4301.182775272689, 4452.755098469551, 4500.392447019676, 4516.638668906546, 9055.773605659911, 9072.183503484717, 9160.267178625827, 9169.40398874071, 9198.2181514572, 4028.274910516135, 4774.4509381420885, 4788.497207793202, 4816.710997340171, 4820.011897561062, 4251.829926802955, 4374.103308821684, 4387.0, 4389.473263208435, 4421.358902959053, 3687.483752274684, 3692.372296709566, 3811.7712937223855, 3821.8280177392085, 3843.404272337792, 1189.41718557906, 1196.8862958018974, 1202.909781766371, 1207.7403358277836, 1215.5077193736552, 819.8032472206628, 828.2793969246794, 830.7009476588423, 850.2815121222557, 856.4903882190087, 5454.0, 5463.48096930791, 5523.088690366045, 5602.52378547828, 5719.570107473131, 418.98114584843756, 420.1303302164551, 420.9410682504452, 940.8071345374182, 945.3004776465366, 3738.3084129436143, 3800.239952009609, 3844.308024555607, 3866.439366291872, 3875.457435958968, 9364.625414983324, 9720.31957762964, 9826.508674566243, 9853.704388868346, 9877.456739879375, 9295.953520232355, 9754.0, 9768.169705574963, 9788.804223915624, 9790.510474476248, 7197.4961752677855, 7273.963630181921, 7333.376662983599, 7353.0, 7355.0, 5382.892342153056, 5629.493345598916, 5635.520980716521, 5724.084146536534, 5797.768089276382, 8648.654053837776, 8732.607032683418, 8832.558372081241, 8868.11318868108, 8948.642054317754, 8948.776280593038, 9022.052684468037, 9208.447493150432, 9341.859872102059, 9375.906240937777, 6140.109684095871, 6710.261871194067, 6805.89791153143, 6908.240093589801, 7012.263712310338, 7514.511556748794, 7524.586147761706, 7577.318041376303, 7580.0145981022115, 7596.240375962359, 6559.868802623825, 6778.186617605918, 6782.96608516974, 6879.346462086094, 6924.619145947021, 6637.1703537057865, 6661.4004739573675, 6705.932940670531, 6759.594424334556, 6817.761378351932, 6422.3577642235405, 6575.769848055295, 6618.338166183343, 6635.6350400728425, 6640.83397915056, 4770.356001939694, 4803.615710743202, 4869.638225460578, 4921.557059864486, 4930.285108659296, 4774.164521208844, 4806.7836947338155, 4810.158222311012, 4839.467658557485, 4959.752012399438], "value": 4166.217301337893, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.088189839972, 316.36568679797006, 317.40011378494637, 322.46309894026444, 326.5901293876185, 5205.349331333583, 5230.8692282692955, 5235.188545775406, 5235.424103348629, 5257.395399529055, 5161.974190129054, 5162.870928226786, 5164.354455693038, 5189.766460509277, 5193.272941788153, 3801.676857467112, 3906.785126818024, 3946.4474973503734, 4064.959350406488, 4068.3083875741195, 4063.553009168989, 4075.6535694465856, 4082.2447847148223, 4099.364598487239, 4103.138340948404, 3836.9232615347814, 4064.6748260139116, 4066.742957658498, 4070.9185816283803, 4074.0629655179328, 3937.645611894929, 4031.3549832026883, 4038.5557588665224, 4058.310087285139, 4070.1452694933805, 3583.1692962559546, 3598.298331825295, 3602.2975519773654, 3608.564219152062, 3612.24142929985, 4965.280034395028, 4978.950210497921, 4994.0, 4999.375078115236, 5011.423686276052, 4560.817567297304, 4639.5824375806005, 4647.651426143019, 4648.907021859543, 4656.441227052742, 5404.756785944603, 5421.376541697716, 5427.0, 5428.647137936022, 5433.8369848904595, 3880.2821478026653, 3883.417487376888, 3891.6302951219873, 3899.2786334528205, 3902.083010492532, 5532.972335138298, 5715.628484148517, 5718.228039214694, 5744.22452968848, 5751.281089863767, 3957.45659192915, 3971.7219794614675, 3983.1635356574866, 3992.4210989406956, 4005.4792876925812, 4024.95351208682, 4038.9394159087637, 4039.979800100981, 4044.0, 4052.675785937118, 4300.268954277781, 4558.817647294138, 4604.194266003436, 4606.424196975378, 4610.170169369546, 5453.809116680976, 5475.5907400743545, 5481.972590137104, 5484.890302193934, 5495.395506494282, 1350.8990173008967, 1354.552997510819, 1362.884154846849, 1363.1275983370651, 1363.8090667306585, 882.3206131279007, 891.5007595746403, 912.2565109435789, 917.554985831871, 920.2545937790411, 4711.8350857719815, 4712.246040633482, 4727.2909063640045, 4735.692180008288, 4750.976245118822, 5589.385167631557, 5597.888042239214, 5602.13166959122, 5602.943970560243, 5608.6073974821375, 4558.6978575819, 4703.270992996091, 4710.387649605598, 4722.693024953367, 4824.300476430898, 3022.561728549348, 3030.196997795586, 3035.635723713124, 3050.115466514686, 3059.3116548776347, 5368.302120724281, 5373.005993891143, 5380.300560927054, 5380.354357477127, 5383.5423988961375, 5624.690642014647, 5869.354371019184, 5886.58649953517, 5900.350961394243, 5901.940980590225, 5359.0, 5381.708389986454, 5389.272448219519, 5396.0, 5403.108487099663, 5438.347398312228, 5698.914516282176, 5723.742431590672, 5733.799317023884, 5736.139579063174, 5580.1629755537, 5591.692456914909, 5592.496675299242, 5597.5521958242425, 5605.523530499953, 5351.866203344947, 5352.919706204488, 5353.866153346197, 5359.705216213146, 5381.838544843661, 3746.1009357754488, 3931.095847954929, 3950.807301947447, 3954.4859168309085, 3957.149212919236, 5618.0, 5631.436856314336, 5634.295713035871, 5655.377908429987, 5676.176954341515, 5461.508464238079, 5483.095289277225, 5483.7806487740045, 5487.780488780404, 5490.0941344677685, 5337.706426146599, 5433.185022246536, 5481.342238931354, 5486.588505861996, 5488.0, 5121.362498313446, 5349.2778474906945, 5359.678419294854, 5360.276362691143, 5367.812126575551, 5392.352917649907, 5396.1366181410785, 5401.567874570103, 5405.621606487508, 5409.29679141709, 5016.197408414636, 5328.946710532845, 5403.621746477709, 5407.891842163213, 5411.756470958738], "value": 4106.272768587267, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.8875168724692, 751.27501960608, 763.732693557255, 775.1589525364978, 790.426940468161, 12244.571439999601, 12537.37313134342, 12574.245545267291, 12608.747825043505, 12613.621591352263, 12234.510619575229, 12266.202696824701, 12273.079519036064, 12277.140600157993, 12333.629991100259, 639.7664852328913, 778.7196609220676, 801.7033697531922, 813.0690359538326, 815.1481701621819, 806.6128258435954, 809.4293523066253, 809.9635516401746, 810.8175660476404, 811.0956283743612, 858.5363903492107, 862.4782006885838, 862.7023676831515, 863.2921004776086, 863.43876480288, 576.5819780659031, 824.5877061469265, 849.1084361420515, 860.4020205956863, 861.2335021830576, 631.6936285901335, 631.7662464887975, 631.8515148939996, 632.1434456311678, 632.7437387857925, 11931.522739090426, 11989.880101198964, 12007.039436845118, 12023.819642705279, 12029.458674359676, 11759.58841440554, 12356.938215308955, 12662.430190641444, 12774.808377874338, 12999.285039322833, 10971.122310215163, 10979.451027448597, 11192.216544841864, 11301.26541774782, 11662.650120496399, 3310.668933106694, 3327.9168020799675, 3349.7990120592845, 3468.4450487921813, 3471.7743346682637, 45116.0, 46471.0, 46494.767526162155, 47139.0, 47155.29267060997, 9638.95180524093, 9672.661456848977, 9686.660966866268, 9726.465044422624, 10253.33353332031, 16289.51131466058, 16420.507384778477, 16451.012939223445, 16460.83539164617, 16513.91743041301, 6886.449084073262, 6913.032175495435, 6945.131858517685, 7037.894431583531, 7193.89209161863, 3907.0427745202037, 3908.101136738566, 3942.743721658083, 4007.458993035961, 4038.0914294283552, 2751.380939288684, 2814.5496720524616, 2826.816256943292, 2829.3916807886403, 2833.079249244004, 472.4401584122825, 485.8639580917278, 519.4390058736556, 523.1263789471592, 526.18178732072, 501.9598432125421, 544.1266766839245, 563.3211979564614, 625.6183727925961, 626.6428135962549, 7576.886346704804, 7807.804804879924, 8183.222593853575, 8268.958655206685, 8374.120717324715, 504.64662318890765, 568.6275489554348, 616.8057062025448, 626.3923993726079, 635.9109724638554, 3734.2531493701367, 3738.8035828534607, 3765.9435108473394, 3811.676007539335, 3933.8819835404984, 48864.0, 49734.25398619023, 51452.742736286826, 51653.0, 53571.0, 46775.06449871052, 47875.5212447878, 48242.5175748245, 48622.0, 48798.51201488011, 43898.78050609727, 43970.560294397284, 43977.34033989493, 45024.54975450203, 45038.32442513365, 7476.439267054884, 7476.962615186889, 8273.131321211427, 8334.166583341617, 8417.158284171779, 27258.863705681346, 27731.44537109206, 28277.15168544947, 29168.854155729085, 29703.702962970092, 38654.42018369783, 39475.80262098671, 39524.604753952095, 40036.799816000734, 40671.796641016605, 11290.242026509992, 11425.885741142481, 11431.714207144887, 11611.6516504505, 11786.46960886745, 11414.0, 11827.0, 12128.151029427856, 12304.446299916346, 12386.442610082388, 8038.87941680887, 9915.900840991499, 10803.567857285621, 10870.130389568974, 10977.506012229629, 11334.94332528332, 11341.886581134084, 11382.715432114263, 11408.315501069963, 11894.34581098048, 10364.119049880845, 10636.84044739314, 10753.0, 10898.673039808818, 10988.0, 9018.774530636787, 9182.816343672956, 9216.677416290398, 9442.244620430487, 9649.855252171083, 8549.0, 8762.167594078552, 8840.911590884267, 9358.953205233931, 9387.342885998189], "value": 5954.6303742580385, "unit": "score"}], "name": "dromaeo_css", "value": 6439.0767721376205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 108.0, 112.0, 112.0, 112.0, 103.0, 112.0, 113.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 139.0, 157.0, 199.0, 134.0, 161.0, 157.0, 132.0, 193.0, 130.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 119.0, 115.0, 75.0, 74.0, 73.0, 120.0, 103.0, 73.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 145.0, 96.0, 94.0, 94.0, 141.0, 94.0, 93.0, 145.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 79.0, 64.0, 64.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 67.0, 65.0, 71.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 77.0, 86.0, 78.0, 80.0, 79.0, 78.0, 80.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 135.0, 131.0, 138.0, 129.0, 131.0, 134.0, 222.0, 131.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 174.0, 175.0, 170.0, 173.0, 173.0, 172.0, 177.0, 173.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 74.0, 73.0, 72.0, 73.0, 72.0, 68.0, 70.0, 69.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1583.1, "alertThreshold": 2.0}]} 10:09:00 INFO - Return code: 0 10:09:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:09:00 ERROR - # TBPL SUCCESS # 10:09:00 INFO - Running post-action listener: _resource_record_post_action 10:09:00 INFO - Running post-run listener: _resource_record_post_run 10:09:01 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518205440; Read time: 196; Write time: 411836 10:09:01 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234291200; Read time: 0; Write time: 201268 10:09:01 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283635712; Read time: 196; Write time: 210548 10:09:01 INFO - Running post-run listener: _upload_blobber_files 10:09:01 INFO - Blob upload gear active. 10:09:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:01 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 10:09:01 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'] 10:09:01 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 10:09:02 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:09:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:03 INFO - (blobuploader) - INFO - Done attempting. 10:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:09:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:09:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:04 INFO - (blobuploader) - INFO - Done attempting. 10:09:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:04 INFO - Return code: 0 10:09:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e85aba310b39b88e911a3f2a5705303afbc0f8566d8eda1404380f7624f7da6e6699933b701b7ff2310e4ca4ae861401430b39120c11504317863bb11870c6bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c1f8dfe4668f4a2cfe4cf3ddb593c6656fbcff23c19833aafa67215b528667c537772c2f8c149c13c32ae5b60d86915aa23ac9e1d187cc8e680ae491a8a9484"} 10:09:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:04 INFO - Contents: 10:09:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e85aba310b39b88e911a3f2a5705303afbc0f8566d8eda1404380f7624f7da6e6699933b701b7ff2310e4ca4ae861401430b39120c11504317863bb11870c6bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c1f8dfe4668f4a2cfe4cf3ddb593c6656fbcff23c19833aafa67215b528667c537772c2f8c149c13c32ae5b60d86915aa23ac9e1d187cc8e680ae491a8a9484"} 10:09:04 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:04 INFO - Copying logs to upload dir... 10:09:04 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.627522 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-23 10:09:03.860882) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 10:09:03.864074) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827 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/e85aba310b39b88e911a3f2a5705303afbc0f8566d8eda1404380f7624f7da6e6699933b701b7ff2310e4ca4ae861401430b39120c11504317863bb11870c6bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c1f8dfe4668f4a2cfe4cf3ddb593c6656fbcff23c19833aafa67215b528667c537772c2f8c149c13c32ae5b60d86915aa23ac9e1d187cc8e680ae491a8a9484"} build_url:https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/Y9r0fL86QT-Tm1HTpHnfNw/artifacts/public/build/firefox-48.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/e85aba310b39b88e911a3f2a5705303afbc0f8566d8eda1404380f7624f7da6e6699933b701b7ff2310e4ca4ae861401430b39120c11504317863bb11870c6bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c1f8dfe4668f4a2cfe4cf3ddb593c6656fbcff23c19833aafa67215b528667c537772c2f8c149c13c32ae5b60d86915aa23ac9e1d187cc8e680ae491a8a9484"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 10:09:03.889158) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 10:09:03.889491) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1461425474.756231-250757827 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 10:09:03.972459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 10:09:03.972809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 10:09:03.973104) ========= ========= Total master_lag: 0.17 =========