builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1462972382.19 results: success (0) buildid: 20160511051212 builduid: 224fb36552b844f8a31774e7d4540102 revision: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.195180) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.195846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.196181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.208849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.209211) ========= 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=aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 06:13:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2016-05-11 06:13:02 (100 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.300427) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.300821) ========= 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=aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009518 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:02.347835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 06:13:02.348288) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cf323be5c58b28d8719401ebb0ef63f1d71d000 --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 8cf323be5c58b28d8719401ebb0ef63f1d71d000 --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=aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 06:13:02,760 truncating revision to first 12 chars 2016-05-11 06:13:02,760 Setting DEBUG logging. 2016-05-11 06:13:02,760 attempt 1/10 2016-05-11 06:13:02,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cf323be5c58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 06:13:03,783 unpacking tar archive at: fx-team-8cf323be5c58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.285082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 06:13:03.642431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:03.642840) ========= script_repo_revision: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:03.643379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:03.643698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 06:13:03.649882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-11 06:13:03.650204) ========= /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=aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:13:04 INFO - MultiFileLogger online at 20160511 06:13:04 in /builds/slave/test 06:13:04 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 06:13:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:13:04 INFO - {'append_to_log': False, 06:13:04 INFO - 'base_work_dir': '/builds/slave/test', 06:13:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:13:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:13:04 INFO - 'branch': 'Fx-Team-Non-PGO', 06:13:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:13:04 INFO - 'config_files': ('talos/linux_config.py',), 06:13:04 INFO - 'default_actions': ('clobber', 06:13:04 INFO - 'read-buildbot-config', 06:13:04 INFO - 'download-and-extract', 06:13:04 INFO - 'populate-webroot', 06:13:04 INFO - 'create-virtualenv', 06:13:04 INFO - 'install', 06:13:04 INFO - 'run-tests'), 06:13:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:13:04 INFO - 'download_minidump_stackwalk': True, 06:13:04 INFO - 'download_symbols': 'ondemand', 06:13:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:13:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:13:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:13:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:13:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:13:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:13:04 INFO - 'installer_path': 'installer.exe', 06:13:04 INFO - 'log_level': 'info', 06:13:04 INFO - 'log_name': 'talos', 06:13:04 INFO - 'log_to_console': True, 06:13:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:13:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:13:04 INFO - 'opt_config_files': (), 06:13:04 INFO - 'pip_index': False, 06:13:04 INFO - 'sps_profile': False, 06:13:04 INFO - 'sps_profile_interval': 0, 06:13:04 INFO - 'suite': 'dromaeojs', 06:13:04 INFO - 'system_bits': '32', 06:13:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:13:04 INFO - 'title': 'talos-linux64-ix-009', 06:13:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:13:04 INFO - 'use_talos_json': True, 06:13:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:13:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:13:04 INFO - 'work_dir': 'build'} 06:13:04 INFO - ##### 06:13:04 INFO - ##### Running clobber step. 06:13:04 INFO - ##### 06:13:04 INFO - Running pre-action listener: _resource_record_pre_action 06:13:04 INFO - Running main action method: clobber 06:13:04 INFO - rmtree: /builds/slave/test/build 06:13:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:13:04 INFO - Running post-action listener: _resource_record_post_action 06:13:04 INFO - ##### 06:13:04 INFO - ##### Finished clobber step (success) 06:13:04 INFO - ##### 06:13:04 INFO - ##### 06:13:04 INFO - ##### Running read-buildbot-config step. 06:13:04 INFO - ##### 06:13:04 INFO - Running pre-action listener: _resource_record_pre_action 06:13:04 INFO - Running main action method: read_buildbot_config 06:13:04 INFO - Using buildbot properties: 06:13:04 INFO - { 06:13:04 INFO - "project": "", 06:13:04 INFO - "product": "firefox", 06:13:04 INFO - "script_repo_revision": "production", 06:13:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:13:04 INFO - "repository": "", 06:13:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:13:04 INFO - "buildid": "20160511051212", 06:13:04 INFO - "pgo_build": "False", 06:13:04 INFO - "basedir": "/builds/slave/test", 06:13:04 INFO - "buildnumber": 2961, 06:13:04 INFO - "slavename": "talos-linux64-ix-009", 06:13:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:13:04 INFO - "platform": "ubuntu64_hw", 06:13:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:13:04 INFO - "branch": "fx-team", 06:13:04 INFO - "repo_path": "integration/fx-team", 06:13:04 INFO - "revision": "8cf323be5c58b28d8719401ebb0ef63f1d71d000", 06:13:04 INFO - "stage_platform": "linux64", 06:13:04 INFO - "builduid": "224fb36552b844f8a31774e7d4540102", 06:13:04 INFO - "slavebuilddir": "test" 06:13:04 INFO - } 06:13:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 06:13:04 INFO - Running post-action listener: _resource_record_post_action 06:13:04 INFO - ##### 06:13:04 INFO - ##### Finished read-buildbot-config step (success) 06:13:04 INFO - ##### 06:13:04 INFO - ##### 06:13:04 INFO - ##### Running download-and-extract step. 06:13:04 INFO - ##### 06:13:04 INFO - Running pre-action listener: _resource_record_pre_action 06:13:04 INFO - Running main action method: download_and_extract 06:13:04 INFO - mkdir: /builds/slave/test/build/tests 06:13:04 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')]} 06:13:04 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:13:05 INFO - Downloaded 1361 bytes. 06:13:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 06:13:05 INFO - Using the following test package requirements: 06:13:05 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:13:05 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:13:05 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:13:05 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'jsshell-linux-x86_64.zip'], 06:13:05 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:13:05 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 06:13:05 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:13:05 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:13:05 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:13:05 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 06:13:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:13:05 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:13:05 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')]} 06:13:05 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:13:07 INFO - Downloaded 22329022 bytes. 06:13:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:13:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:13:08 INFO - Return code: 0 06:13:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:13:08 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')]} 06:13:08 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 06:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:13:09 INFO - Downloaded 22329022 bytes. 06:13:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:13:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:13:11 INFO - Return code: 0 06:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:11 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 06:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:13:12 INFO - Downloaded 10840152 bytes. 06:13:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:13:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:13:12 INFO - Return code: 0 06:13:12 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')]} 06:13:12 INFO - https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:13:13 INFO - Downloaded 54683548 bytes. 06:13:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:13:13 INFO - mkdir: /builds/slave/test/properties 06:13:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:13:13 INFO - Writing to file /builds/slave/test/properties/build_url 06:13:13 INFO - Contents: 06:13:13 INFO - build_url:https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 06:13:14 INFO - Running post-action listener: _resource_record_post_action 06:13:14 INFO - Running post-action listener: set_extra_try_arguments 06:13:14 INFO - ##### 06:13:14 INFO - ##### Finished download-and-extract step (success) 06:13:14 INFO - ##### 06:13:14 INFO - ##### 06:13:14 INFO - ##### Running populate-webroot step. 06:13:14 INFO - ##### 06:13:14 INFO - Running pre-action listener: _resource_record_pre_action 06:13:14 INFO - Running main action method: populate_webroot 06:13:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:13:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:13:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:13:14 INFO - '--tppagecycles', 06:13:14 INFO - '7'], 06:13:14 INFO - 'tests': ['tsvgm']}}, 06:13:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:13:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:13:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:13:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:13:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['damp', 'tps']}, 06:13:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'tests': ['damp', 'tps']}, 06:13:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['dromaeo_dom']}, 06:13:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:13:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['a11yr', 06:13:14 INFO - 'ts_paint', 06:13:14 INFO - 'tpaint', 06:13:14 INFO - 'sessionrestore', 06:13:14 INFO - 'sessionrestore_no_auto_restore', 06:13:14 INFO - 'tabpaint']}, 06:13:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:13:14 INFO - 'ts_paint', 06:13:14 INFO - 'tpaint', 06:13:14 INFO - 'sessionrestore', 06:13:14 INFO - 'sessionrestore_no_auto_restore', 06:13:14 INFO - 'tabpaint']}, 06:13:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:13:14 INFO - 'ts_paint', 06:13:14 INFO - 'tpaint', 06:13:14 INFO - 'sessionrestore', 06:13:14 INFO - 'sessionrestore_no_auto_restore', 06:13:14 INFO - 'tabpaint']}, 06:13:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:13:14 INFO - 'ts_paint', 06:13:14 INFO - 'tpaint', 06:13:14 INFO - 'sessionrestore', 06:13:14 INFO - 'sessionrestore_no_auto_restore', 06:13:14 INFO - 'tabpaint']}, 06:13:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['a11yr', 06:13:14 INFO - 'ts_paint', 06:13:14 INFO - 'tpaint', 06:13:14 INFO - 'sessionrestore', 06:13:14 INFO - 'sessionrestore_no_auto_restore', 06:13:14 INFO - 'tabpaint']}, 06:13:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['a11yr', 06:13:14 INFO - 'ts_paint', 06:13:14 INFO - 'tpaint', 06:13:14 INFO - 'sessionrestore', 06:13:14 INFO - 'sessionrestore_no_auto_restore', 06:13:14 INFO - 'tabpaint']}, 06:13:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['tsvgx', 06:13:14 INFO - 'tsvgr_opacity', 06:13:14 INFO - 'tart', 06:13:14 INFO - 'tscrollx', 06:13:14 INFO - 'cart']}, 06:13:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:13:14 INFO - 'tsvgr_opacity', 06:13:14 INFO - 'tart', 06:13:14 INFO - 'tscrollx', 06:13:14 INFO - 'cart']}, 06:13:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'talos_options': ['--disable-e10s'], 06:13:14 INFO - 'tests': ['tp5o']}, 06:13:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'tests': ['tp5o']}, 06:13:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'talos_options': ['--disable-e10s', 06:13:14 INFO - '--xperf_path', 06:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:14 INFO - 'tests': ['tp5n']}, 06:13:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:14 INFO - 'talos_options': ['--xperf_path', 06:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:14 INFO - 'tests': ['tp5n']}}, 06:13:14 INFO - 'talos.zip': {'path': '', 06:13:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:13:14 INFO - Running post-action listener: _resource_record_post_action 06:13:14 INFO - ##### 06:13:14 INFO - ##### Finished populate-webroot step (success) 06:13:14 INFO - ##### 06:13:14 INFO - ##### 06:13:14 INFO - ##### Running create-virtualenv step. 06:13:14 INFO - ##### 06:13:14 INFO - Running pre-action listener: _resource_record_pre_action 06:13:14 INFO - Running main action method: create_virtualenv 06:13:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:13:14 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 06:13:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:13:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:13:14 INFO - Using real prefix '/usr' 06:13:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:13:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:13:17 INFO - Installing pip.................done. 06:13:17 INFO - Return code: 0 06:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:17 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:17 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 06:13:17 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 06:13:17 INFO - Using env: {'DISPLAY': ':0', 06:13:17 INFO - 'HOME': '/home/cltbld', 06:13:17 INFO - 'LANG': 'en_US.UTF-8', 06:13:17 INFO - 'LANGUAGE': 'en_US:en', 06:13:17 INFO - 'LOGNAME': 'cltbld', 06:13:17 INFO - 'MAIL': '/var/mail/cltbld', 06:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:17 INFO - 'MOZ_NO_REMOTE': '1', 06:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:17 INFO - 'NO_EM_RESTART': '1', 06:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:17 INFO - 'PWD': '/builds/slave/test', 06:13:17 INFO - 'SHELL': '/bin/bash', 06:13:17 INFO - 'SHLVL': '1', 06:13:17 INFO - 'TERM': 'linux', 06:13:17 INFO - 'TMOUT': '86400', 06:13:17 INFO - 'USER': 'cltbld', 06:13:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:17 INFO - '_': '/tools/buildbot/bin/python'} 06:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:17 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 06:13:17 INFO - Cleaning up... 06:13:17 INFO - Return code: 0 06:13:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:17 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:17 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 06:13:17 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 06:13:17 INFO - Using env: {'DISPLAY': ':0', 06:13:17 INFO - 'HOME': '/home/cltbld', 06:13:17 INFO - 'LANG': 'en_US.UTF-8', 06:13:17 INFO - 'LANGUAGE': 'en_US:en', 06:13:17 INFO - 'LOGNAME': 'cltbld', 06:13:17 INFO - 'MAIL': '/var/mail/cltbld', 06:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:17 INFO - 'MOZ_NO_REMOTE': '1', 06:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:17 INFO - 'NO_EM_RESTART': '1', 06:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:17 INFO - 'PWD': '/builds/slave/test', 06:13:17 INFO - 'SHELL': '/bin/bash', 06:13:17 INFO - 'SHLVL': '1', 06:13:17 INFO - 'TERM': 'linux', 06:13:17 INFO - 'TMOUT': '86400', 06:13:17 INFO - 'USER': 'cltbld', 06:13:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:17 INFO - '_': '/tools/buildbot/bin/python'} 06:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:17 INFO - Downloading/unpacking psutil>=0.7.1 06:13:17 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 06:13:17 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 06:13:17 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 06:13:17 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 06:13:17 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 06:13:17 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 06:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:19 INFO - Installing collected packages: psutil 06:13:19 INFO - Running setup.py install for psutil 06:13:19 INFO - building 'psutil._psutil_linux' extension 06:13:19 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 06:13:19 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 06:13:19 INFO - building 'psutil._psutil_posix' extension 06:13:19 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 06:13:19 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 06:13:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:20 INFO - Successfully installed psutil 06:13:20 INFO - Cleaning up... 06:13:20 INFO - Return code: 0 06:13:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:20 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:20 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 06:13:20 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 06:13:20 INFO - Using env: {'DISPLAY': ':0', 06:13:20 INFO - 'HOME': '/home/cltbld', 06:13:20 INFO - 'LANG': 'en_US.UTF-8', 06:13:20 INFO - 'LANGUAGE': 'en_US:en', 06:13:20 INFO - 'LOGNAME': 'cltbld', 06:13:20 INFO - 'MAIL': '/var/mail/cltbld', 06:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:20 INFO - 'MOZ_NO_REMOTE': '1', 06:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:20 INFO - 'NO_EM_RESTART': '1', 06:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:20 INFO - 'PWD': '/builds/slave/test', 06:13:20 INFO - 'SHELL': '/bin/bash', 06:13:20 INFO - 'SHLVL': '1', 06:13:20 INFO - 'TERM': 'linux', 06:13:20 INFO - 'TMOUT': '86400', 06:13:20 INFO - 'USER': 'cltbld', 06:13:20 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:20 INFO - '_': '/tools/buildbot/bin/python'} 06:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:13:20 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 06:13:20 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 06:13:20 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 06:13:20 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 06:13:20 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 06:13:20 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 06:13:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:13:22 INFO - Installing collected packages: mozsystemmonitor 06:13:22 INFO - Running setup.py install for mozsystemmonitor 06:13:22 INFO - Successfully installed mozsystemmonitor 06:13:22 INFO - Cleaning up... 06:13:22 INFO - Return code: 0 06:13:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:13:22 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')]} 06:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:22 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')]} 06:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:22 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:22 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 06:13:22 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 06:13:22 INFO - Using env: {'DISPLAY': ':0', 06:13:22 INFO - 'HOME': '/home/cltbld', 06:13:22 INFO - 'LANG': 'en_US.UTF-8', 06:13:22 INFO - 'LANGUAGE': 'en_US:en', 06:13:22 INFO - 'LOGNAME': 'cltbld', 06:13:22 INFO - 'MAIL': '/var/mail/cltbld', 06:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:22 INFO - 'MOZ_NO_REMOTE': '1', 06:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:22 INFO - 'NO_EM_RESTART': '1', 06:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:22 INFO - 'PWD': '/builds/slave/test', 06:13:22 INFO - 'SHELL': '/bin/bash', 06:13:22 INFO - 'SHLVL': '1', 06:13:22 INFO - 'TERM': 'linux', 06:13:22 INFO - 'TMOUT': '86400', 06:13:22 INFO - 'USER': 'cltbld', 06:13:22 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:22 INFO - '_': '/tools/buildbot/bin/python'} 06:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:22 INFO - Downloading/unpacking blobuploader==1.2.4 06:13:22 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 06:13:22 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 06:13:22 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 06:13:22 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 06:13:22 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 06:13:22 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 06:13:24 INFO - Downloading blobuploader-1.2.4.tar.gz 06:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:13:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:13:24 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 06:13:24 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 06:13:24 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 06:13:24 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 06:13:24 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 06:13:24 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 06:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:13:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:13:24 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 06:13:24 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 06:13:24 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 06:13:24 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 06:13:24 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 06:13:24 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 06:13:25 INFO - Downloading docopt-0.6.1.tar.gz 06:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:13:25 INFO - Installing collected packages: blobuploader, requests, docopt 06:13:25 INFO - Running setup.py install for blobuploader 06:13:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:13:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:13:25 INFO - Running setup.py install for requests 06:13:25 INFO - Running setup.py install for docopt 06:13:25 INFO - Successfully installed blobuploader requests docopt 06:13:25 INFO - Cleaning up... 06:13:25 INFO - Return code: 0 06:13:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:25 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:25 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 06:13:25 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 06:13:25 INFO - Using env: {'DISPLAY': ':0', 06:13:25 INFO - 'HOME': '/home/cltbld', 06:13:25 INFO - 'LANG': 'en_US.UTF-8', 06:13:25 INFO - 'LANGUAGE': 'en_US:en', 06:13:25 INFO - 'LOGNAME': 'cltbld', 06:13:25 INFO - 'MAIL': '/var/mail/cltbld', 06:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:25 INFO - 'MOZ_NO_REMOTE': '1', 06:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:25 INFO - 'NO_EM_RESTART': '1', 06:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:25 INFO - 'PWD': '/builds/slave/test', 06:13:25 INFO - 'SHELL': '/bin/bash', 06:13:25 INFO - 'SHLVL': '1', 06:13:25 INFO - 'TERM': 'linux', 06:13:25 INFO - 'TMOUT': '86400', 06:13:25 INFO - 'USER': 'cltbld', 06:13:25 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:25 INFO - '_': '/tools/buildbot/bin/python'} 06:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:13:25 INFO - Running setup.py (path:/tmp/pip-7WH1za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:13:25 INFO - Running setup.py (path:/tmp/pip-UNoRPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:13:25 INFO - Running setup.py (path:/tmp/pip-q2sJka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:13:26 INFO - Running setup.py (path:/tmp/pip-jFVdGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:13:26 INFO - Running setup.py (path:/tmp/pip-pNXC8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:13:26 INFO - Running setup.py (path:/tmp/pip-MfnGpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:13:26 INFO - Running setup.py (path:/tmp/pip-r1U0SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:13:26 INFO - Running setup.py (path:/tmp/pip-bQnCP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:13:26 INFO - Running setup.py (path:/tmp/pip-hpMPVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:13:26 INFO - Running setup.py (path:/tmp/pip-f48UA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:13:26 INFO - Running setup.py (path:/tmp/pip-l6G8TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:13:26 INFO - Running setup.py (path:/tmp/pip-KrGZ3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:13:26 INFO - Running setup.py (path:/tmp/pip-wajs1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:13:26 INFO - Running setup.py (path:/tmp/pip-ZUGunq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:26 INFO - Running setup.py (path:/tmp/pip-2vERlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:13:26 INFO - Running setup.py (path:/tmp/pip-Ecjl_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:13:26 INFO - Running setup.py (path:/tmp/pip-Vj0e64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:13:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:13:26 INFO - Running setup.py install for manifestparser 06:13:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:13:26 INFO - Running setup.py install for mozcrash 06:13:27 INFO - Running setup.py install for mozdebug 06:13:27 INFO - Running setup.py install for mozdevice 06:13:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Running setup.py install for mozfile 06:13:27 INFO - Running setup.py install for mozhttpd 06:13:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Running setup.py install for mozinfo 06:13:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Running setup.py install for mozInstall 06:13:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Running setup.py install for mozleak 06:13:27 INFO - Running setup.py install for mozlog 06:13:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Running setup.py install for moznetwork 06:13:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:13:27 INFO - Running setup.py install for mozprocess 06:13:27 INFO - Running setup.py install for mozprofile 06:13:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:13:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:13:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:13:28 INFO - Running setup.py install for mozrunner 06:13:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:13:28 INFO - Running setup.py install for mozscreenshot 06:13:28 INFO - Running setup.py install for moztest 06:13:28 INFO - Running setup.py install for mozversion 06:13:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:13:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:13:28 INFO - Cleaning up... 06:13:28 INFO - Return code: 0 06:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:28 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:28 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 06:13:28 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 06:13:28 INFO - Using env: {'DISPLAY': ':0', 06:13:28 INFO - 'HOME': '/home/cltbld', 06:13:28 INFO - 'LANG': 'en_US.UTF-8', 06:13:28 INFO - 'LANGUAGE': 'en_US:en', 06:13:28 INFO - 'LOGNAME': 'cltbld', 06:13:28 INFO - 'MAIL': '/var/mail/cltbld', 06:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:28 INFO - 'MOZ_NO_REMOTE': '1', 06:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:28 INFO - 'NO_EM_RESTART': '1', 06:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:28 INFO - 'PWD': '/builds/slave/test', 06:13:28 INFO - 'SHELL': '/bin/bash', 06:13:28 INFO - 'SHLVL': '1', 06:13:28 INFO - 'TERM': 'linux', 06:13:28 INFO - 'TMOUT': '86400', 06:13:28 INFO - 'USER': 'cltbld', 06:13:28 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:28 INFO - '_': '/tools/buildbot/bin/python'} 06:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:13:28 INFO - Running setup.py (path:/tmp/pip-qdmFaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:13:28 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)) 06:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:13:28 INFO - Running setup.py (path:/tmp/pip-0zBHRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:13:28 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)) 06:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:13:28 INFO - Running setup.py (path:/tmp/pip-9ilci9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:13:28 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)) 06:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:13:28 INFO - Running setup.py (path:/tmp/pip-GRXxEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:13:28 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)) 06:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:13:28 INFO - Running setup.py (path:/tmp/pip-PF7zS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:13:28 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)) 06:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:13:28 INFO - Running setup.py (path:/tmp/pip-iMNNqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:13:28 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)) 06:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:13:29 INFO - Running setup.py (path:/tmp/pip-ZEZ0Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:13:29 INFO - Running setup.py (path:/tmp/pip-gEuk2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:13:29 INFO - Running setup.py (path:/tmp/pip-NHmA3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:13:29 INFO - Running setup.py (path:/tmp/pip-xZgBVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:13:29 INFO - Running setup.py (path:/tmp/pip-1D89nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:13:29 INFO - Running setup.py (path:/tmp/pip-1yQo7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:13:29 INFO - Running setup.py (path:/tmp/pip-87brTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:13:29 INFO - Running setup.py (path:/tmp/pip-ywrz9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:29 INFO - Running setup.py (path:/tmp/pip-S7yH8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:13:29 INFO - Running setup.py (path:/tmp/pip-ISax_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:13:29 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)) 06:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:13:29 INFO - Running setup.py (path:/tmp/pip-hr4KcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:13:29 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)) 06:13:29 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)) 06:13:29 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)) 06:13:29 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)) 06:13:29 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)) 06:13:29 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)) 06:13:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:13:29 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 06:13:29 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 06:13:29 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 06:13:29 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 06:13:29 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 06:13:29 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 06:13:31 INFO - Downloading blessings-1.6.tar.gz 06:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:13:31 INFO - Installing collected packages: blessings 06:13:31 INFO - Running setup.py install for blessings 06:13:31 INFO - Successfully installed blessings 06:13:31 INFO - Cleaning up... 06:13:31 INFO - Return code: 0 06:13:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:13:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:13:31 INFO - Reading from file tmpfile_stdout 06:13:31 INFO - Current package versions: 06:13:31 INFO - argparse == 1.2.1 06:13:31 INFO - blessings == 1.6 06:13:31 INFO - blobuploader == 1.2.4 06:13:31 INFO - docopt == 0.6.1 06:13:31 INFO - manifestparser == 1.1 06:13:31 INFO - mozInstall == 1.12 06:13:31 INFO - mozcrash == 0.17 06:13:31 INFO - mozdebug == 0.1 06:13:31 INFO - mozdevice == 0.48 06:13:31 INFO - mozfile == 1.2 06:13:31 INFO - mozhttpd == 0.7 06:13:31 INFO - mozinfo == 0.9 06:13:31 INFO - mozleak == 0.1 06:13:31 INFO - mozlog == 3.1 06:13:31 INFO - moznetwork == 0.27 06:13:31 INFO - mozprocess == 0.22 06:13:31 INFO - mozprofile == 0.28 06:13:31 INFO - mozrunner == 6.11 06:13:31 INFO - mozscreenshot == 0.1 06:13:31 INFO - mozsystemmonitor == 0.0 06:13:31 INFO - moztest == 0.7 06:13:31 INFO - mozversion == 1.4 06:13:31 INFO - psutil == 3.1.1 06:13:31 INFO - requests == 1.2.3 06:13:31 INFO - wsgiref == 0.1.2 06:13:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:31 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:31 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 06:13:31 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 06:13:31 INFO - Using env: {'DISPLAY': ':0', 06:13:31 INFO - 'HOME': '/home/cltbld', 06:13:31 INFO - 'LANG': 'en_US.UTF-8', 06:13:31 INFO - 'LANGUAGE': 'en_US:en', 06:13:31 INFO - 'LOGNAME': 'cltbld', 06:13:31 INFO - 'MAIL': '/var/mail/cltbld', 06:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:31 INFO - 'MOZ_NO_REMOTE': '1', 06:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:31 INFO - 'NO_EM_RESTART': '1', 06:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:31 INFO - 'PWD': '/builds/slave/test', 06:13:31 INFO - 'SHELL': '/bin/bash', 06:13:31 INFO - 'SHLVL': '1', 06:13:31 INFO - 'TERM': 'linux', 06:13:31 INFO - 'TMOUT': '86400', 06:13:31 INFO - 'USER': 'cltbld', 06:13:31 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:31 INFO - '_': '/tools/buildbot/bin/python'} 06:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 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)) 06:13:32 INFO - Cleaning up... 06:13:32 INFO - Return code: 0 06:13:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:13:32 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')]} 06:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:32 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')]} 06:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:32 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:32 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 06:13:32 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 06:13:32 INFO - Using env: {'DISPLAY': ':0', 06:13:32 INFO - 'HOME': '/home/cltbld', 06:13:32 INFO - 'LANG': 'en_US.UTF-8', 06:13:32 INFO - 'LANGUAGE': 'en_US:en', 06:13:32 INFO - 'LOGNAME': 'cltbld', 06:13:32 INFO - 'MAIL': '/var/mail/cltbld', 06:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:32 INFO - 'MOZ_NO_REMOTE': '1', 06:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:32 INFO - 'NO_EM_RESTART': '1', 06:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:32 INFO - 'PWD': '/builds/slave/test', 06:13:32 INFO - 'SHELL': '/bin/bash', 06:13:32 INFO - 'SHLVL': '1', 06:13:32 INFO - 'TERM': 'linux', 06:13:32 INFO - 'TMOUT': '86400', 06:13:32 INFO - 'USER': 'cltbld', 06:13:32 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:32 INFO - '_': '/tools/buildbot/bin/python'} 06:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:32 INFO - Downloading/unpacking jsonschema 06:13:32 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 06:13:32 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 06:13:32 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 06:13:32 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 06:13:32 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 06:13:32 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 06:13:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:13:34 INFO - Downloading/unpacking functools32 (from jsonschema) 06:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:34 INFO - Downloading functools32-3.2.3-2.tar.gz 06:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:13:34 INFO - warning: no files found matching '*.txt' 06:13:34 INFO - no previously-included directories found matching 'build' 06:13:34 INFO - no previously-included directories found matching 'dist' 06:13:34 INFO - no previously-included directories found matching '.git*' 06:13:34 INFO - Installing collected packages: jsonschema, functools32 06:13:34 INFO - Running setup.py install for functools32 06:13:34 INFO - warning: no files found matching '*.txt' 06:13:34 INFO - no previously-included directories found matching 'build' 06:13:34 INFO - no previously-included directories found matching 'dist' 06:13:34 INFO - no previously-included directories found matching '.git*' 06:13:34 INFO - Successfully installed jsonschema functools32 06:13:34 INFO - Cleaning up... 06:13:34 INFO - Return code: 0 06:13:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:34 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 0x7f4478a1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, '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': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', '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 06:13:34 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 06:13:34 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 06:13:34 INFO - Using env: {'DISPLAY': ':0', 06:13:34 INFO - 'HOME': '/home/cltbld', 06:13:34 INFO - 'LANG': 'en_US.UTF-8', 06:13:34 INFO - 'LANGUAGE': 'en_US:en', 06:13:34 INFO - 'LOGNAME': 'cltbld', 06:13:34 INFO - 'MAIL': '/var/mail/cltbld', 06:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:34 INFO - 'MOZ_NO_REMOTE': '1', 06:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:34 INFO - 'NO_EM_RESTART': '1', 06:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:34 INFO - 'PWD': '/builds/slave/test', 06:13:34 INFO - 'SHELL': '/bin/bash', 06:13:34 INFO - 'SHLVL': '1', 06:13:34 INFO - 'TERM': 'linux', 06:13:34 INFO - 'TMOUT': '86400', 06:13:34 INFO - 'USER': 'cltbld', 06:13:34 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:34 INFO - '_': '/tools/buildbot/bin/python'} 06:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:34 INFO - Downloading/unpacking flake8 06:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:13:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:13:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:13:37 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 06:13:37 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 06:13:37 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 06:13:37 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 06:13:37 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 06:13:37 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 06:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:13:37 INFO - no previously-included directories found matching 'docs/_build' 06:13:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:13:37 INFO - Running setup.py install for pep8 06:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:13:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:13:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:13:37 INFO - no previously-included directories found matching 'docs/_build' 06:13:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:13:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:13:37 INFO - Cleaning up... 06:13:37 INFO - Return code: 0 06:13:37 INFO - Running post-action listener: _resource_record_post_action 06:13:37 INFO - Running post-action listener: _start_resource_monitoring 06:13:37 INFO - Starting resource monitoring. 06:13:37 INFO - ##### 06:13:37 INFO - ##### Finished create-virtualenv step (success) 06:13:37 INFO - ##### 06:13:37 INFO - ##### 06:13:37 INFO - ##### Running install step. 06:13:37 INFO - ##### 06:13:37 INFO - Running pre-action listener: _resource_record_pre_action 06:13:37 INFO - Running main action method: install 06:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:13:37 INFO - Reading from file tmpfile_stdout 06:13:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:13:37 INFO - Reading from file tmpfile_stdout 06:13:37 INFO - Output received: 06:13:37 INFO - Usage: mozinstall [options] installer 06:13:37 INFO - Options: 06:13:37 INFO - -h, --help show this help message and exit 06:13:37 INFO - -d DEST, --destination=DEST 06:13:37 INFO - Directory to install application into. [default: 06:13:37 INFO - "/builds/slave/test"] 06:13:37 INFO - --app=APP Application being installed. [default: firefox] 06:13:37 INFO - mkdir: /builds/slave/test/build/application 06:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:13:53 INFO - Reading from file tmpfile_stdout 06:13:53 INFO - Output received: 06:13:53 INFO - /builds/slave/test/build/application/firefox/firefox 06:13:53 INFO - Running post-action listener: _resource_record_post_action 06:13:53 INFO - ##### 06:13:53 INFO - ##### Finished install step (success) 06:13:53 INFO - ##### 06:13:53 INFO - ##### 06:13:53 INFO - ##### Running run-tests step. 06:13:53 INFO - ##### 06:13:53 INFO - Running pre-action listener: _resource_record_pre_action 06:13:53 INFO - Running main action method: run_tests 06:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:13:53 INFO - Python 2.7.3 06:13:53 INFO - Return code: 0 06:13:53 INFO - grabbing minidump binary from tooltool 06:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:13:53 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109b9c0>, '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 0x109c8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:13:53 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 06:13:53 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 06:13:53 INFO - Calling ['/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'] with output_timeout 600 06:13:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:13:53 INFO - Return code: 0 06:13:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:13:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:13:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:13:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:13:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:13:54 INFO - Return code: 0 06:13:54 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/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 06:13:54 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/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 06:13:54 INFO - Using env: {'DISPLAY': ':0', 06:13:54 INFO - 'HOME': '/home/cltbld', 06:13:54 INFO - 'LANG': 'en_US.UTF-8', 06:13:54 INFO - 'LANGUAGE': 'en_US:en', 06:13:54 INFO - 'LOGNAME': 'cltbld', 06:13:54 INFO - 'MAIL': '/var/mail/cltbld', 06:13:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:13:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:54 INFO - 'MOZ_NO_REMOTE': '1', 06:13:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:54 INFO - 'NO_EM_RESTART': '1', 06:13:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:54 INFO - 'PWD': '/builds/slave/test', 06:13:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:13:54 INFO - 'SHELL': '/bin/bash', 06:13:54 INFO - 'SHLVL': '1', 06:13:54 INFO - 'TERM': 'linux', 06:13:54 INFO - 'TMOUT': '86400', 06:13:54 INFO - 'USER': 'cltbld', 06:13:54 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320', 06:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:54 INFO - '_': '/tools/buildbot/bin/python'} 06:13:54 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/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 06:13:54 INFO - mozversion application_buildid: 20160511051212 06:13:54 INFO - mozversion application_changeset: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 06:13:54 INFO - mozversion application_display_name: Nightly 06:13:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:13:54 INFO - mozversion application_name: Firefox 06:13:54 INFO - mozversion application_remotingname: firefox 06:13:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:13:54 INFO - mozversion application_vendor: Mozilla 06:13:54 INFO - mozversion application_version: 49.0a1 06:13:54 INFO - mozversion platform_buildid: 20160511051212 06:13:54 INFO - mozversion platform_changeset: 8cf323be5c58b28d8719401ebb0ef63f1d71d000 06:13:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:13:54 INFO - mozversion platform_version: 49.0a1 06:13:54 INFO - using testdate: 1462972434 06:13:54 INFO - actual date: 1462972434 06:13:54 INFO - starting webserver on 'localhost:41112' 06:13:54 INFO - SUITE-START | Running 2 tests 06:13:54 INFO - TEST-START | dromaeo_css 06:13:54 INFO - operating with platform_type : linux_ 06:13:54 INFO - Initialising browser for dromaeo_css test... 06:13:54 INFO - TEST-INFO | started process 32631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeKkPWn/profile http://localhost:41112/getInfo.html) 06:13:59 INFO - PROCESS | 32631 | __metrics Screen width/height:1600/1200 06:13:59 INFO - PROCESS | 32631 | colorDepth:24 06:13:59 INFO - PROCESS | 32631 | Browser inner width/height: 1024/697 06:13:59 INFO - PROCESS | 32631 | __metrics 06:14:00 ERROR - PROCESS | 32631 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:14:01 INFO - TEST-INFO | 32631: exit 0 06:14:01 INFO - Browser initialized. 06:14:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:14:01 INFO - TEST-INFO | started process 32710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeKkPWn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:12 INFO - PROCESS | 32710 | RSS: Main: 153784320 06:14:12 INFO - PROCESS | 32710 | 06:15:04 INFO - PROCESS | 32710 | 1462972504189 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] 06:17:15 INFO - PROCESS | 32710 | Cycle 1(1): loaded http://localhost:41112/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41112/tests/dromaeo/cssquery-ext.html) 06:17:17 INFO - PROCESS | 32710 | RSS: Main: 273756160 06:17:17 INFO - PROCESS | 32710 | 06:20:19 INFO - PROCESS | 32710 | Cycle 1(1): loaded http://localhost:41112/tests/dromaeo/cssquery-ext.html (next: http://localhost:41112/tests/dromaeo/cssquery-jquery.html) 06:20:20 INFO - PROCESS | 32710 | RSS: Main: 242425856 06:20:20 INFO - PROCESS | 32710 | 06:23:22 INFO - PROCESS | 32710 | Cycle 1(1): loaded http://localhost:41112/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41112/tests/dromaeo/cssquery-mootools.html) 06:23:22 INFO - PROCESS | 32710 | RSS: Main: 237801472 06:23:22 INFO - PROCESS | 32710 | 06:26:24 INFO - PROCESS | 32710 | Cycle 1(1): loaded http://localhost:41112/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41112/tests/dromaeo/cssquery-prototype.html) 06:26:25 INFO - PROCESS | 32710 | RSS: Main: 228003840 06:26:25 INFO - PROCESS | 32710 | 06:29:28 INFO - PROCESS | 32710 | Cycle 1(1): loaded http://localhost:41112/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41112/tests/dromaeo/cssquery-yui.html) 06:29:28 INFO - PROCESS | 32710 | RSS: Main: 213872640 06:29:28 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | Cycle 1(1): loaded http://localhost:41112/tests/dromaeo/cssquery-yui.html (next: http://localhost:41112/tests/dromaeo/cssquery-dojo.html) 06:32:31 INFO - PROCESS | 32710 | RSS: Main: 299098112 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | __start_tp_report 06:32:31 INFO - PROCESS | 32710 | _x_x_mozilla_page_load 06:32:31 INFO - PROCESS | 32710 | _x_x_mozilla_page_load_details 06:32:31 INFO - PROCESS | 32710 | |i|pagename|runs| 06:32:31 INFO - PROCESS | 32710 | |0;dojo.html;2631.263246291039;2643.524165650183;2674.277944954862;2683.9398437617137;2687.0729598288585;4542.273236282195;4620.537946205386;4659.62722982161;4726.33831263623;4765.642576806736;4566.474855391631;4568.565986231302;4595.333676616889;4645.651576131787;4670.579647831694;4153.792310384484;4238.300680387748;4243.787810609472;4267.14657068586;4479.910401791963;4361.280388735855;4427.667924905629;4439.045605194882;4445.444319460067;4494.213512635276;4207.621314081747;4268.167707297078;4295.355696645528;4340.804663790137;4346.6522678185665;4301.612854843079;4315.43899293093;4329.047609525899;4407.493138289105;4427.247367947457;4356.281213599752;4357.6078152966065;4361.520232774392;4371.4098596689355;4420.447444069491;4422.402975598286;4577.977110114428;4584.770761461914;4650.837220697294;4667.486576476585;5025.8240961566535;5030.37120359955;5056.519630635084;5082.923756143661;5088.287639730441;5025.773840177164;5027.648064635477;5110.718910459923;5113.463086375951;5133.358330208724;4561.201789686792;4714.646401519865;4717.056588682209;4756.357891684647;4790.520947905251;5173.948260517422;5187.273781670569;5224.634275600672;5228.05894938907;5246.842594722164;4958.950410495849;4976.2286845539;5006.849794506171;5007.9499205008215;5017.3226614406585;4888.120138375127;4986.825461108844;4992.450830408652;4994.700317980933;4996.7501624918605;4942.950570494321;4980.576650984634;4987.62592805541;4995.450500444948;5031.345925029796;4755.904881902412;4934.753262336869;4938.58022068121;4940.925886111711;4979.228219625964;4151.27352713274;4288.31386978082;4299.892502687458;4323.113761678848;4336.891577710519;3708.295423869456;3755.2677227940835;3766.227923275722;3771.396576547739;3823.541175058955;4282.036541778138;4312.094460163338;4331.155424692155;4364.64695944252;4378.693491455568;4823.348847905488;4951.702897826142;4990.500949905053;4992.051510213048;5012.949870501321;4230.2174097792;4235.745855248695;4237.173751118564;4248.87253382399;4256.553061928515;4347.456567929009;4513.887152821206;4518.960639053036;4520.028193938319;4571.062932098978;4666.976665116653;4718.882027949328;4727.503612120678;4788.257820037899;4790.832320868893;5076.949230507647;5079.796808127781;5084.694918304914;5085.389753229488;5091.465396133352;4596.609288210406;4685.4143232095985;4748.667593268438;4753.5008824072975;4781.163296423042;4849.4908034657265;4856.514348565115;4880.658353915192;4881.267809828554;4917.385326834145;4883.974365383309;4901.117798796108;4901.436334821541;4927.211646136601;4964.900701986012;4748.121597504472;4760.952390476051;4764.094821983812;4794.017226468496;4815.109204797123;4906;4915.139850526072;4915.410150781786;4922;4949.356583644103;4841.031793641216;4846.636502262415;4857.635677324144;4880.170371036861;4936.802527898987;4693.389859318267;4782.760861956818;4884.365032545888;4955.82654607087;5026.321446604661;4731.148393289103;4783.449903261169;4803.99116185591;4829.1790395633525;4844.0554091951735 06:32:31 INFO - PROCESS | 32710 | |1;ext.html;568.3265330583258;570.1647087017518;577.9537636989041;587.6797145555672;588.6938791828248;27294.181174564746;40590.79704601476;40893.795531022304;41957.7902110489;42441.36337954933;37943.4308485373;38717;41823.37264941021;41832.37251441231;41853.162936741246;7305;7680.731174408897;7823.982882225303;7840.960795196044;7846.803829904241;9657.613695452173;9932.304738668296;9946.900530994706;10328.27702060856;10333.948330258338;9858.70423887281;9926.9503652482;9929.304948653597;9964.601415943354;9964.90035099647;9854.950725246365;9886.90113098867;9917;9935.10584047432;9964.4519551425;9782.168515676176;9783.315167938246;9812.116909478109;9833.803323933482;9839.114479696862;37720.62279377199;37999.62000380016;38159.236815263816;38218.426723599165;38260;3210.1011716719354;3211.1811488070393;3261.249912520134;3281.2125089978235;3715.1269451678836;28721.712782872113;28787.42425151506;28832.567511487345;29780.255493612833;29892.70107298921;3130.20179854138;3136.670649581784;3154.479510880702;3190.6171259448784;3261.72275356595;228445;229306;229542.99999999834;230339;232792;52250.47749522532;52500.69991601032;52729.73635131877;52865.207021894705;52967.47032529626;49398.50601494011;49577;49590;49701.50298497041;49745;12723.300218488072;12967.610971670865;13010.21938683682;13020;13187.208767473981;10008.949955250177;10512;10738.087262582769;11159.163062770325;11183.32900026001;15388.461403850812;15551.30019149141;15559.84440155584;15744.60638484047;15783.289751961189;5806.158107074535;5930.673812940244;5953.493953014043;5966.164736936832;5983.970080149571;880.5157163560017;945.3193700535603;1034.6999370182714;1065.1212749481708;1077.6659235636978;27146.32134196661;27495.175144745688;27795.166145015683;28419.28951776181;30315.242118947204;957.1911734584265;988.1896844587369;1004.9346792458467;1096.3641088168843;1097.5719469406938;14396.640083997983;14845.183514906568;14854.257287135817;14957.401703931939;15150.242487875563;327175;330204;331979;334017;334775;48735.51264487381;48920.26619600709;49006;49055;49178;1152.066825871047;1244.5830646733264;1274.394662535307;1286.742651469691;1289.1749280460513;26911.058112966737;27950.58074128849;28324;28604.42791144207;28750.568741468476;41181;41593.79203103965;41900.161996759285;42125.94685132896;42143.789281054625;221631;222324;222373;222630;223905;22308.553828923006;24524.877375613007;25243.62134567946;25396.365090872878;26474.07340743065;40588.594114058484;41232.79383603063;41554.58445415507;41685.79157104316;42561.574384257;35535.644643553234;35695.64304356923;35752.106197345274;36050.4592431119;36382;35299.764508242086;35550;35676.61072198137;36032.81983590065;36102.27795444024;35232.64767352294;35474.82262588671;35508.644913551565;35899.10252243715;36235.637643623224;30912;31199.71011183517;31352.253255869175;32043.35913281768;32151.839240803645;24460.266192014267;24486.75513244845;24664.876675616506;25010.37474063163;25135 06:32:31 INFO - PROCESS | 32710 | |2;jquery.html;365.52664299731845;374.2570996571806;390.5918315360449;393.15864050931015;403.7093292829162;15565.521275478826;16689.666206675858;16916.407925722604;17127.82872171278;17130.486085417426;15905.920470397632;16784.664306713858;16850.325986960506;16922.323107075703;17502.124893755292;3376.4766461198556;4578.26747720364;4826;4837.758112094399;4856.611471082305;3553.1117220694828;5289.418164001957;5614.775408983635;5616.52259557938;5624.072028115356;5046.54581087702;5566.777328906839;5569.248151499536;5579.637323573975;5582.525485333752;3339.5825521809775;5342.198670199462;5434.701091439989;5463.3717122530625;5468.644538105011;4919.77860996256;5274.894502109936;5281.63028587999;5343.492368225013;5360;19632.11655475507;20265.29071482491;20515.589688206303;20526.589468210703;20590.794092059186;1809.4752521768671;1907.189444486088;1945.4552725236815;1955.5502234486005;2016.2842191022123;9054.411463254868;9198.218151457135;9477.194438472738;9588.280878934038;12566;1480.5262316058866;1502.9924850375787;1616.191904047976;1708.7693161423174;1744.4766570029067;69783.65108174426;69857.30142698559;71536.92694609637;71825.64087179583;73835;10342.32774869631;10344.793104138025;10350.637727679496;10368.792624147474;10449.738756530995;14620.342084606218;14646.194459304841;14654.926725366518;14693.338799754038;14693.77959330611;7099.858002839915;7330.743423980135;7359.300866417681;7396.186419493852;7404.814879628052;6641.701123449359;6670.533062685662;6694.163229596301;6700.530962832652;6772.966135169391;4459.420275364182;4502.887427814331;4517.638588912879;4546.613537849254;4552.499225085238;1704.9829501705071;1775.5472354549506;1889.4142815727168;1904.352520143158;1919.5489060070872;885.0662551008619;889.8531742262584;912.8128733609594;925.4909799610188;940.2759874896292;15123.470678526419;16121.27454264561;16148.434804781777;16225.918870405572;16368.345266189219;896.7130518234103;904.5341649050744;905.4838741917044;919.9540022998823;926.9907300926905;9115.36192466521;9322.813543729224;9420.481873496887;9479.194268487256;9569.090936361035;395972;405839;405862;413369;421704;79298.6035069821;79753;80861;81125.59437202776;81256;919.3151102428733;921.318224513855;938.1134827588;941.2752180820867;942.6229508196776;14257.786133207803;14803;14882.404703811726;15196.620084497976;15666.530004099895;24434.51130977406;25299.87350063238;32807.67192328046;34548.30903381868;34936.65063349334;47375.28937065878;48427.27359089687;49565.752171240354;49961.25058124059;49991.25013124879;6916.481263905328;7089.858202836018;7266.091738532684;7298.598577078312;7489.737859174903;8474.32205423577;11688.94155529217;11971.76056478883;12112.333821639895;12273.509059637514;10093.142082923034;10562.89437105619;10610.52252648648;10703.250772445854;10824.783504329711;10312.948435257777;10396.844047339144;10421.635242766466;10697.411642359744;10728.302660327054;10505.894941050798;10613.416262105658;10731.409772462277;10811.891881081403;10825.621103261348;6972.825679358057;7051.259617740268;7162;7259.673314700956;7325.523840950321;9792.951035244778;10122;10195.643152489627;10256.48717564104;10453.320534165256 06:32:31 INFO - PROCESS | 32710 | |3;mootools.html;1286.8841804237616;1472.4993502209247;1509.1397903195177;1679.479361397966;1845.6677797996356;6513.511486638503;7270.236625154362;7525.096988361391;7542.622868856549;7575.545467271953;7158.964205178967;7375.409967202624;7404.629768511566;7536.773896783106;7578.242175782419;1865.9533511662182;2097.9685304720365;2177.346795961213;2181.814545763608;2237.105157936822;2232.7878851509163;2236.194969810867;2251.864888106719;2252.4256314639742;2264.954700905981;2135.7970992755663;2151.3868547463976;2159.4493404181912;2166.209333593235;2171.207509259117;1819.9545011374755;2080.4590806390297;2095.559932414195;2161.7081693971268;2164.2316977473083;2184.344696591016;2190.5728382965326;2200.7139071920546;2202.9889850550803;2208.7128673272373;7613;7633.08402991639;7661.808454788619;7667.616619169019;7675.539467631904;4612.561806628365;4773.16469617819;4774;4778.593819525345;4804.351412559295;2846.2742000789667;2855.6858745537975;2880.3087259057884;2907.752841008517;2933.6332958380203;860.5912191708951;864.7838040489878;865.9911203447975;871.1506281375672;873.8339715454107;10180.287379883412;10307.587696492057;10387;10467.371957682564;10482.109020733247;4291.184674911757;4301.827926882952;4376.606105450524;4406.074724307931;4406.427164468599;8962.417442866194;8990.505522196212;9003;9016.774580635536;9029.729108126767;4727.881802954954;4745.572898439088;4797.856064318076;4817.205161148441;4831.444383895897;3588.659077387644;4191.476065491814;4347.543507931621;4377.146456440963;4378.387025816388;3697.9815100924325;3733.3653278942643;3765.2281282337053;3827.655511004023;3831.3103641344824;1196.6230637349206;1216.6958260434892;1236.190295356525;1236.252067499168;1243.1049644256302;846.331398195431;868.9174528419917;870.9303255739526;874.6326542852017;880.3529405886668;5113.335266415343;5180.352455943007;5300.814471493479;5313.681179129265;5364.249005139283;421.2922290551902;423.4854651598323;425.3895659728238;432.36010704158025;435.18185810675726;3499.4225952718025;3509.7192224621967;3524.7885126891956;3554.964450355463;3587.1749497615697;8731.257843083282;8807.559622018873;9089.636414543344;9178.724638260863;9470.195033422237;9189.90810091904;9240.491772952551;9323.440593564408;9366;9386.67146649864;6929.5842249465195;7039.472039596948;7066.752663656747;7088.7873363798135;7094.893576596355;5342.439043900335;5397.919031214614;5425.728713564227;5522.834314970557;5593.468620481048;8353.20644538768;8362.372822038249;8432.5783710813;8443.113473085483;8661.783455413664;8511.233988941025;8646.43798153118;8662.82674346522;8669.30645548342;8669.783255418664;5759.71201439918;6439.291677915519;6661.067450556829;6761.425278851353;6857.451403887777;7505.136909255505;7517.887231691639;7535.962320188364;7553.055868016498;7633.6564854580565;6287.308396076336;6431.871362572816;6500.414962653384;6603.735850565923;6603.9339606605245;6752.493562982894;6786.117804685359;6793.490488213502;6794.3545363190415;6858.5199036067;6460.612363258219;6477.8704425912165;6527.771527996498;6540.771073012422;6558.770443034471;4248.893777655583;4480.462344518679;4545.6590755694115;4554.157480866051;4587;4574.108048930427;4850.126977144007;4889.584385327287;4911.3369695090705;4972.105021096238 06:32:31 INFO - PROCESS | 32710 | |4;prototype.html;311.3073411659059;314.2426751528816;316.8954245099118;319.0985466058386;320.39125661243634;4565.680402371835;4613.838515651953;4619.036909313537;4622.226664001601;4625.259958406656;4574;4579.610733087691;4586.1974154522995;4604.516525764797;4623.306504024398;3459.304940579117;3544.982275088621;3690.261947610475;3705.4987883178883;3713.721470889694;3656.451532270154;3682.5949145593963;3685.594584595692;3688.391415416453;3698.870539531117;3460;3645.125169959204;3665.3872296189593;3674.3018826423026;3680.9447858282147;3500.9299814003703;3647.689946354563;3654.8903532894055;3668.449732540127;3674.9081272968388;3253.528238405418;3261.9184520386943;3277.2462333663393;3277.655846136145;3277.9344413111603;4431.534688857656;4437.2013037653205;4446.710963787344;4480.865574032784;4481.126180394825;4015.9397609035886;4155.376693495969;4188.6649068074485;4196.475440569929;4199;4775.426948766136;4777.348571542792;4800.903981920377;4804.351412559329;4809.446913604946;3567.518385018015;3583.5699716033982;3586.103474131467;3588.067102553329;3630.6913912317486;4757.500462451428;5053.974730126362;5065.696058236517;5094.286799848024;5101.903090835488;3469.167399824024;3477.095955051654;3489.249811290534;3489.581250249986;3491.0748651607346;3516.0330908999717;3533.611302756746;3536.29274145172;3536.3634545781492;3539.663731945461;4044.716869819143;4045.4943132108488;4068.5524592294823;4082.857100001486;4086.6117718816663;4651.395318608559;4773.660906155958;4853.344798452164;4861.683990540603;4880.41435027799;1273.2169715624825;1275.508929062299;1285.8714128587253;1287.2340957130493;1287.658770425838;840.1094839470181;843.700486327345;895.3866601378077;915.6037043508702;916.6883259691737;4092.751710728197;4125.29869922114;4138.193052354762;4144.274751918402;4145.709800313949;4877.585405240523;4917.754112294371;4917.87705307363;4920.704757714549;4934.55588996992;4001.419794129835;4130.925959250556;4177.582241775798;4179.561146079618;4193.161367726406;2585.1985884375904;2611.347163209198;2619.9607005894927;2623.7638612524966;2629.815912886118;4666.766661666903;4673.696209746356;4710.882227944328;4711.175544279738;4712.6229901607785;4874.731889746098;4960.826371076995;5066.721330326867;5082.669626474268;5097.1844504879045;4640.907181856344;4673.228917228619;4694.694844835075;4696.600788932979;4711.175544279738;4915.361003069578;4925.926111108408;4953.356063711839;4954.677945933647;4955.35580374549;4652.627789776878;4829.323894654681;4856.514348565115;4894.755262236803;4920.827771027997;4746.501617330268;4747.884247201836;4750.809967601395;4752.524747525358;4753.453352864327;3610.223801882608;3615.584207816135;3617.077645200457;3638.927221455503;3646.5077214575695;5058.192703049843;5063.924041139312;5066.620003499678;5086.160783470686;5090.974545127251;4557;4868.659193856396;4872.707637541759;4885.2427873679635;4908.11653902301;4846.539578740014;4863.48933362006;4874.95125048745;4877.097736918681;4878.878028049327;4764.42826860765;4786.200072957359;4819.807207711652;4826.6621336506105;4835.3714017178945;4624.44506659203;4856.053069651525;4862.31927530139;4866.8053277868485;4867.221244600847;4731.888006318582;4732.763361831826;4747.026859493864;4747.691400059123;4794.304825800309 06:32:31 INFO - PROCESS | 32710 | |5;yui.html;708.1891234536453;713.8251128473523;714.4034730999615;812.3501199040768;812.7968007998;12509.874901250985;12974.286414247224;12983.675408114801;12997.220166789999;13001.544945926895;13100.213987160778;13119.606411807661;13178.736425271489;13219;13263.469461221539;682.2563405887581;837.9078301386843;871.4901782457255;876.0669886570781;881.8236352729448;858.1632907914795;866.4194989357114;866.7833041739565;867.5055218525412;873.0091346321907;902.5351943748974;903.7559858838109;908.8182363527288;909.708893154191;910.3400034974657;709.7941596936907;882.2104216726059;902.5306840442965;906.2568693671192;908.209857424042;674.8582797612507;676.24936320684;676.5602358466987;677.2516369411827;677.9084823548807;11135.944320278346;11145.554177832959;11209.887901120966;11219.719507012309;11225.494852731646;11328.150388720878;11647.30116193031;11840.467178976967;11891.702707432298;12228.327441990687;11140.387278699669;11216.214864959456;11311.490982905789;11332.716682082932;11398.373089480076;3970.3250447424007;3974.18529201513;3979.323027983481;4009.4386785850006;4061.0659548304056;42268.788656056524;44236.55763442389;44933;45086.32370514445;45317;8651.567421628893;9120.133587309196;9508.954015058338;9753.122219000183;9849.606015759433;15546.455874044354;15639.218039098227;15654.139022353653;15762.448314308944;16643.583910402336;6920.065791118134;6930.584164950119;6945.40964018054;7058.435325174077;7117.7152913882865;3601.099725068733;3665.6151104134215;3712.498812660256;3725.7578257413184;3839.0978120141745;2763.433496133288;2857.985710071436;2866.3407416294367;2871.61233233515;2873.195505258531;498.56873804159864;515.0831519894593;522.2427480153792;530.3291336459382;538.2625802650394;456.70998915688114;554.9417311182349;568.2101878389043;574.8189320364072;579.5189992306375;7691.384689224848;8207.384446166561;8314.168583141758;8327.417080804285;8627.611757470804;550.6916126968911;600.6276108812564;615.8460384903774;618.8545691762432;624.7688355308564;3802.391617341212;3912.182402643295;3941.4481972523868;4015.638592526628;4020.1356708307853;48139.518604814206;48166.27750583744;49306.75346623244;49591.256131158065;49992.50007499878;43185.78407107944;44624.553754462686;44723.776381118536;44911.326330105076;45040.3243951341;38534.42198367027;38586.80706596449;39119;41810;42032.36951445731;8416.537090459839;8476.788080297794;8508.74473765788;8577.785555360917;8651.134886511298;28298;28458.146255612366;28660.85669571639;29790.8510457455;30052.84973575118;37072.443913341864;37285.81357093306;37289.62710372861;37529.81235093807;38102.428463573626;10256.487175641338;10657.89342106569;10819.67540973772;10997.725056873642;11588.246763960316;12014.579489717818;12049.879501204876;12067.094967877269;12375.814362784746;12377.814332784836;11062.944685276521;11432.256903301259;11782.764344713229;11827.112966527373;11842.703932401415;10623.628173013907;10635.521401536795;11433.828492572784;11749.29504229749;11784.646460606196;11121.332720036824;11337.886621134014;11887.76224475523;11927.463264153308;11994.220375675553;9426.670066547638;9432.292578056537;9500.192483638968;9519.428834269966;9809.460479673686;8843.46939183651;9605.087516685904;10025;10025.398476091457;10066.899331006889 06:32:31 INFO - PROCESS | 32710 | __end_tp_report 06:32:31 INFO - PROCESS | 32710 | __start_cc_report 06:32:31 INFO - PROCESS | 32710 | _x_x_mozilla_cycle_collect,1080 06:32:31 INFO - PROCESS | 32710 | __end_cc_report 06:32:31 INFO - PROCESS | 32710 | __startTimestamp1462973551938__endTimestamp 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | ------- Summary: start ------- 06:32:31 INFO - PROCESS | 32710 | Number of tests: 6 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | [#0] dojo.html Cycles:165 Average:4630.43 Median:4755.90 stddev:475.71 (10.0%) stddev-sans-first:450.58 06:32:31 INFO - PROCESS | 32710 | Values: 2631.3 2643.5 2674.3 2683.9 2687.1 4542.3 4620.5 4659.6 4726.3 4765.6 4566.5 4568.6 4595.3 4645.7 4670.6 4153.8 4238.3 4243.8 4267.1 4479.9 4361.3 4427.7 4439.0 4445.4 4494.2 4207.6 4268.2 4295.4 4340.8 4346.7 4301.6 4315.4 4329.0 4407.5 4427.2 4356.3 4357.6 4361.5 4371.4 4420.4 4422.4 4578.0 4584.8 4650.8 4667.5 5025.8 5030.4 5056.5 5082.9 5088.3 5025.8 5027.6 5110.7 5113.5 5133.4 4561.2 4714.6 4717.1 4756.4 4790.5 5173.9 5187.3 5224.6 5228.1 5246.8 4959.0 4976.2 5006.8 5007.9 5017.3 4888.1 4986.8 4992.5 4994.7 4996.8 4943.0 4980.6 4987.6 4995.5 5031.3 4755.9 4934.8 4938.6 4940.9 4979.2 4151.3 4288.3 4299.9 4323.1 4336.9 3708.3 3755.3 3766.2 3771.4 3823.5 4282.0 4312.1 4331.2 4364.6 4378.7 4823.3 4951.7 4990.5 4992.1 5012.9 4230.2 4235.7 4237.2 4248.9 4256.6 4347.5 4513.9 4519.0 4520.0 4571.1 4667.0 4718.9 4727.5 4788.3 4790.8 5076.9 5079.8 5084.7 5085.4 5091.5 4596.6 4685.4 4748.7 4753.5 4781.2 4849.5 4856.5 4880.7 4881.3 4917.4 4884.0 4901.1 4901.4 4927.2 4964.9 4748.1 4761.0 4764.1 4794.0 4815.1 4906.0 4915.1 4915.4 4922.0 4949.4 4841.0 4846.6 4857.6 4880.2 4936.8 4693.4 4782.8 4884.4 4955.8 5026.3 4731.1 4783.4 4804.0 4829.2 4844.1 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | [#1] ext.html Cycles:180 Average:42436.79 Median:35491.73 stddev:69538.63 (195.9%) stddev-sans-first:69662.64 06:32:31 INFO - PROCESS | 32710 | Values: 568.3 570.2 578.0 587.7 588.7 27294.2 40590.8 40893.8 41957.8 42441.4 37943.4 38717.0 41823.4 41832.4 41853.2 7305.0 7680.7 7824.0 7841.0 7846.8 9657.6 9932.3 9946.9 10328.3 10333.9 9858.7 9927.0 9929.3 9964.6 9964.9 9855.0 9886.9 9917.0 9935.1 9964.5 9782.2 9783.3 9812.1 9833.8 9839.1 37720.6 37999.6 38159.2 38218.4 38260.0 3210.1 3211.2 3261.2 3281.2 3715.1 28721.7 28787.4 28832.6 29780.3 29892.7 3130.2 3136.7 3154.5 3190.6 3261.7 228445.0 229306.0 229543.0 230339.0 232792.0 52250.5 52500.7 52729.7 52865.2 52967.5 49398.5 49577.0 49590.0 49701.5 49745.0 12723.3 12967.6 13010.2 13020.0 13187.2 10008.9 10512.0 10738.1 11159.2 11183.3 15388.5 15551.3 15559.8 15744.6 15783.3 5806.2 5930.7 5953.5 5966.2 5984.0 880.5 945.3 1034.7 1065.1 1077.7 27146.3 27495.2 27795.2 28419.3 30315.2 957.2 988.2 1004.9 1096.4 1097.6 14396.6 14845.2 14854.3 14957.4 15150.2 327175.0 330204.0 331979.0 334017.0 334775.0 48735.5 48920.3 49006.0 49055.0 49178.0 1152.1 1244.6 1274.4 1286.7 1289.2 26911.1 27950.6 28324.0 28604.4 28750.6 41181.0 41593.8 41900.2 42125.9 42143.8 221631.0 222324.0 222373.0 222630.0 223905.0 22308.6 24524.9 25243.6 25396.4 26474.1 40588.6 41232.8 41554.6 41685.8 42561.6 35535.6 35695.6 35752.1 36050.5 36382.0 35299.8 35550.0 35676.6 36032.8 36102.3 35232.6 35474.8 35508.6 35899.1 36235.6 30912.0 31199.7 31352.3 32043.4 32151.8 24460.3 24486.8 24664.9 25010.4 25135.0 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | [#2] jquery.html Cycles:180 Average:24693.83 Median:417536.50 stddev:67447.08 (16.2%) stddev-sans-first:67611.55 06:32:31 INFO - PROCESS | 32710 | Values: 365.5 374.3 390.6 393.2 403.7 15565.5 16689.7 16916.4 17127.8 17130.5 15905.9 16784.7 16850.3 16922.3 17502.1 3376.5 4578.3 4826.0 4837.8 4856.6 3553.1 5289.4 5614.8 5616.5 5624.1 5046.5 5566.8 5569.2 5579.6 5582.5 3339.6 5342.2 5434.7 5463.4 5468.6 4919.8 5274.9 5281.6 5343.5 5360.0 19632.1 20265.3 20515.6 20526.6 20590.8 1809.5 1907.2 1945.5 1955.6 2016.3 9054.4 9198.2 9477.2 9588.3 12566.0 1480.5 1503.0 1616.2 1708.8 1744.5 69783.7 69857.3 71536.9 71825.6 73835.0 10342.3 10344.8 10350.6 10368.8 10449.7 14620.3 14646.2 14654.9 14693.3 14693.8 7099.9 7330.7 7359.3 7396.2 7404.8 6641.7 6670.5 6694.2 6700.5 6773.0 4459.4 4502.9 4517.6 4546.6 4552.5 1705.0 1775.5 1889.4 1904.4 1919.5 885.1 889.9 912.8 925.5 940.3 15123.5 16121.3 16148.4 16225.9 16368.3 896.7 904.5 905.5 920.0 927.0 9115.4 9322.8 9420.5 9479.2 9569.1 395972.0 405839.0 405862.0 413369.0 421704.0 79298.6 79753.0 80861.0 81125.6 81256.0 919.3 921.3 938.1 941.3 942.6 14257.8 14803.0 14882.4 15196.6 15666.5 24434.5 25299.9 32807.7 34548.3 34936.7 47375.3 48427.3 49565.8 49961.3 49991.3 6916.5 7089.9 7266.1 7298.6 7489.7 8474.3 11688.9 11971.8 12112.3 12273.5 10093.1 10562.9 10610.5 10703.3 10824.8 10312.9 10396.8 10421.6 10697.4 10728.3 10505.9 10613.4 10731.4 10811.9 10825.6 6972.8 7051.3 7162.0 7259.7 7325.5 9793.0 10122.0 10195.6 10256.5 10453.3 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | [#3] mootools.html Cycles:180 Average:5056.99 Median:5146.84 stddev:2774.68 (53.9%) stddev-sans-first:2767.99 06:32:31 INFO - PROCESS | 32710 | Values: 1286.9 1472.5 1509.1 1679.5 1845.7 6513.5 7270.2 7525.1 7542.6 7575.5 7159.0 7375.4 7404.6 7536.8 7578.2 1866.0 2098.0 2177.3 2181.8 2237.1 2232.8 2236.2 2251.9 2252.4 2265.0 2135.8 2151.4 2159.4 2166.2 2171.2 1820.0 2080.5 2095.6 2161.7 2164.2 2184.3 2190.6 2200.7 2203.0 2208.7 7613.0 7633.1 7661.8 7667.6 7675.5 4612.6 4773.2 4774.0 4778.6 4804.4 2846.3 2855.7 2880.3 2907.8 2933.6 860.6 864.8 866.0 871.2 873.8 10180.3 10307.6 10387.0 10467.4 10482.1 4291.2 4301.8 4376.6 4406.1 4406.4 8962.4 8990.5 9003.0 9016.8 9029.7 4727.9 4745.6 4797.9 4817.2 4831.4 3588.7 4191.5 4347.5 4377.1 4378.4 3698.0 3733.4 3765.2 3827.7 3831.3 1196.6 1216.7 1236.2 1236.3 1243.1 846.3 868.9 870.9 874.6 880.4 5113.3 5180.4 5300.8 5313.7 5364.2 421.3 423.5 425.4 432.4 435.2 3499.4 3509.7 3524.8 3555.0 3587.2 8731.3 8807.6 9089.6 9178.7 9470.2 9189.9 9240.5 9323.4 9366.0 9386.7 6929.6 7039.5 7066.8 7088.8 7094.9 5342.4 5397.9 5425.7 5522.8 5593.5 8353.2 8362.4 8432.6 8443.1 8661.8 8511.2 8646.4 8662.8 8669.3 8669.8 5759.7 6439.3 6661.1 6761.4 6857.5 7505.1 7517.9 7536.0 7553.1 7633.7 6287.3 6431.9 6500.4 6603.7 6603.9 6752.5 6786.1 6793.5 6794.4 6858.5 6460.6 6477.9 6527.8 6540.8 6558.8 4248.9 4480.5 4545.7 4554.2 4587.0 4574.1 4850.1 4889.6 4911.3 4972.1 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | [#4] prototype.html Cycles:180 Average:4024.23 Median:4609.18 stddev:1148.72 (24.9%) stddev-sans-first:1117.63 06:32:31 INFO - PROCESS | 32710 | Values: 311.3 314.2 316.9 319.1 320.4 4565.7 4613.8 4619.0 4622.2 4625.3 4574.0 4579.6 4586.2 4604.5 4623.3 3459.3 3545.0 3690.3 3705.5 3713.7 3656.5 3682.6 3685.6 3688.4 3698.9 3460.0 3645.1 3665.4 3674.3 3680.9 3500.9 3647.7 3654.9 3668.4 3674.9 3253.5 3261.9 3277.2 3277.7 3277.9 4431.5 4437.2 4446.7 4480.9 4481.1 4015.9 4155.4 4188.7 4196.5 4199.0 4775.4 4777.3 4800.9 4804.4 4809.4 3567.5 3583.6 3586.1 3588.1 3630.7 4757.5 5054.0 5065.7 5094.3 5101.9 3469.2 3477.1 3489.2 3489.6 3491.1 3516.0 3533.6 3536.3 3536.4 3539.7 4044.7 4045.5 4068.6 4082.9 4086.6 4651.4 4773.7 4853.3 4861.7 4880.4 1273.2 1275.5 1285.9 1287.2 1287.7 840.1 843.7 895.4 915.6 916.7 4092.8 4125.3 4138.2 4144.3 4145.7 4877.6 4917.8 4917.9 4920.7 4934.6 4001.4 4130.9 4177.6 4179.6 4193.2 2585.2 2611.3 2620.0 2623.8 2629.8 4666.8 4673.7 4710.9 4711.2 4712.6 4874.7 4960.8 5066.7 5082.7 5097.2 4640.9 4673.2 4694.7 4696.6 4711.2 4915.4 4925.9 4953.4 4954.7 4955.4 4652.6 4829.3 4856.5 4894.8 4920.8 4746.5 4747.9 4750.8 4752.5 4753.5 3610.2 3615.6 3617.1 3638.9 3646.5 5058.2 5063.9 5066.6 5086.2 5091.0 4557.0 4868.7 4872.7 4885.2 4908.1 4846.5 4863.5 4875.0 4877.1 4878.9 4764.4 4786.2 4819.8 4826.7 4835.4 4624.4 4856.1 4862.3 4866.8 4867.2 4731.9 4732.8 4747.0 4747.7 4794.3 06:32:31 INFO - PROCESS | 32710 | 06:32:31 INFO - PROCESS | 32710 | [#5] yui.html Cycles:180 Average:12543.62 Median:22935.53 stddev:13691.07 (59.7%) stddev-sans-first:13700.63 06:32:31 INFO - PROCESS | 32710 | Values: 708.2 713.8 714.4 812.4 812.8 12509.9 12974.3 12983.7 12997.2 13001.5 13100.2 13119.6 13178.7 13219.0 13263.5 682.3 837.9 871.5 876.1 881.8 858.2 866.4 866.8 867.5 873.0 902.5 903.8 908.8 909.7 910.3 709.8 882.2 902.5 906.3 908.2 674.9 676.2 676.6 677.3 677.9 11135.9 11145.6 11209.9 11219.7 11225.5 11328.2 11647.3 11840.5 11891.7 12228.3 11140.4 11216.2 11311.5 11332.7 11398.4 3970.3 3974.2 3979.3 4009.4 4061.1 42268.8 44236.6 44933.0 45086.3 45317.0 8651.6 9120.1 9509.0 9753.1 9849.6 15546.5 15639.2 15654.1 15762.4 16643.6 6920.1 6930.6 6945.4 7058.4 7117.7 3601.1 3665.6 3712.5 3725.8 3839.1 2763.4 2858.0 2866.3 2871.6 2873.2 498.6 515.1 522.2 530.3 538.3 456.7 554.9 568.2 574.8 579.5 7691.4 8207.4 8314.2 8327.4 8627.6 550.7 600.6 615.8 618.9 624.8 3802.4 3912.2 3941.4 4015.6 4020.1 48139.5 48166.3 49306.8 49591.3 49992.5 43185.8 44624.6 44723.8 44911.3 45040.3 38534.4 38586.8 39119.0 41810.0 42032.4 8416.5 8476.8 8508.7 8577.8 8651.1 28298.0 28458.1 28660.9 29790.9 30052.8 37072.4 37285.8 37289.6 37529.8 38102.4 10256.5 10657.9 10819.7 10997.7 11588.2 12014.6 12049.9 12067.1 12375.8 12377.8 11062.9 11432.3 11782.8 11827.1 11842.7 10623.6 10635.5 11433.8 11749.3 11784.6 11121.3 11337.9 11887.8 11927.5 11994.2 9426.7 9432.3 9500.2 9519.4 9809.5 8843.5 9605.1 10025.0 10025.4 10066.9 06:32:31 INFO - PROCESS | 32710 | -------- Summary: end -------- 06:32:31 INFO - PROCESS | 32710 | 06:32:32 INFO - TEST-INFO | 32710: exit 0 06:32:32 INFO - TEST-OK | dromaeo_css | took 1117690ms 06:32:32 INFO - TEST-START | kraken 06:32:32 INFO - operating with platform_type : linux_ 06:32:32 INFO - Initialising browser for kraken test... 06:32:32 INFO - TEST-INFO | started process 425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphsmm_n/profile http://localhost:41112/getInfo.html) 06:32:36 INFO - PROCESS | 425 | __metrics Screen width/height:1600/1200 06:32:36 INFO - PROCESS | 425 | colorDepth:24 06:32:36 INFO - PROCESS | 425 | Browser inner width/height: 1024/697 06:32:36 INFO - PROCESS | 425 | __metrics 06:32:37 ERROR - PROCESS | 425 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:32:38 INFO - TEST-INFO | 425: exit 0 06:32:38 INFO - Browser initialized. 06:32:38 INFO - Running cycle 1/1 for kraken test... 06:32:38 INFO - TEST-INFO | started process 503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphsmm_n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:49 INFO - PROCESS | 503 | RSS: Main: 152793088 06:32:49 INFO - PROCESS | 503 | 06:32:52 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41112/tests/kraken/driver.html?testName=audio-beat-detection) 06:32:53 INFO - PROCESS | 503 | RSS: Main: 209149952 06:32:53 INFO - PROCESS | 503 | 06:32:56 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41112/tests/kraken/driver.html?testName=audio-dft) 06:32:57 INFO - PROCESS | 503 | RSS: Main: 197365760 06:32:57 INFO - PROCESS | 503 | 06:33:00 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41112/tests/kraken/driver.html?testName=audio-fft) 06:33:00 INFO - PROCESS | 503 | RSS: Main: 265465856 06:33:00 INFO - PROCESS | 503 | 06:33:03 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41112/tests/kraken/driver.html?testName=audio-oscillator) 06:33:03 INFO - PROCESS | 503 | RSS: Main: 174899200 06:33:03 INFO - PROCESS | 503 | 06:33:06 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41112/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:33:06 INFO - PROCESS | 503 | RSS: Main: 178827264 06:33:06 INFO - PROCESS | 503 | 06:33:10 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41112/tests/kraken/driver.html?testName=imaging-darkroom) 06:33:10 INFO - PROCESS | 503 | RSS: Main: 215212032 06:33:10 INFO - PROCESS | 503 | 06:33:14 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41112/tests/kraken/driver.html?testName=imaging-desaturate) 06:33:14 INFO - PROCESS | 503 | RSS: Main: 213704704 06:33:14 INFO - PROCESS | 503 | 06:33:17 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41112/tests/kraken/driver.html?testName=json-parse-financial) 06:33:18 INFO - PROCESS | 503 | RSS: Main: 213966848 06:33:18 INFO - PROCESS | 503 | 06:33:20 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41112/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:33:20 INFO - PROCESS | 503 | RSS: Main: 208949248 06:33:20 INFO - PROCESS | 503 | 06:33:22 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:33:23 INFO - PROCESS | 503 | RSS: Main: 210505728 06:33:23 INFO - PROCESS | 503 | 06:33:25 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:33:26 INFO - PROCESS | 503 | RSS: Main: 212971520 06:33:26 INFO - PROCESS | 503 | 06:33:29 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:33:30 INFO - PROCESS | 503 | RSS: Main: 218005504 06:33:30 INFO - PROCESS | 503 | 06:33:33 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:33:33 INFO - PROCESS | 503 | RSS: Main: 216154112 06:33:33 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | Cycle 1(1): loaded http://localhost:41112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41112/tests/kraken/driver.html?testName=ai-astar) 06:33:35 INFO - PROCESS | 503 | RSS: Main: 261689344 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | __start_tp_report 06:33:35 INFO - PROCESS | 503 | _x_x_mozilla_page_load 06:33:35 INFO - PROCESS | 503 | _x_x_mozilla_page_load_details 06:33:35 INFO - PROCESS | 503 | |i|pagename|runs| 06:33:35 INFO - PROCESS | 503 | |0;ai-astar;115;113;117;116;117;115;115;116;114;116 06:33:35 INFO - PROCESS | 503 | |1;audio-beat-detection;170;137;160;213;141;166;160;147;188;136 06:33:35 INFO - PROCESS | 503 | |2;audio-dft;162;163;163;163;165;163;163;164;164;161 06:33:35 INFO - PROCESS | 503 | |3;audio-fft;77;78;78;148;78;82;78;78;127;78 06:33:35 INFO - PROCESS | 503 | |4;audio-oscillator;94;96;148;93;93;94;118;93;93;118 06:33:35 INFO - PROCESS | 503 | |5;imaging-gaussian-blur;119;120;118;118;120;118;118;118;119;118 06:33:35 INFO - PROCESS | 503 | |6;imaging-darkroom;147;148;148;146;148;147;146;146;149;146 06:33:35 INFO - PROCESS | 503 | |7;imaging-desaturate;96;95;96;95;96;94;95;95;95;95 06:33:35 INFO - PROCESS | 503 | |8;json-parse-financial;68;68;70;69;68;69;69;68;69;69 06:33:35 INFO - PROCESS | 503 | |9;json-stringify-tinderbox;64;64;64;64;65;64;64;65;64;65 06:33:35 INFO - PROCESS | 503 | |10;stanford-crypto-aes;90;88;86;86;89;88;88;86;166;93 06:33:35 INFO - PROCESS | 503 | |11;stanford-crypto-ccm;145;144;143;139;142;153;140;159;158;140 06:33:35 INFO - PROCESS | 503 | |12;stanford-crypto-pbkdf2;183;183;181;183;180;180;177;181;182;179 06:33:35 INFO - PROCESS | 503 | |13;stanford-crypto-sha256-iterative;72;75;71;74;71;75;71;70;69;70 06:33:35 INFO - PROCESS | 503 | __end_tp_report 06:33:35 INFO - PROCESS | 503 | __start_cc_report 06:33:35 INFO - PROCESS | 503 | _x_x_mozilla_cycle_collect,1967 06:33:35 INFO - PROCESS | 503 | __end_cc_report 06:33:35 INFO - PROCESS | 503 | __startTimestamp1462973615698__endTimestamp 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | ------- Summary: start ------- 06:33:35 INFO - PROCESS | 503 | Number of tests: 14 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 06:33:35 INFO - PROCESS | 503 | Values: 115.0 113.0 117.0 116.0 117.0 115.0 115.0 116.0 114.0 116.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#1] audio-beat-detection Cycles:10 Average:161.80 Median:163.00 stddev:24.34 (14.9%) stddev-sans-first:25.63 06:33:35 INFO - PROCESS | 503 | Values: 170.0 137.0 160.0 213.0 141.0 166.0 160.0 147.0 188.0 136.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 06:33:35 INFO - PROCESS | 503 | Values: 162.0 163.0 163.0 163.0 165.0 163.0 163.0 164.0 164.0 161.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#3] audio-fft Cycles:10 Average:90.20 Median:78.00 stddev:25.45 (32.6%) stddev-sans-first:26.54 06:33:35 INFO - PROCESS | 503 | Values: 77.0 78.0 78.0 148.0 78.0 82.0 78.0 78.0 127.0 78.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:93.00 stddev:18.49 (19.9%) stddev-sans-first:19.25 06:33:35 INFO - PROCESS | 503 | Values: 94.0 96.0 148.0 93.0 93.0 94.0 118.0 93.0 93.0 118.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 06:33:35 INFO - PROCESS | 503 | Values: 119.0 120.0 118.0 118.0 120.0 118.0 118.0 118.0 119.0 118.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 06:33:35 INFO - PROCESS | 503 | Values: 147.0 148.0 148.0 146.0 148.0 147.0 146.0 146.0 149.0 146.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:33:35 INFO - PROCESS | 503 | Values: 96.0 95.0 96.0 95.0 96.0 94.0 95.0 95.0 95.0 95.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 06:33:35 INFO - PROCESS | 503 | Values: 68.0 68.0 70.0 69.0 68.0 69.0 69.0 68.0 69.0 69.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 06:33:35 INFO - PROCESS | 503 | Values: 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 65.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#10] stanford-crypto-aes Cycles:10 Average:96.00 Median:88.00 stddev:24.69 (28.1%) stddev-sans-first:26.09 06:33:35 INFO - PROCESS | 503 | Values: 90.0 88.0 86.0 86.0 89.0 88.0 88.0 86.0 166.0 93.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#11] stanford-crypto-ccm Cycles:10 Average:146.30 Median:144.50 stddev:7.54 (5.2%) stddev-sans-first:7.99 06:33:35 INFO - PROCESS | 503 | Values: 145.0 144.0 143.0 139.0 142.0 153.0 140.0 159.0 158.0 140.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:181.50 stddev:1.97 (1.1%) stddev-sans-first:1.94 06:33:35 INFO - PROCESS | 503 | Values: 183.0 183.0 181.0 183.0 180.0 180.0 177.0 181.0 182.0 179.0 06:33:35 INFO - PROCESS | 503 | 06:33:35 INFO - PROCESS | 503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.50 stddev:2.15 (3.0%) stddev-sans-first:2.28 06:33:35 INFO - PROCESS | 503 | Values: 72.0 75.0 71.0 74.0 71.0 75.0 71.0 70.0 69.0 70.0 06:33:35 INFO - PROCESS | 503 | -------- Summary: end -------- 06:33:35 INFO - PROCESS | 503 | 06:33:36 INFO - TEST-INFO | 503: exit 0 06:33:36 INFO - TEST-OK | kraken | took 64116ms 06:33:36 INFO - SUITE-END | took 1181s 06:33:36 INFO - Completed test suite (00:19:42) 06:33:36 INFO - javascript benchmark 06:33:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.263246291039, 2643.524165650183, 2674.277944954862, 2683.9398437617137, 2687.0729598288585, 4542.273236282195, 4620.537946205386, 4659.62722982161, 4726.33831263623, 4765.642576806736, 4566.474855391631, 4568.565986231302, 4595.333676616889, 4645.651576131787, 4670.579647831694, 4153.792310384484, 4238.300680387748, 4243.787810609472, 4267.14657068586, 4479.910401791963, 4361.280388735855, 4427.667924905629, 4439.045605194882, 4445.444319460067, 4494.213512635276, 4207.621314081747, 4268.167707297078, 4295.355696645528, 4340.804663790137, 4346.6522678185665, 4301.612854843079, 4315.43899293093, 4329.047609525899, 4407.493138289105, 4427.247367947457, 4356.281213599752, 4357.6078152966065, 4361.520232774392, 4371.4098596689355, 4420.447444069491, 4422.402975598286, 4577.977110114428, 4584.770761461914, 4650.837220697294, 4667.486576476585, 5025.8240961566535, 5030.37120359955, 5056.519630635084, 5082.923756143661, 5088.287639730441, 5025.773840177164, 5027.648064635477, 5110.718910459923, 5113.463086375951, 5133.358330208724, 4561.201789686792, 4714.646401519865, 4717.056588682209, 4756.357891684647, 4790.520947905251, 5173.948260517422, 5187.273781670569, 5224.634275600672, 5228.05894938907, 5246.842594722164, 4958.950410495849, 4976.2286845539, 5006.849794506171, 5007.9499205008215, 5017.3226614406585, 4888.120138375127, 4986.825461108844, 4992.450830408652, 4994.700317980933, 4996.7501624918605, 4942.950570494321, 4980.576650984634, 4987.62592805541, 4995.450500444948, 5031.345925029796, 4755.904881902412, 4934.753262336869, 4938.58022068121, 4940.925886111711, 4979.228219625964, 4151.27352713274, 4288.31386978082, 4299.892502687458, 4323.113761678848, 4336.891577710519, 3708.295423869456, 3755.2677227940835, 3766.227923275722, 3771.396576547739, 3823.541175058955, 4282.036541778138, 4312.094460163338, 4331.155424692155, 4364.64695944252, 4378.693491455568, 4823.348847905488, 4951.702897826142, 4990.500949905053, 4992.051510213048, 5012.949870501321, 4230.2174097792, 4235.745855248695, 4237.173751118564, 4248.87253382399, 4256.553061928515, 4347.456567929009, 4513.887152821206, 4518.960639053036, 4520.028193938319, 4571.062932098978, 4666.976665116653, 4718.882027949328, 4727.503612120678, 4788.257820037899, 4790.832320868893, 5076.949230507647, 5079.796808127781, 5084.694918304914, 5085.389753229488, 5091.465396133352, 4596.609288210406, 4685.4143232095985, 4748.667593268438, 4753.5008824072975, 4781.163296423042, 4849.4908034657265, 4856.514348565115, 4880.658353915192, 4881.267809828554, 4917.385326834145, 4883.974365383309, 4901.117798796108, 4901.436334821541, 4927.211646136601, 4964.900701986012, 4748.121597504472, 4760.952390476051, 4764.094821983812, 4794.017226468496, 4815.109204797123, 4906.0, 4915.139850526072, 4915.410150781786, 4922.0, 4949.356583644103, 4841.031793641216, 4846.636502262415, 4857.635677324144, 4880.170371036861, 4936.802527898987, 4693.389859318267, 4782.760861956818, 4884.365032545888, 4955.82654607087, 5026.321446604661, 4731.148393289103, 4783.449903261169, 4803.99116185591, 4829.1790395633525, 4844.0554091951735], "value": 4601.081853338063, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3265330583258, 570.1647087017518, 577.9537636989041, 587.6797145555672, 588.6938791828248, 27294.181174564746, 40590.79704601476, 40893.795531022304, 41957.7902110489, 42441.36337954933, 37943.4308485373, 38717.0, 41823.37264941021, 41832.37251441231, 41853.162936741246, 7305.0, 7680.731174408897, 7823.982882225303, 7840.960795196044, 7846.803829904241, 9657.613695452173, 9932.304738668296, 9946.900530994706, 10328.27702060856, 10333.948330258338, 9858.70423887281, 9926.9503652482, 9929.304948653597, 9964.601415943354, 9964.90035099647, 9854.950725246365, 9886.90113098867, 9917.0, 9935.10584047432, 9964.4519551425, 9782.168515676176, 9783.315167938246, 9812.116909478109, 9833.803323933482, 9839.114479696862, 37720.62279377199, 37999.62000380016, 38159.236815263816, 38218.426723599165, 38260.0, 3210.1011716719354, 3211.1811488070393, 3261.249912520134, 3281.2125089978235, 3715.1269451678836, 28721.712782872113, 28787.42425151506, 28832.567511487345, 29780.255493612833, 29892.70107298921, 3130.20179854138, 3136.670649581784, 3154.479510880702, 3190.6171259448784, 3261.72275356595, 228445.0, 229306.0, 229542.99999999834, 230339.0, 232792.0, 52250.47749522532, 52500.69991601032, 52729.73635131877, 52865.207021894705, 52967.47032529626, 49398.50601494011, 49577.0, 49590.0, 49701.50298497041, 49745.0, 12723.300218488072, 12967.610971670865, 13010.21938683682, 13020.0, 13187.208767473981, 10008.949955250177, 10512.0, 10738.087262582769, 11159.163062770325, 11183.32900026001, 15388.461403850812, 15551.30019149141, 15559.84440155584, 15744.60638484047, 15783.289751961189, 5806.158107074535, 5930.673812940244, 5953.493953014043, 5966.164736936832, 5983.970080149571, 880.5157163560017, 945.3193700535603, 1034.6999370182714, 1065.1212749481708, 1077.6659235636978, 27146.32134196661, 27495.175144745688, 27795.166145015683, 28419.28951776181, 30315.242118947204, 957.1911734584265, 988.1896844587369, 1004.9346792458467, 1096.3641088168843, 1097.5719469406938, 14396.640083997983, 14845.183514906568, 14854.257287135817, 14957.401703931939, 15150.242487875563, 327175.0, 330204.0, 331979.0, 334017.0, 334775.0, 48735.51264487381, 48920.26619600709, 49006.0, 49055.0, 49178.0, 1152.066825871047, 1244.5830646733264, 1274.394662535307, 1286.742651469691, 1289.1749280460513, 26911.058112966737, 27950.58074128849, 28324.0, 28604.42791144207, 28750.568741468476, 41181.0, 41593.79203103965, 41900.161996759285, 42125.94685132896, 42143.789281054625, 221631.0, 222324.0, 222373.0, 222630.0, 223905.0, 22308.553828923006, 24524.877375613007, 25243.62134567946, 25396.365090872878, 26474.07340743065, 40588.594114058484, 41232.79383603063, 41554.58445415507, 41685.79157104316, 42561.574384257, 35535.644643553234, 35695.64304356923, 35752.106197345274, 36050.4592431119, 36382.0, 35299.764508242086, 35550.0, 35676.61072198137, 36032.81983590065, 36102.27795444024, 35232.64767352294, 35474.82262588671, 35508.644913551565, 35899.10252243715, 36235.637643623224, 30912.0, 31199.71011183517, 31352.253255869175, 32043.35913281768, 32151.839240803645, 24460.266192014267, 24486.75513244845, 24664.876675616506, 25010.37474063163, 25135.0], "value": 17461.914846979784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.52664299731845, 374.2570996571806, 390.5918315360449, 393.15864050931015, 403.7093292829162, 15565.521275478826, 16689.666206675858, 16916.407925722604, 17127.82872171278, 17130.486085417426, 15905.920470397632, 16784.664306713858, 16850.325986960506, 16922.323107075703, 17502.124893755292, 3376.4766461198556, 4578.26747720364, 4826.0, 4837.758112094399, 4856.611471082305, 3553.1117220694828, 5289.418164001957, 5614.775408983635, 5616.52259557938, 5624.072028115356, 5046.54581087702, 5566.777328906839, 5569.248151499536, 5579.637323573975, 5582.525485333752, 3339.5825521809775, 5342.198670199462, 5434.701091439989, 5463.3717122530625, 5468.644538105011, 4919.77860996256, 5274.894502109936, 5281.63028587999, 5343.492368225013, 5360.0, 19632.11655475507, 20265.29071482491, 20515.589688206303, 20526.589468210703, 20590.794092059186, 1809.4752521768671, 1907.189444486088, 1945.4552725236815, 1955.5502234486005, 2016.2842191022123, 9054.411463254868, 9198.218151457135, 9477.194438472738, 9588.280878934038, 12566.0, 1480.5262316058866, 1502.9924850375787, 1616.191904047976, 1708.7693161423174, 1744.4766570029067, 69783.65108174426, 69857.30142698559, 71536.92694609637, 71825.64087179583, 73835.0, 10342.32774869631, 10344.793104138025, 10350.637727679496, 10368.792624147474, 10449.738756530995, 14620.342084606218, 14646.194459304841, 14654.926725366518, 14693.338799754038, 14693.77959330611, 7099.858002839915, 7330.743423980135, 7359.300866417681, 7396.186419493852, 7404.814879628052, 6641.701123449359, 6670.533062685662, 6694.163229596301, 6700.530962832652, 6772.966135169391, 4459.420275364182, 4502.887427814331, 4517.638588912879, 4546.613537849254, 4552.499225085238, 1704.9829501705071, 1775.5472354549506, 1889.4142815727168, 1904.352520143158, 1919.5489060070872, 885.0662551008619, 889.8531742262584, 912.8128733609594, 925.4909799610188, 940.2759874896292, 15123.470678526419, 16121.27454264561, 16148.434804781777, 16225.918870405572, 16368.345266189219, 896.7130518234103, 904.5341649050744, 905.4838741917044, 919.9540022998823, 926.9907300926905, 9115.36192466521, 9322.813543729224, 9420.481873496887, 9479.194268487256, 9569.090936361035, 395972.0, 405839.0, 405862.0, 413369.0, 421704.0, 79298.6035069821, 79753.0, 80861.0, 81125.59437202776, 81256.0, 919.3151102428733, 921.318224513855, 938.1134827588, 941.2752180820867, 942.6229508196776, 14257.786133207803, 14803.0, 14882.404703811726, 15196.620084497976, 15666.530004099895, 24434.51130977406, 25299.87350063238, 32807.67192328046, 34548.30903381868, 34936.65063349334, 47375.28937065878, 48427.27359089687, 49565.752171240354, 49961.25058124059, 49991.25013124879, 6916.481263905328, 7089.858202836018, 7266.091738532684, 7298.598577078312, 7489.737859174903, 8474.32205423577, 11688.94155529217, 11971.76056478883, 12112.333821639895, 12273.509059637514, 10093.142082923034, 10562.89437105619, 10610.52252648648, 10703.250772445854, 10824.783504329711, 10312.948435257777, 10396.844047339144, 10421.635242766466, 10697.411642359744, 10728.302660327054, 10505.894941050798, 10613.416262105658, 10731.409772462277, 10811.891881081403, 10825.621103261348, 6972.825679358057, 7051.259617740268, 7162.0, 7259.673314700956, 7325.523840950321, 9792.951035244778, 10122.0, 10195.643152489627, 10256.48717564104, 10453.320534165256], "value": 8137.495808798092, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.8841804237616, 1472.4993502209247, 1509.1397903195177, 1679.479361397966, 1845.6677797996356, 6513.511486638503, 7270.236625154362, 7525.096988361391, 7542.622868856549, 7575.545467271953, 7158.964205178967, 7375.409967202624, 7404.629768511566, 7536.773896783106, 7578.242175782419, 1865.9533511662182, 2097.9685304720365, 2177.346795961213, 2181.814545763608, 2237.105157936822, 2232.7878851509163, 2236.194969810867, 2251.864888106719, 2252.4256314639742, 2264.954700905981, 2135.7970992755663, 2151.3868547463976, 2159.4493404181912, 2166.209333593235, 2171.207509259117, 1819.9545011374755, 2080.4590806390297, 2095.559932414195, 2161.7081693971268, 2164.2316977473083, 2184.344696591016, 2190.5728382965326, 2200.7139071920546, 2202.9889850550803, 2208.7128673272373, 7613.0, 7633.08402991639, 7661.808454788619, 7667.616619169019, 7675.539467631904, 4612.561806628365, 4773.16469617819, 4774.0, 4778.593819525345, 4804.351412559295, 2846.2742000789667, 2855.6858745537975, 2880.3087259057884, 2907.752841008517, 2933.6332958380203, 860.5912191708951, 864.7838040489878, 865.9911203447975, 871.1506281375672, 873.8339715454107, 10180.287379883412, 10307.587696492057, 10387.0, 10467.371957682564, 10482.109020733247, 4291.184674911757, 4301.827926882952, 4376.606105450524, 4406.074724307931, 4406.427164468599, 8962.417442866194, 8990.505522196212, 9003.0, 9016.774580635536, 9029.729108126767, 4727.881802954954, 4745.572898439088, 4797.856064318076, 4817.205161148441, 4831.444383895897, 3588.659077387644, 4191.476065491814, 4347.543507931621, 4377.146456440963, 4378.387025816388, 3697.9815100924325, 3733.3653278942643, 3765.2281282337053, 3827.655511004023, 3831.3103641344824, 1196.6230637349206, 1216.6958260434892, 1236.190295356525, 1236.252067499168, 1243.1049644256302, 846.331398195431, 868.9174528419917, 870.9303255739526, 874.6326542852017, 880.3529405886668, 5113.335266415343, 5180.352455943007, 5300.814471493479, 5313.681179129265, 5364.249005139283, 421.2922290551902, 423.4854651598323, 425.3895659728238, 432.36010704158025, 435.18185810675726, 3499.4225952718025, 3509.7192224621967, 3524.7885126891956, 3554.964450355463, 3587.1749497615697, 8731.257843083282, 8807.559622018873, 9089.636414543344, 9178.724638260863, 9470.195033422237, 9189.90810091904, 9240.491772952551, 9323.440593564408, 9366.0, 9386.67146649864, 6929.5842249465195, 7039.472039596948, 7066.752663656747, 7088.7873363798135, 7094.893576596355, 5342.439043900335, 5397.919031214614, 5425.728713564227, 5522.834314970557, 5593.468620481048, 8353.20644538768, 8362.372822038249, 8432.5783710813, 8443.113473085483, 8661.783455413664, 8511.233988941025, 8646.43798153118, 8662.82674346522, 8669.30645548342, 8669.783255418664, 5759.71201439918, 6439.291677915519, 6661.067450556829, 6761.425278851353, 6857.451403887777, 7505.136909255505, 7517.887231691639, 7535.962320188364, 7553.055868016498, 7633.6564854580565, 6287.308396076336, 6431.871362572816, 6500.414962653384, 6603.735850565923, 6603.9339606605245, 6752.493562982894, 6786.117804685359, 6793.490488213502, 6794.3545363190415, 6858.5199036067, 6460.612363258219, 6477.8704425912165, 6527.771527996498, 6540.771073012422, 6558.770443034471, 4248.893777655583, 4480.462344518679, 4545.6590755694115, 4554.157480866051, 4587.0, 4574.108048930427, 4850.126977144007, 4889.584385327287, 4911.3369695090705, 4972.105021096238], "value": 4038.3777734585747, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.3073411659059, 314.2426751528816, 316.8954245099118, 319.0985466058386, 320.39125661243634, 4565.680402371835, 4613.838515651953, 4619.036909313537, 4622.226664001601, 4625.259958406656, 4574.0, 4579.610733087691, 4586.1974154522995, 4604.516525764797, 4623.306504024398, 3459.304940579117, 3544.982275088621, 3690.261947610475, 3705.4987883178883, 3713.721470889694, 3656.451532270154, 3682.5949145593963, 3685.594584595692, 3688.391415416453, 3698.870539531117, 3460.0, 3645.125169959204, 3665.3872296189593, 3674.3018826423026, 3680.9447858282147, 3500.9299814003703, 3647.689946354563, 3654.8903532894055, 3668.449732540127, 3674.9081272968388, 3253.528238405418, 3261.9184520386943, 3277.2462333663393, 3277.655846136145, 3277.9344413111603, 4431.534688857656, 4437.2013037653205, 4446.710963787344, 4480.865574032784, 4481.126180394825, 4015.9397609035886, 4155.376693495969, 4188.6649068074485, 4196.475440569929, 4199.0, 4775.426948766136, 4777.348571542792, 4800.903981920377, 4804.351412559329, 4809.446913604946, 3567.518385018015, 3583.5699716033982, 3586.103474131467, 3588.067102553329, 3630.6913912317486, 4757.500462451428, 5053.974730126362, 5065.696058236517, 5094.286799848024, 5101.903090835488, 3469.167399824024, 3477.095955051654, 3489.249811290534, 3489.581250249986, 3491.0748651607346, 3516.0330908999717, 3533.611302756746, 3536.29274145172, 3536.3634545781492, 3539.663731945461, 4044.716869819143, 4045.4943132108488, 4068.5524592294823, 4082.857100001486, 4086.6117718816663, 4651.395318608559, 4773.660906155958, 4853.344798452164, 4861.683990540603, 4880.41435027799, 1273.2169715624825, 1275.508929062299, 1285.8714128587253, 1287.2340957130493, 1287.658770425838, 840.1094839470181, 843.700486327345, 895.3866601378077, 915.6037043508702, 916.6883259691737, 4092.751710728197, 4125.29869922114, 4138.193052354762, 4144.274751918402, 4145.709800313949, 4877.585405240523, 4917.754112294371, 4917.87705307363, 4920.704757714549, 4934.55588996992, 4001.419794129835, 4130.925959250556, 4177.582241775798, 4179.561146079618, 4193.161367726406, 2585.1985884375904, 2611.347163209198, 2619.9607005894927, 2623.7638612524966, 2629.815912886118, 4666.766661666903, 4673.696209746356, 4710.882227944328, 4711.175544279738, 4712.6229901607785, 4874.731889746098, 4960.826371076995, 5066.721330326867, 5082.669626474268, 5097.1844504879045, 4640.907181856344, 4673.228917228619, 4694.694844835075, 4696.600788932979, 4711.175544279738, 4915.361003069578, 4925.926111108408, 4953.356063711839, 4954.677945933647, 4955.35580374549, 4652.627789776878, 4829.323894654681, 4856.514348565115, 4894.755262236803, 4920.827771027997, 4746.501617330268, 4747.884247201836, 4750.809967601395, 4752.524747525358, 4753.453352864327, 3610.223801882608, 3615.584207816135, 3617.077645200457, 3638.927221455503, 3646.5077214575695, 5058.192703049843, 5063.924041139312, 5066.620003499678, 5086.160783470686, 5090.974545127251, 4557.0, 4868.659193856396, 4872.707637541759, 4885.2427873679635, 4908.11653902301, 4846.539578740014, 4863.48933362006, 4874.95125048745, 4877.097736918681, 4878.878028049327, 4764.42826860765, 4786.200072957359, 4819.807207711652, 4826.6621336506105, 4835.3714017178945, 4624.44506659203, 4856.053069651525, 4862.31927530139, 4866.8053277868485, 4867.221244600847, 4731.888006318582, 4732.763361831826, 4747.026859493864, 4747.691400059123, 4794.304825800309], "value": 3672.383253426497, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.1891234536453, 713.8251128473523, 714.4034730999615, 812.3501199040768, 812.7968007998, 12509.874901250985, 12974.286414247224, 12983.675408114801, 12997.220166789999, 13001.544945926895, 13100.213987160778, 13119.606411807661, 13178.736425271489, 13219.0, 13263.469461221539, 682.2563405887581, 837.9078301386843, 871.4901782457255, 876.0669886570781, 881.8236352729448, 858.1632907914795, 866.4194989357114, 866.7833041739565, 867.5055218525412, 873.0091346321907, 902.5351943748974, 903.7559858838109, 908.8182363527288, 909.708893154191, 910.3400034974657, 709.7941596936907, 882.2104216726059, 902.5306840442965, 906.2568693671192, 908.209857424042, 674.8582797612507, 676.24936320684, 676.5602358466987, 677.2516369411827, 677.9084823548807, 11135.944320278346, 11145.554177832959, 11209.887901120966, 11219.719507012309, 11225.494852731646, 11328.150388720878, 11647.30116193031, 11840.467178976967, 11891.702707432298, 12228.327441990687, 11140.387278699669, 11216.214864959456, 11311.490982905789, 11332.716682082932, 11398.373089480076, 3970.3250447424007, 3974.18529201513, 3979.323027983481, 4009.4386785850006, 4061.0659548304056, 42268.788656056524, 44236.55763442389, 44933.0, 45086.32370514445, 45317.0, 8651.567421628893, 9120.133587309196, 9508.954015058338, 9753.122219000183, 9849.606015759433, 15546.455874044354, 15639.218039098227, 15654.139022353653, 15762.448314308944, 16643.583910402336, 6920.065791118134, 6930.584164950119, 6945.40964018054, 7058.435325174077, 7117.7152913882865, 3601.099725068733, 3665.6151104134215, 3712.498812660256, 3725.7578257413184, 3839.0978120141745, 2763.433496133288, 2857.985710071436, 2866.3407416294367, 2871.61233233515, 2873.195505258531, 498.56873804159864, 515.0831519894593, 522.2427480153792, 530.3291336459382, 538.2625802650394, 456.70998915688114, 554.9417311182349, 568.2101878389043, 574.8189320364072, 579.5189992306375, 7691.384689224848, 8207.384446166561, 8314.168583141758, 8327.417080804285, 8627.611757470804, 550.6916126968911, 600.6276108812564, 615.8460384903774, 618.8545691762432, 624.7688355308564, 3802.391617341212, 3912.182402643295, 3941.4481972523868, 4015.638592526628, 4020.1356708307853, 48139.518604814206, 48166.27750583744, 49306.75346623244, 49591.256131158065, 49992.50007499878, 43185.78407107944, 44624.553754462686, 44723.776381118536, 44911.326330105076, 45040.3243951341, 38534.42198367027, 38586.80706596449, 39119.0, 41810.0, 42032.36951445731, 8416.537090459839, 8476.788080297794, 8508.74473765788, 8577.785555360917, 8651.134886511298, 28298.0, 28458.146255612366, 28660.85669571639, 29790.8510457455, 30052.84973575118, 37072.443913341864, 37285.81357093306, 37289.62710372861, 37529.81235093807, 38102.428463573626, 10256.487175641338, 10657.89342106569, 10819.67540973772, 10997.725056873642, 11588.246763960316, 12014.579489717818, 12049.879501204876, 12067.094967877269, 12375.814362784746, 12377.814332784836, 11062.944685276521, 11432.256903301259, 11782.764344713229, 11827.112966527373, 11842.703932401415, 10623.628173013907, 10635.521401536795, 11433.828492572784, 11749.29504229749, 11784.646460606196, 11121.332720036824, 11337.886621134014, 11887.76224475523, 11927.463264153308, 11994.220375675553, 9426.670066547638, 9432.292578056537, 9500.192483638968, 9519.428834269966, 9809.460479673686, 8843.46939183651, 9605.087516685904, 10025.0, 10025.398476091457, 10066.899331006889], "value": 6024.170948763595, "unit": "score"}], "name": "dromaeo_css", "value": 6229.088524176969, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 117.0, 116.0, 117.0, 115.0, 115.0, 116.0, 114.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 137.0, 160.0, 213.0, 141.0, 166.0, 160.0, 147.0, 188.0, 136.0], "value": 161.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 165.0, 163.0, 163.0, 164.0, 164.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 148.0, 78.0, 82.0, 78.0, 78.0, 127.0, 78.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 148.0, 93.0, 93.0, 94.0, 118.0, 93.0, 93.0, 118.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 118.0, 118.0, 120.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 148.0, 147.0, 146.0, 146.0, 149.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 69.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "value": 68.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 86.0, 86.0, 89.0, 88.0, 88.0, 86.0, 166.0, 93.0], "value": 96.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 143.0, 139.0, 142.0, 153.0, 140.0, 159.0, 158.0, 140.0], "value": 146.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 181.0, 183.0, 180.0, 180.0, 177.0, 181.0, 182.0, 179.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 71.0, 74.0, 71.0, 75.0, 71.0, 70.0, 69.0, 70.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1623.4, "alertThreshold": 2.0}]} 06:33:36 INFO - Return code: 0 06:33:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:33:36 ERROR - # TBPL SUCCESS # 06:33:36 INFO - Running post-action listener: _resource_record_post_action 06:33:36 INFO - ##### 06:33:36 INFO - ##### Finished run-tests step (success) 06:33:36 INFO - ##### 06:33:36 INFO - Running post-run listener: _resource_record_post_run 06:33:38 INFO - Total resource usage - Wall time: 1199s; CPU: 26.0%; Read bytes: 4096; Write bytes: 522866688; Read time: 12; Write time: 832624 06:33:38 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 234811392; Read time: 0; Write time: 411800 06:33:38 INFO - run-tests - Wall time: 1183s; CPU: 26.0%; Read bytes: 4096; Write bytes: 284176384; Read time: 12; Write time: 419756 06:33:38 INFO - Running post-run listener: _upload_blobber_files 06:33:38 INFO - Blob upload gear active. 06:33:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:33:38 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 06:33:38 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'] 06:33:38 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 06:33:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:33:39 INFO - (blobuploader) - INFO - Done attempting. 06:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:33:40 INFO - (blobuploader) - INFO - Done attempting. 06:33:40 INFO - (blobuploader) - INFO - Iteration through files over. 06:33:40 INFO - Return code: 0 06:33:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:33:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:33:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6d2bddd27456a0149dfc242d5f50d4113436e634fd2992c0c0b06d912499f6c778a4a8358e09b76374395e7c0a563f138693410a27810464673bec7a5ca76d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65289c1f15a9362a08f10c6ec95a1299bf11ceb67ed6064ff68592998dda419135c76198209ba830858a29dc657aa310fab4962b40c523422c40bf2f53d6989b"} 06:33:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:33:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:33:40 INFO - Contents: 06:33:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6d2bddd27456a0149dfc242d5f50d4113436e634fd2992c0c0b06d912499f6c778a4a8358e09b76374395e7c0a563f138693410a27810464673bec7a5ca76d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65289c1f15a9362a08f10c6ec95a1299bf11ceb67ed6064ff68592998dda419135c76198209ba830858a29dc657aa310fab4962b40c523422c40bf2f53d6989b"} 06:33:40 INFO - Running post-run listener: copy_logs_to_upload_dir 06:33:40 INFO - Copying logs to upload dir... 06:33:40 INFO - mkdir: /builds/slave/test/build/upload/logs 06:33:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.116683 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-11 06:33:39.781769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 06:33:39.785172) ========= 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=aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320 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/a6d2bddd27456a0149dfc242d5f50d4113436e634fd2992c0c0b06d912499f6c778a4a8358e09b76374395e7c0a563f138693410a27810464673bec7a5ca76d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65289c1f15a9362a08f10c6ec95a1299bf11ceb67ed6064ff68592998dda419135c76198209ba830858a29dc657aa310fab4962b40c523422c40bf2f53d6989b"} build_url:https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005376 build_url: 'https://queue.taskcluster.net/v1/task/CCfOWzcmTcqTzgQKbh7bXw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6d2bddd27456a0149dfc242d5f50d4113436e634fd2992c0c0b06d912499f6c778a4a8358e09b76374395e7c0a563f138693410a27810464673bec7a5ca76d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65289c1f15a9362a08f10c6ec95a1299bf11ceb67ed6064ff68592998dda419135c76198209ba830858a29dc657aa310fab4962b40c523422c40bf2f53d6989b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 06:33:39.798917) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:33:39.799242) ========= 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=aa52b8aba932b19cc50b5275000001de-1462972381.958520-130499320 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002149 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 06:33:39.878783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 06:33:39.879119) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 06:33:39.879440) ========= ========= Total master_lag: 0.16 =========