builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1466799775.84 results: success (0) buildid: 20160624124158 builduid: d5f8509081c242b5a873a077b3083062 revision: f3e9898727b03f97a286787b8880a39a57358f92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:55.837923) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:55.838484) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:55.838821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:55.854353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:55.854694) ========= 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=6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 13:22:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-06-24 13:22:56 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.398167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:56.267835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:56.268276) ========= 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=6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013650 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:56.319152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:56.319804) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f3e9898727b03f97a286787b8880a39a57358f92 --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 f3e9898727b03f97a286787b8880a39a57358f92 --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=6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 13:22:56,427 truncating revision to first 12 chars 2016-06-24 13:22:56,427 Setting DEBUG logging. 2016-06-24 13:22:56,427 attempt 1/10 2016-06-24 13:22:56,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f3e9898727b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 13:22:56,743 unpacking tar archive at: fx-team-f3e9898727b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681532 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:57.024111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:57.024482) ========= script_repo_revision: f3e9898727b03f97a286787b8880a39a57358f92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:57.024971) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:57.025316) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 13:22:57.034539) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-24 13:22:57.034880) ========= /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=6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:22:57 INFO - MultiFileLogger online at 20160624 13:22:57 in /builds/slave/test 13:22:57 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 13:22:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:22:57 INFO - {'append_to_log': False, 13:22:57 INFO - 'base_work_dir': '/builds/slave/test', 13:22:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:22:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:22:57 INFO - 'branch': 'Fx-Team-Non-PGO', 13:22:57 INFO - 'buildbot_json_path': 'buildprops.json', 13:22:57 INFO - 'config_files': ('talos/linux_config.py',), 13:22:57 INFO - 'default_actions': ('clobber', 13:22:57 INFO - 'read-buildbot-config', 13:22:57 INFO - 'download-and-extract', 13:22:57 INFO - 'populate-webroot', 13:22:57 INFO - 'create-virtualenv', 13:22:57 INFO - 'install', 13:22:57 INFO - 'run-tests'), 13:22:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:22:57 INFO - 'download_minidump_stackwalk': True, 13:22:57 INFO - 'download_symbols': 'ondemand', 13:22:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:22:57 INFO - 'tooltool.py': '/tools/tooltool.py', 13:22:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:22:57 INFO - '/tools/misc-python/virtualenv.py')}, 13:22:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:22:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:22:57 INFO - 'installer_path': 'installer.exe', 13:22:57 INFO - 'log_level': 'info', 13:22:57 INFO - 'log_name': 'talos', 13:22:57 INFO - 'log_to_console': True, 13:22:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:22:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:22:57 INFO - 'opt_config_files': (), 13:22:57 INFO - 'pip_index': False, 13:22:57 INFO - 'sps_profile': False, 13:22:57 INFO - 'sps_profile_interval': 0, 13:22:57 INFO - 'suite': 'dromaeojs', 13:22:57 INFO - 'system_bits': '32', 13:22:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:22:57 INFO - 'title': 'talos-linux64-ix-050', 13:22:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:22:57 INFO - 'use_talos_json': True, 13:22:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:22:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:22:57 INFO - 'work_dir': 'build'} 13:22:57 INFO - ##### 13:22:57 INFO - ##### Running clobber step. 13:22:57 INFO - ##### 13:22:57 INFO - Running pre-action listener: _resource_record_pre_action 13:22:57 INFO - Running main action method: clobber 13:22:57 INFO - rmtree: /builds/slave/test/build 13:22:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:22:57 INFO - Running post-action listener: _resource_record_post_action 13:22:57 INFO - ##### 13:22:57 INFO - ##### Finished clobber step (success) 13:22:57 INFO - ##### 13:22:57 INFO - ##### 13:22:57 INFO - ##### Running read-buildbot-config step. 13:22:57 INFO - ##### 13:22:57 INFO - Running pre-action listener: _resource_record_pre_action 13:22:57 INFO - Running main action method: read_buildbot_config 13:22:57 INFO - Using buildbot properties: 13:22:57 INFO - { 13:22:57 INFO - "project": "", 13:22:57 INFO - "product": "firefox", 13:22:57 INFO - "script_repo_revision": "production", 13:22:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:22:57 INFO - "repository": "", 13:22:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:22:57 INFO - "buildid": "20160624124158", 13:22:57 INFO - "pgo_build": "False", 13:22:57 INFO - "basedir": "/builds/slave/test", 13:22:57 INFO - "buildnumber": 1884, 13:22:57 INFO - "slavename": "talos-linux64-ix-050", 13:22:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:22:57 INFO - "platform": "ubuntu64_hw", 13:22:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:22:57 INFO - "branch": "fx-team", 13:22:57 INFO - "repo_path": "integration/fx-team", 13:22:57 INFO - "revision": "f3e9898727b03f97a286787b8880a39a57358f92", 13:22:57 INFO - "stage_platform": "linux64", 13:22:57 INFO - "builduid": "d5f8509081c242b5a873a077b3083062", 13:22:57 INFO - "slavebuilddir": "test" 13:22:57 INFO - } 13:22:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:22:57 INFO - Running post-action listener: _resource_record_post_action 13:22:57 INFO - ##### 13:22:57 INFO - ##### Finished read-buildbot-config step (success) 13:22:57 INFO - ##### 13:22:57 INFO - ##### 13:22:57 INFO - ##### Running download-and-extract step. 13:22:57 INFO - ##### 13:22:57 INFO - Running pre-action listener: _resource_record_pre_action 13:22:57 INFO - Running main action method: download_and_extract 13:22:57 INFO - mkdir: /builds/slave/test/build/tests 13:22:57 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')]} 13:22:57 INFO - https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:22:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:22:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:22:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:22:58 INFO - Downloaded 1361 bytes. 13:22:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:22:58 INFO - Using the following test package requirements: 13:22:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:22:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:22:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:22:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'jsshell-linux-x86_64.zip'], 13:22:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:22:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:22:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:22:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:22:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:22:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:22:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:22:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:22:58 INFO - https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:22:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:22:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:22:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:22:59 INFO - Downloaded 22710798 bytes. 13:22:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:22:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:23:00 INFO - Return code: 0 13:23:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:23:00 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')]} 13:23:00 INFO - https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:23:01 INFO - Downloaded 22710798 bytes. 13:23:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:23:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:23:02 INFO - Return code: 0 13:23:02 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')]} 13:23:02 INFO - https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:23:03 INFO - Downloaded 14405518 bytes. 13:23:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:23:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:23:04 INFO - Return code: 0 13:23: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')]} 13:23:04 INFO - https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:23:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:23:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:23:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:23:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:23:05 INFO - Downloaded 56255868 bytes. 13:23:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:23:05 INFO - mkdir: /builds/slave/test/properties 13:23:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:23:05 INFO - Writing to file /builds/slave/test/properties/build_url 13:23:05 INFO - Contents: 13:23:05 INFO - build_url:https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:23:06 INFO - Running post-action listener: _resource_record_post_action 13:23:06 INFO - Running post-action listener: set_extra_try_arguments 13:23:06 INFO - ##### 13:23:06 INFO - ##### Finished download-and-extract step (success) 13:23:06 INFO - ##### 13:23:06 INFO - ##### 13:23:06 INFO - ##### Running populate-webroot step. 13:23:06 INFO - ##### 13:23:06 INFO - Running pre-action listener: _resource_record_pre_action 13:23:06 INFO - Running main action method: populate_webroot 13:23:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:23:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:23:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:23:06 INFO - '--tppagecycles', 13:23:06 INFO - '7'], 13:23:06 INFO - 'tests': ['tsvgm']}}, 13:23:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:23:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:23:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:23:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:23:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:23:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['damp', 'tps']}, 13:23:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'tests': ['damp', 'tps']}, 13:23:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['dromaeo_dom']}, 13:23:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:23:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['basic_compositor_video']}, 13:23:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:23:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['a11yr', 13:23:06 INFO - 'ts_paint', 13:23:06 INFO - 'tpaint', 13:23:06 INFO - 'sessionrestore', 13:23:06 INFO - 'sessionrestore_no_auto_restore', 13:23:06 INFO - 'tabpaint']}, 13:23:06 INFO - 'other-e10s': {'tests': ['a11yr', 13:23:06 INFO - 'ts_paint', 13:23:06 INFO - 'tpaint', 13:23:06 INFO - 'sessionrestore', 13:23:06 INFO - 'sessionrestore_no_auto_restore', 13:23:06 INFO - 'tabpaint']}, 13:23:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:23:06 INFO - 'ts_paint', 13:23:06 INFO - 'tpaint', 13:23:06 INFO - 'sessionrestore', 13:23:06 INFO - 'sessionrestore_no_auto_restore', 13:23:06 INFO - 'tabpaint']}, 13:23:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:23:06 INFO - 'ts_paint', 13:23:06 INFO - 'tpaint', 13:23:06 INFO - 'sessionrestore', 13:23:06 INFO - 'sessionrestore_no_auto_restore', 13:23:06 INFO - 'tabpaint']}, 13:23:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['a11yr', 13:23:06 INFO - 'ts_paint', 13:23:06 INFO - 'tpaint', 13:23:06 INFO - 'sessionrestore', 13:23:06 INFO - 'sessionrestore_no_auto_restore', 13:23:06 INFO - 'tabpaint']}, 13:23:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['a11yr', 13:23:06 INFO - 'ts_paint', 13:23:06 INFO - 'tpaint', 13:23:06 INFO - 'sessionrestore', 13:23:06 INFO - 'sessionrestore_no_auto_restore', 13:23:06 INFO - 'tabpaint']}, 13:23:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['tsvgx', 13:23:06 INFO - 'tsvgr_opacity', 13:23:06 INFO - 'tart', 13:23:06 INFO - 'tscrollx', 13:23:06 INFO - 'cart']}, 13:23:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:23:06 INFO - 'tsvgr_opacity', 13:23:06 INFO - 'tart', 13:23:06 INFO - 'tscrollx', 13:23:06 INFO - 'cart']}, 13:23:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'talos_options': ['--disable-e10s'], 13:23:06 INFO - 'tests': ['tp5o']}, 13:23:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'tests': ['tp5o']}, 13:23:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'talos_options': ['--disable-e10s', 13:23:06 INFO - '--xperf_path', 13:23:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:06 INFO - 'tests': ['tp5n']}, 13:23:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:23:06 INFO - 'talos_options': ['--xperf_path', 13:23:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:23:06 INFO - 'tests': ['tp5n']}}, 13:23:06 INFO - 'talos.zip': {'path': '', 13:23:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:23:06 INFO - Running post-action listener: _resource_record_post_action 13:23:06 INFO - ##### 13:23:06 INFO - ##### Finished populate-webroot step (success) 13:23:06 INFO - ##### 13:23:06 INFO - ##### 13:23:06 INFO - ##### Running create-virtualenv step. 13:23:06 INFO - ##### 13:23:06 INFO - Running pre-action listener: _resource_record_pre_action 13:23:06 INFO - Running main action method: create_virtualenv 13:23:06 INFO - Creating virtualenv /builds/slave/test/build/venv 13:23:06 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 13:23:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:23:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:23:06 INFO - Using real prefix '/usr' 13:23:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:23:06 INFO - Installing distribute.............................................................................................................................................................................................done. 13:23:08 INFO - Installing pip.................done. 13:23:08 INFO - Return code: 0 13:23:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:08 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 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:08 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 13:23:08 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 13:23:08 INFO - Using env: {'DISPLAY': ':0', 13:23:08 INFO - 'HOME': '/home/cltbld', 13:23:08 INFO - 'LANG': 'en_US.UTF-8', 13:23:08 INFO - 'LANGUAGE': 'en_US:en', 13:23:08 INFO - 'LOGNAME': 'cltbld', 13:23:08 INFO - 'MAIL': '/var/mail/cltbld', 13:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:08 INFO - 'MOZ_NO_REMOTE': '1', 13:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:08 INFO - 'NO_EM_RESTART': '1', 13:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:08 INFO - 'PWD': '/builds/slave/test', 13:23:08 INFO - 'SHELL': '/bin/bash', 13:23:08 INFO - 'SHLVL': '1', 13:23:08 INFO - 'TERM': 'linux', 13:23:08 INFO - 'TMOUT': '86400', 13:23:08 INFO - 'USER': 'cltbld', 13:23:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:08 INFO - '_': '/tools/buildbot/bin/python'} 13:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:09 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 13:23:09 INFO - Cleaning up... 13:23:09 INFO - Return code: 0 13:23:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:23:09 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')]} 13:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:09 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')]} 13:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:09 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:09 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>=3.1.1'] in /builds/slave/test/build 13:23:09 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>=3.1.1 13:23:09 INFO - Using env: {'DISPLAY': ':0', 13:23:09 INFO - 'HOME': '/home/cltbld', 13:23:09 INFO - 'LANG': 'en_US.UTF-8', 13:23:09 INFO - 'LANGUAGE': 'en_US:en', 13:23:09 INFO - 'LOGNAME': 'cltbld', 13:23:09 INFO - 'MAIL': '/var/mail/cltbld', 13:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:09 INFO - 'MOZ_NO_REMOTE': '1', 13:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:09 INFO - 'NO_EM_RESTART': '1', 13:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:09 INFO - 'PWD': '/builds/slave/test', 13:23:09 INFO - 'SHELL': '/bin/bash', 13:23:09 INFO - 'SHLVL': '1', 13:23:09 INFO - 'TERM': 'linux', 13:23:09 INFO - 'TMOUT': '86400', 13:23:09 INFO - 'USER': 'cltbld', 13:23:09 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:09 INFO - '_': '/tools/buildbot/bin/python'} 13:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:09 INFO - Downloading/unpacking psutil>=3.1.1 13:23:09 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 13:23:09 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 13:23:09 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 13:23:09 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 13:23:09 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 13:23:09 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 13:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:23:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:11 INFO - Installing collected packages: psutil 13:23:11 INFO - Running setup.py install for psutil 13:23:11 INFO - building 'psutil._psutil_linux' extension 13:23:11 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 13:23:11 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 13:23:11 INFO - building 'psutil._psutil_posix' extension 13:23:11 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 13:23:11 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 13:23:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:23:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:23:11 INFO - Successfully installed psutil 13:23:11 INFO - Cleaning up... 13:23:11 INFO - Return code: 0 13:23:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:11 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:11 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.3'] in /builds/slave/test/build 13:23:11 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.3 13:23:11 INFO - Using env: {'DISPLAY': ':0', 13:23:11 INFO - 'HOME': '/home/cltbld', 13:23:11 INFO - 'LANG': 'en_US.UTF-8', 13:23:11 INFO - 'LANGUAGE': 'en_US:en', 13:23:11 INFO - 'LOGNAME': 'cltbld', 13:23:11 INFO - 'MAIL': '/var/mail/cltbld', 13:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:11 INFO - 'MOZ_NO_REMOTE': '1', 13:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:11 INFO - 'NO_EM_RESTART': '1', 13:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:11 INFO - 'PWD': '/builds/slave/test', 13:23:11 INFO - 'SHELL': '/bin/bash', 13:23:11 INFO - 'SHLVL': '1', 13:23:11 INFO - 'TERM': 'linux', 13:23:11 INFO - 'TMOUT': '86400', 13:23:11 INFO - 'USER': 'cltbld', 13:23:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:11 INFO - '_': '/tools/buildbot/bin/python'} 13:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:23:12 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 13:23:12 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 13:23:12 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 13:23:12 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 13:23:12 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 13:23:12 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 13:23:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:23:14 INFO - Installing collected packages: mozsystemmonitor 13:23:14 INFO - Running setup.py install for mozsystemmonitor 13:23:14 INFO - Successfully installed mozsystemmonitor 13:23:14 INFO - Cleaning up... 13:23:14 INFO - Return code: 0 13:23:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:23:14 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')]} 13:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:14 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')]} 13:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:14 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:14 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==2.5.1'] in /builds/slave/test/build 13:23:14 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==2.5.1 13:23:14 INFO - Using env: {'DISPLAY': ':0', 13:23:14 INFO - 'HOME': '/home/cltbld', 13:23:14 INFO - 'LANG': 'en_US.UTF-8', 13:23:14 INFO - 'LANGUAGE': 'en_US:en', 13:23:14 INFO - 'LOGNAME': 'cltbld', 13:23:14 INFO - 'MAIL': '/var/mail/cltbld', 13:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:14 INFO - 'MOZ_NO_REMOTE': '1', 13:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:14 INFO - 'NO_EM_RESTART': '1', 13:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:14 INFO - 'PWD': '/builds/slave/test', 13:23:14 INFO - 'SHELL': '/bin/bash', 13:23:14 INFO - 'SHLVL': '1', 13:23:14 INFO - 'TERM': 'linux', 13:23:14 INFO - 'TMOUT': '86400', 13:23:14 INFO - 'USER': 'cltbld', 13:23:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:14 INFO - '_': '/tools/buildbot/bin/python'} 13:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:14 INFO - Downloading/unpacking jsonschema==2.5.1 13:23:14 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 13:23:14 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 13:23:14 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 13:23:14 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 13:23:14 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 13:23:14 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 13:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 13:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:23:16 INFO - warning: no files found matching '*.txt' 13:23:16 INFO - no previously-included directories found matching 'build' 13:23:16 INFO - no previously-included directories found matching 'dist' 13:23:16 INFO - no previously-included directories found matching '.git*' 13:23:16 INFO - Installing collected packages: jsonschema, functools32 13:23:16 INFO - Running setup.py install for functools32 13:23:16 INFO - warning: no files found matching '*.txt' 13:23:16 INFO - no previously-included directories found matching 'build' 13:23:16 INFO - no previously-included directories found matching 'dist' 13:23:16 INFO - no previously-included directories found matching '.git*' 13:23:16 INFO - Successfully installed jsonschema functools32 13:23:16 INFO - Cleaning up... 13:23:16 INFO - Return code: 0 13:23:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:23:16 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')]} 13:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:16 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')]} 13:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:16 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 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:16 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 13:23:16 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 13:23:16 INFO - Using env: {'DISPLAY': ':0', 13:23:16 INFO - 'HOME': '/home/cltbld', 13:23:16 INFO - 'LANG': 'en_US.UTF-8', 13:23:16 INFO - 'LANGUAGE': 'en_US:en', 13:23:16 INFO - 'LOGNAME': 'cltbld', 13:23:16 INFO - 'MAIL': '/var/mail/cltbld', 13:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:16 INFO - 'MOZ_NO_REMOTE': '1', 13:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:16 INFO - 'NO_EM_RESTART': '1', 13:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:16 INFO - 'PWD': '/builds/slave/test', 13:23:16 INFO - 'SHELL': '/bin/bash', 13:23:16 INFO - 'SHLVL': '1', 13:23:16 INFO - 'TERM': 'linux', 13:23:16 INFO - 'TMOUT': '86400', 13:23:16 INFO - 'USER': 'cltbld', 13:23:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:16 INFO - '_': '/tools/buildbot/bin/python'} 13:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:16 INFO - Downloading/unpacking blobuploader==1.2.4 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 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 13:23:16 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 13:23:18 INFO - Downloading blobuploader-1.2.4.tar.gz 13:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:23:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:23:18 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 13:23:18 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 13:23:18 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 13:23:18 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 13:23:18 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 13:23:18 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 13:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:23:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:23:19 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 13:23:19 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 13:23:19 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 13:23:19 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 13:23:19 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 13:23:19 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 13:23:19 INFO - Downloading docopt-0.6.1.tar.gz 13:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:23:19 INFO - Installing collected packages: blobuploader, requests, docopt 13:23:19 INFO - Running setup.py install for blobuploader 13:23:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:23:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:23:19 INFO - Running setup.py install for requests 13:23:19 INFO - Running setup.py install for docopt 13:23:20 INFO - Successfully installed blobuploader requests docopt 13:23:20 INFO - Cleaning up... 13:23:20 INFO - Return code: 0 13:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23: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')]} 13:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23: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')]} 13:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:20 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 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:20 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 13:23:20 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 13:23:20 INFO - Using env: {'DISPLAY': ':0', 13:23:20 INFO - 'HOME': '/home/cltbld', 13:23:20 INFO - 'LANG': 'en_US.UTF-8', 13:23:20 INFO - 'LANGUAGE': 'en_US:en', 13:23:20 INFO - 'LOGNAME': 'cltbld', 13:23:20 INFO - 'MAIL': '/var/mail/cltbld', 13:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:20 INFO - 'MOZ_NO_REMOTE': '1', 13:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:20 INFO - 'NO_EM_RESTART': '1', 13:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:20 INFO - 'PWD': '/builds/slave/test', 13:23:20 INFO - 'SHELL': '/bin/bash', 13:23:20 INFO - 'SHLVL': '1', 13:23:20 INFO - 'TERM': 'linux', 13:23:20 INFO - 'TMOUT': '86400', 13:23:20 INFO - 'USER': 'cltbld', 13:23:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:20 INFO - '_': '/tools/buildbot/bin/python'} 13:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:20 INFO - Running setup.py (path:/tmp/pip-UNXiC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:20 INFO - Running setup.py (path:/tmp/pip-gSFYBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:20 INFO - Running setup.py (path:/tmp/pip-gqOEFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:20 INFO - Running setup.py (path:/tmp/pip-Zwb1gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:20 INFO - Running setup.py (path:/tmp/pip-CL1P_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:20 INFO - Running setup.py (path:/tmp/pip-wSgpS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:20 INFO - Running setup.py (path:/tmp/pip-U0ihJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:20 INFO - Running setup.py (path:/tmp/pip-_iRxX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:20 INFO - Running setup.py (path:/tmp/pip-tuMyQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:21 INFO - Running setup.py (path:/tmp/pip-qcqhXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:21 INFO - Running setup.py (path:/tmp/pip-9h4mvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:21 INFO - Running setup.py (path:/tmp/pip-2FMiYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:21 INFO - Running setup.py (path:/tmp/pip-BKEsfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:21 INFO - Running setup.py (path:/tmp/pip-aal9D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:21 INFO - Running setup.py (path:/tmp/pip-yrTU70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:21 INFO - Running setup.py (path:/tmp/pip-xN0qUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:21 INFO - Running setup.py (path:/tmp/pip-_Aziq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:23:21 INFO - Running setup.py install for manifestparser 13:23:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:23:21 INFO - Running setup.py install for mozcrash 13:23:21 INFO - Running setup.py install for mozdebug 13:23:21 INFO - Running setup.py install for mozdevice 13:23:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:23:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Running setup.py install for mozfile 13:23:22 INFO - Running setup.py install for mozhttpd 13:23:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Running setup.py install for mozinfo 13:23:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Running setup.py install for mozInstall 13:23:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Running setup.py install for mozleak 13:23:22 INFO - Running setup.py install for mozlog 13:23:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Running setup.py install for moznetwork 13:23:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Running setup.py install for mozprocess 13:23:22 INFO - Running setup.py install for mozprofile 13:23:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:23:22 INFO - Running setup.py install for mozrunner 13:23:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:23:23 INFO - Running setup.py install for mozscreenshot 13:23:23 INFO - Running setup.py install for moztest 13:23:23 INFO - Running setup.py install for mozversion 13:23:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:23:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:23:23 INFO - Cleaning up... 13:23:23 INFO - Return code: 0 13:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:23 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 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:23 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 13:23:23 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 13:23:23 INFO - Using env: {'DISPLAY': ':0', 13:23:23 INFO - 'HOME': '/home/cltbld', 13:23:23 INFO - 'LANG': 'en_US.UTF-8', 13:23:23 INFO - 'LANGUAGE': 'en_US:en', 13:23:23 INFO - 'LOGNAME': 'cltbld', 13:23:23 INFO - 'MAIL': '/var/mail/cltbld', 13:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:23 INFO - 'MOZ_NO_REMOTE': '1', 13:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:23 INFO - 'NO_EM_RESTART': '1', 13:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:23 INFO - 'PWD': '/builds/slave/test', 13:23:23 INFO - 'SHELL': '/bin/bash', 13:23:23 INFO - 'SHLVL': '1', 13:23:23 INFO - 'TERM': 'linux', 13:23:23 INFO - 'TMOUT': '86400', 13:23:23 INFO - 'USER': 'cltbld', 13:23:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:23 INFO - '_': '/tools/buildbot/bin/python'} 13:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:23:23 INFO - Running setup.py (path:/tmp/pip-P7RbrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:23:23 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)) 13:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:23:23 INFO - Running setup.py (path:/tmp/pip-ozlF2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:23:23 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)) 13:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:23:23 INFO - Running setup.py (path:/tmp/pip-V2FE_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:23:23 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)) 13:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:23:23 INFO - Running setup.py (path:/tmp/pip-xu9ETg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:23:23 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)) 13:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:23:23 INFO - Running setup.py (path:/tmp/pip-1LVxJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:23:23 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)) 13:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:23:23 INFO - Running setup.py (path:/tmp/pip-RiJY81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:23:24 INFO - Running setup.py (path:/tmp/pip-f2dBeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:23:24 INFO - Running setup.py (path:/tmp/pip-XIiRjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:23:24 INFO - Running setup.py (path:/tmp/pip-v2ur29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:23:24 INFO - Running setup.py (path:/tmp/pip-29sBGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:23:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:23:24 INFO - Running setup.py (path:/tmp/pip-BIWtr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:23:24 INFO - Running setup.py (path:/tmp/pip-KBiInG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:23:24 INFO - Running setup.py (path:/tmp/pip-w7vzyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:23:24 INFO - Running setup.py (path:/tmp/pip-E4gb9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:24 INFO - Running setup.py (path:/tmp/pip-TlKTXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:23:24 INFO - Running setup.py (path:/tmp/pip-360S08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:23:24 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)) 13:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:23:24 INFO - Running setup.py (path:/tmp/pip-_njpfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:23:24 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)) 13:23:24 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)) 13:23:24 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)) 13:23:24 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)) 13:23:24 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)) 13:23:24 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)) 13:23:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:26 INFO - Downloading blessings-1.6.tar.gz 13:23:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:23:26 INFO - Installing collected packages: blessings 13:23:26 INFO - Running setup.py install for blessings 13:23:26 INFO - Successfully installed blessings 13:23:26 INFO - Cleaning up... 13:23:26 INFO - Return code: 0 13:23:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:27 INFO - Reading from file tmpfile_stdout 13:23:27 INFO - Current package versions: 13:23:27 INFO - argparse == 1.2.1 13:23:27 INFO - blessings == 1.6 13:23:27 INFO - blobuploader == 1.2.4 13:23:27 INFO - docopt == 0.6.1 13:23:27 INFO - functools32 == 3.2.3-2 13:23:27 INFO - jsonschema == 2.5.1 13:23:27 INFO - manifestparser == 1.1 13:23:27 INFO - mozInstall == 1.12 13:23:27 INFO - mozcrash == 0.17 13:23:27 INFO - mozdebug == 0.1 13:23:27 INFO - mozdevice == 0.48 13:23:27 INFO - mozfile == 1.2 13:23:27 INFO - mozhttpd == 0.7 13:23:27 INFO - mozinfo == 0.9 13:23:27 INFO - mozleak == 0.1 13:23:27 INFO - mozlog == 3.2 13:23:27 INFO - moznetwork == 0.27 13:23:27 INFO - mozprocess == 0.22 13:23:27 INFO - mozprofile == 0.28 13:23:27 INFO - mozrunner == 6.11 13:23:27 INFO - mozscreenshot == 0.1 13:23:27 INFO - mozsystemmonitor == 0.3 13:23:27 INFO - moztest == 0.7 13:23:27 INFO - mozversion == 1.4 13:23:27 INFO - psutil == 3.1.1 13:23:27 INFO - requests == 1.2.3 13:23:27 INFO - wsgiref == 0.1.2 13:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 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 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:27 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 13:23:27 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 13:23:27 INFO - Using env: {'DISPLAY': ':0', 13:23:27 INFO - 'HOME': '/home/cltbld', 13:23:27 INFO - 'LANG': 'en_US.UTF-8', 13:23:27 INFO - 'LANGUAGE': 'en_US:en', 13:23:27 INFO - 'LOGNAME': 'cltbld', 13:23:27 INFO - 'MAIL': '/var/mail/cltbld', 13:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:27 INFO - 'MOZ_NO_REMOTE': '1', 13:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:27 INFO - 'NO_EM_RESTART': '1', 13:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:27 INFO - 'PWD': '/builds/slave/test', 13:23:27 INFO - 'SHELL': '/bin/bash', 13:23:27 INFO - 'SHLVL': '1', 13:23:27 INFO - 'TERM': 'linux', 13:23:27 INFO - 'TMOUT': '86400', 13:23:27 INFO - 'USER': 'cltbld', 13:23:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:27 INFO - '_': '/tools/buildbot/bin/python'} 13:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 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)) 13:23:27 INFO - Cleaning up... 13:23:27 INFO - Return code: 0 13:23:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 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 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:27 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 13:23:27 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 13:23:27 INFO - Using env: {'DISPLAY': ':0', 13:23:27 INFO - 'HOME': '/home/cltbld', 13:23:27 INFO - 'LANG': 'en_US.UTF-8', 13:23:27 INFO - 'LANGUAGE': 'en_US:en', 13:23:27 INFO - 'LOGNAME': 'cltbld', 13:23:27 INFO - 'MAIL': '/var/mail/cltbld', 13:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:27 INFO - 'MOZ_NO_REMOTE': '1', 13:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:27 INFO - 'NO_EM_RESTART': '1', 13:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:27 INFO - 'PWD': '/builds/slave/test', 13:23:27 INFO - 'SHELL': '/bin/bash', 13:23:27 INFO - 'SHLVL': '1', 13:23:27 INFO - 'TERM': 'linux', 13:23:27 INFO - 'TMOUT': '86400', 13:23:27 INFO - 'USER': 'cltbld', 13:23:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:27 INFO - '_': '/tools/buildbot/bin/python'} 13:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:23:27 INFO - Cleaning up... 13:23:27 INFO - Return code: 0 13:23:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:23:27 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 0x7f81bc254f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeb350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, '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': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', '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 13:23:27 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 13:23:27 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 13:23:27 INFO - Using env: {'DISPLAY': ':0', 13:23:27 INFO - 'HOME': '/home/cltbld', 13:23:27 INFO - 'LANG': 'en_US.UTF-8', 13:23:27 INFO - 'LANGUAGE': 'en_US:en', 13:23:27 INFO - 'LOGNAME': 'cltbld', 13:23:27 INFO - 'MAIL': '/var/mail/cltbld', 13:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:27 INFO - 'MOZ_NO_REMOTE': '1', 13:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:27 INFO - 'NO_EM_RESTART': '1', 13:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:27 INFO - 'PWD': '/builds/slave/test', 13:23:27 INFO - 'SHELL': '/bin/bash', 13:23:27 INFO - 'SHLVL': '1', 13:23:27 INFO - 'TERM': 'linux', 13:23:27 INFO - 'TMOUT': '86400', 13:23:27 INFO - 'USER': 'cltbld', 13:23:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:27 INFO - '_': '/tools/buildbot/bin/python'} 13:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:23:27 INFO - Downloading/unpacking flake8 13:23:27 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 13:23:27 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 13:23:27 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 13:23:27 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 13:23:27 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 13:23:27 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 13:23:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:23:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:23:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23: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 13:23:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:23:30 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 13:23:30 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 13:23:30 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 13:23:30 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 13:23:30 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 13:23:30 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 13:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:23:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:30 INFO - no previously-included directories found matching 'docs/_build' 13:23:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:23:30 INFO - Running setup.py install for pep8 13:23:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:23:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:23:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:23:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:23:30 INFO - no previously-included directories found matching 'docs/_build' 13:23:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:23:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:23:30 INFO - Cleaning up... 13:23:30 INFO - Return code: 0 13:23:30 INFO - Running post-action listener: _resource_record_post_action 13:23:30 INFO - Running post-action listener: _start_resource_monitoring 13:23:30 INFO - Starting resource monitoring. 13:23:30 INFO - ##### 13:23:30 INFO - ##### Finished create-virtualenv step (success) 13:23:30 INFO - ##### 13:23:30 INFO - ##### 13:23:30 INFO - ##### Running install step. 13:23:30 INFO - ##### 13:23:30 INFO - Running pre-action listener: _resource_record_pre_action 13:23:30 INFO - Running main action method: install 13:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:23:30 INFO - Reading from file tmpfile_stdout 13:23:30 INFO - Detecting whether we're running mozinstall >=1.0... 13:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:23:30 INFO - Reading from file tmpfile_stdout 13:23:30 INFO - Output received: 13:23:30 INFO - Usage: mozinstall [options] installer 13:23:30 INFO - Options: 13:23:30 INFO - -h, --help show this help message and exit 13:23:30 INFO - -d DEST, --destination=DEST 13:23:30 INFO - Directory to install application into. [default: 13:23:30 INFO - "/builds/slave/test"] 13:23:30 INFO - --app=APP Application being installed. [default: firefox] 13:23:30 INFO - mkdir: /builds/slave/test/build/application 13:23:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:23:47 INFO - Reading from file tmpfile_stdout 13:23:47 INFO - Output received: 13:23:47 INFO - /builds/slave/test/build/application/firefox/firefox 13:23:47 INFO - Running post-action listener: _resource_record_post_action 13:23:47 INFO - ##### 13:23:47 INFO - ##### Finished install step (success) 13:23:47 INFO - ##### 13:23:47 INFO - ##### 13:23:47 INFO - ##### Running run-tests step. 13:23:47 INFO - ##### 13:23:47 INFO - Running pre-action listener: _resource_record_pre_action 13:23:47 INFO - Running main action method: run_tests 13:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:23:47 INFO - Python 2.7.3 13:23:47 INFO - Return code: 0 13:23:47 INFO - grabbing minidump binary from tooltool 13:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:23:47 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 0x2b7a1c0>, '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 0x2b7b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:23:47 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 13:23:47 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 13:23:47 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 13:23:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:23:47 INFO - Return code: 0 13:23:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:23:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:23:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:23:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:23:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:23:48 INFO - Return code: 0 13:23:48 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/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 13:23:48 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/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 13:23:48 INFO - Using env: {'DISPLAY': ':0', 13:23:48 INFO - 'HOME': '/home/cltbld', 13:23:48 INFO - 'LANG': 'en_US.UTF-8', 13:23:48 INFO - 'LANGUAGE': 'en_US:en', 13:23:48 INFO - 'LOGNAME': 'cltbld', 13:23:48 INFO - 'MAIL': '/var/mail/cltbld', 13:23:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:23:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:23:48 INFO - 'MOZ_NO_REMOTE': '1', 13:23:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:23:48 INFO - 'NO_EM_RESTART': '1', 13:23:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:23:48 INFO - 'PWD': '/builds/slave/test', 13:23:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:23:48 INFO - 'SHELL': '/bin/bash', 13:23:48 INFO - 'SHLVL': '1', 13:23:48 INFO - 'TERM': 'linux', 13:23:48 INFO - 'TMOUT': '86400', 13:23:48 INFO - 'USER': 'cltbld', 13:23:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188', 13:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:23:48 INFO - '_': '/tools/buildbot/bin/python'} 13:23:48 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/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 13:23:48 INFO - mozversion application_buildid: 20160624124158 13:23:48 INFO - mozversion application_changeset: f3e9898727b03f97a286787b8880a39a57358f92 13:23:48 INFO - mozversion application_display_name: Nightly 13:23:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:23:48 INFO - mozversion application_name: Firefox 13:23:48 INFO - mozversion application_remotingname: firefox 13:23:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:23:48 INFO - mozversion application_vendor: Mozilla 13:23:48 INFO - mozversion application_version: 50.0a1 13:23:48 INFO - mozversion platform_buildid: 20160624124158 13:23:48 INFO - mozversion platform_changeset: f3e9898727b03f97a286787b8880a39a57358f92 13:23:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:23:48 INFO - mozversion platform_version: 50.0a1 13:23:48 INFO - using testdate: 1466799828 13:23:48 INFO - actual date: 1466799828 13:23:48 INFO - starting webserver on 'localhost:36296' 13:23:48 INFO - SUITE-START | Running 2 tests 13:23:48 INFO - TEST-START | dromaeo_css 13:23:48 INFO - operating with platform_type : linux_ 13:23:48 INFO - Initialising browser for dromaeo_css test... 13:23:48 INFO - TEST-INFO | started process 14358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_a8kOZ/profile http://localhost:36296/getInfo.html) 13:23:52 INFO - PROCESS | 14358 | __metrics Screen width/height:1600/1200 13:23:52 INFO - PROCESS | 14358 | colorDepth:24 13:23:52 INFO - PROCESS | 14358 | Browser inner width/height: 1024/697 13:23:52 INFO - PROCESS | 14358 | __metrics 13:23:53 INFO - PROCESS | 14358 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:23:54 INFO - TEST-INFO | 14358: exit 0 13:23:54 INFO - Browser initialized. 13:23:54 INFO - Running cycle 1/1 for dromaeo_css test... 13:23:54 INFO - TEST-INFO | started process 14438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_a8kOZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:06 INFO - PROCESS | 14438 | RSS: Main: 175702016 13:24:06 INFO - PROCESS | 14438 | 13:24:57 INFO - PROCESS | 14438 | 1466799897549 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] 13:27:10 INFO - PROCESS | 14438 | Cycle 1(1): loaded http://localhost:36296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36296/tests/dromaeo/cssquery-ext.html) 13:27:11 INFO - PROCESS | 14438 | RSS: Main: 294289408 13:27:11 INFO - PROCESS | 14438 | 13:30:14 INFO - PROCESS | 14438 | Cycle 1(1): loaded http://localhost:36296/tests/dromaeo/cssquery-ext.html (next: http://localhost:36296/tests/dromaeo/cssquery-jquery.html) 13:30:14 INFO - PROCESS | 14438 | RSS: Main: 255860736 13:30:14 INFO - PROCESS | 14438 | 13:33:17 INFO - PROCESS | 14438 | Cycle 1(1): loaded http://localhost:36296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36296/tests/dromaeo/cssquery-mootools.html) 13:33:17 INFO - PROCESS | 14438 | RSS: Main: 261083136 13:33:17 INFO - PROCESS | 14438 | 13:36:19 INFO - PROCESS | 14438 | Cycle 1(1): loaded http://localhost:36296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36296/tests/dromaeo/cssquery-prototype.html) 13:36:20 INFO - PROCESS | 14438 | RSS: Main: 252346368 13:36:20 INFO - PROCESS | 14438 | 13:39:23 INFO - PROCESS | 14438 | Cycle 1(1): loaded http://localhost:36296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36296/tests/dromaeo/cssquery-yui.html) 13:39:24 INFO - PROCESS | 14438 | RSS: Main: 232869888 13:39:24 INFO - PROCESS | 14438 | 13:42:26 INFO - PROCESS | 14438 | Cycle 1(1): loaded http://localhost:36296/tests/dromaeo/cssquery-yui.html (next: http://localhost:36296/tests/dromaeo/cssquery-dojo.html) 13:42:27 INFO - PROCESS | 14438 | RSS: Main: 287485952 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | __start_tp_report 13:42:27 INFO - PROCESS | 14438 | _x_x_mozilla_page_load 13:42:27 INFO - PROCESS | 14438 | _x_x_mozilla_page_load_details 13:42:27 INFO - PROCESS | 14438 | |i|pagename|runs| 13:42:27 INFO - PROCESS | 14438 | |0;dojo.html;2644.153870761356;2651.4431969286447;2680.9597856032165;2692.8788204530792;2696.8651567421625;4626.930596041062;4696.131215725093;4705.082508910759;4797.208460604001;4865.878353041176;4764.356811830402;4765.428148622162;4766.3088852116425;4797.40032495938;4810.110129626013;4327.437433133696;4343.370211319357;4369.366441865927;4465.620422264112;4551.658625603093;4464.776761161929;4485.932711009337;4500.842470513533;4517.774111294422;4546.408966834323;4309.1381723655395;4355.586219309161;4357.477102747691;4392.516823149451;4410.3825464435;4381.715188512769;4392.560743925614;4399.23013472641;4431.357453169305;4469.016816300409;4411.867643970686;4430.645548356156;4446.421965144543;4446.533114023014;4489.887752806173;4678.3216433616935;4770.0698363819065;4810.5670489656095;4810.855674329776;4821.445533763627;5196.324477817897;5205.869853253661;5237.528622423962;5240.816571419982;5265.289185959923;5265.7893684252585;5279.392869819982;5299.841004769824;5300.416954135042;5302.125149350352;4636.11913736389;4698.9530104698515;4767.380240568704;4768.9523104769205;4779.904401911942;5285.995660824431;5331.600129990266;5387.4073851876265;5388.057090009311;5392.595555333366;4939.135651261015;5100.158473851847;5153.123968925292;5157.303763991888;5157.355330583677;5062.139436295838;5114.769835357418;5116.411612664591;5133.4096578893905;5149.356330458692;5103.515166059218;5114.514121158484;5125.56432703217;5131.461196574381;5179.663321884065;4934.235193545006;4993.350864387607;5107.182850743863;5122.026814905156;5136.563392111638;4346.695731298779;4358.193734159191;4372.584604462571;4410.779461026936;4433.357163211316;3815.3513902636064;3820.9808950955066;3825.2731980923536;3860.3051450738576;3866.323393406199;4286.142771445723;4388.912221755547;4391.231534481453;4401.364671712859;4443.822247110144;5064.518870707277;5108.514691104339;5130.948690513047;5207.92188117171;5212.973935130376;4402.185595664748;4405.163019026375;4406.481998882463;4410.316400957857;4443.400140980991;4650.627949764011;4654.720716757005;4659.2312268475325;4662.044280922402;4689.085628302449;4652.534746525321;4703.31801888731;4756.357891684716;4769.785359658893;4786.832460863853;5079.263506791568;5112.769925353442;5123.154679477844;5124.923126153036;5172.818951336685;4655.3947986761505;4761.666683332133;4761.928571071506;4772.0694464580465;4823.107725070873;4948.480409557089;4982.676126051795;4990.750462476934;5015.7492125392855;5021.246812978083;5052.595792336678;5067.442581315979;5069.163588008085;5072.289879416959;5089.440161582297;4815.711057336431;4944.3572335596145;4951.579115775199;4967.40391153064;4972.266047490156;4969.900601988013;4996.200607902718;5041;5051.974740126423;5090.821821236239;4967.205247160437;4969.204927211629;5021.799128034984;5027.974860125676;5036.345275114359;4872.634552408513;4940.654154209315;5003.44962054181;5122.026814905156;5140.100482415637;4789.592884604847;4835.0571638531555;4852.8301509447;4880.145974454385;4918.336024636628 13:42:27 INFO - PROCESS | 14438 | |1;ext.html;536.1476381285627;562.1202817590473;569.6468189722373;570.4979617936216;604.4469310580818;26165.34586635335;28157.718422815793;28234;28242.576361354597;38383.23233535328;36206;39981.600183998155;39996.80001599988;40023.799881000625;40107.59892401075;7758.728444504443;7909.96045019777;7910.920890791105;7917.208279172066;7922.405819563527;7550.6224688765615;7713.73001944932;7805.024371953506;9807.803843923117;10147.746306342327;10193;10251.743706407326;10267.075963163314;10282.228832837567;10284.280100392938;10099.747506312327;10165.288429809953;10169.898301016969;10170.949145254226;10175.949120254425;7434.628268586549;9812.116909478182;10219.846702299472;10224.693259202237;10249.231307651882;38000;39200;39319.60680393188;39360.21279574421;39403;3045.3604743004;3318.1870441741685;3531.876384326536;3549.1836877518317;3677.4667673187505;29534.70465295341;30032.8498357509;30368.54447183294;30566.694333056606;31429;3402.9829850850833;3445.9483107753404;3451.475782793509;3528.1708798432346;3560.893173204808;161381;162861;163984;164090.17954910267;164935;56245.43754562402;56822.43177568171;56979.715101424226;57068.714656426455;57099.42900570941;33945.32109357799;33980.150496237795;33999.150021249174;36254.637453625124;36383.81808090943;16001.439949601709;16165.27256273447;16259.430919917746;16263.105529195771;16266.105364205083;9590.760230994281;12141;12212.511499539918;12217.022638188924;12217.877821221851;18861.434156975312;19512.609747805247;19590.804091958897;20235.595288094155;20342.593148136955;7290.890636640454;7292.96353518229;7426.74006409773;7439.293267139613;7521.586312752851;831.9542425166553;910.913463220993;962.841131213356;963.5808423335732;999.6950929966284;25195.874020630145;26137.31669189365;26612;26612.201633951012;27325.590116148273;948.8624149498422;981.215027977615;987.3335498538602;1032.5972870580479;1099.8130317845985;14110.85889141116;14415.279236038155;14719.116852988855;14859.2570371481;14877.851221487646;389108;389474;393045;393785;394109;33361.165970850925;50059;50060.249096263586;50066.499335006185;50138.24792628113;1089.3137323486312;1183.3846399872018;1184.437392238697;1196.0670676872053;1233.3216730798204;26908.461830763667;27457.31356716018;28354.85822570874;28646.57030144591;29260.707392926648;45761.77119114383;46271.30593041174;46466.30300545562;46472.83817904444;46517.53482465132;354167;356962;357925;358046;358225;32396.190095247806;37659.24681506409;39023.804880976546;39517;41778.79110604428;41258.793706031276;41501.58498414977;41533.58466415418;41799.58200417957;42420;35292.82353588318;35395.64604353924;35653.82173089222;35904.82047589745;36299.45550816793;35524;35619;35806.82096589501;35963.28073438569;36288.27423451569;34254.31491370209;34790.47814282737;35438.64561354354;35694.64305356913;35720.285594288485;31332.53001204938;32369.676303236665;32542.349153016334;32717.34565308633;32928.506072409415;24722.13472528453;24912.62631060572;24963.87518062398;25227.873860630578;25525.744742552335 13:42:27 INFO - PROCESS | 14438 | |2;jquery.html;370.3537327363751;371.7973704331141;376.29069204549427;386.96904247660154;393.22338381696153;15804.920975395122;16931.915340423297;17291.827081729178;17310.394136205236;17333.7399939001;15379.69240615187;16238.75641865373;17867.731984020218;17901.552461188476;17927.64144717108;4518.706284091531;4756.690815097025;4761.285807128924;4764.571188593026;4770.713757174563;3500.1949551603147;4716.740579268139;5189.8183563575285;5480;5519.779208831662;5506.91739623906;5551.444855514456;5557.916631250535;5581.386047534768;5590.385057643656;5297.231901374298;5513.5037846594;5558.027345214612;5568.303962004749;5575.275214222145;3417.3507033663523;5045.318881950926;5358.4373640767935;5389.434109418494;5402.6758394496455;12319.815202771966;12342.506299748;12406.81389779154;12515.249085054926;12619.684507887285;1766.1963806468154;1809.1406581873637;1911.722800193964;1913.062599326334;2129.7763734807777;9111.717273466205;9200.631974721004;9649.324547281693;9707.369021013612;9830.754231144207;1688.3499852556854;1754.8420642142269;1766.9751544104388;1815.6459490399377;1817.3457555280088;66444.66777666128;66577;66979.66510167466;67328.32671673318;70861.6456917712;10054.29619926598;10140.44227567476;10170.593176273014;10228.437435941094;10312.535935882903;13764.724705505834;13954.651133721534;13990.440382384793;14004.229767362893;14019.088759230617;6991.510594258353;7533.924660753432;7540.095188577406;7612.5051871629275;7782.416318776114;7382.2617738225745;7512.887306690404;7597.278258565428;7606;7634.923650763421;4336.306191009423;4463.397441345377;4481.731096134243;4487.394201782783;4546.431696037996;1700.9404670836461;1782.9197686104158;1803.9549011274823;1813.6372725454698;1814.1201517264117;785.681798871458;891.5319457284977;926.4348747264163;926.7405126564438;950.2825366847985;15402.537923862303;16554.42059527911;16910.830891690926;17221.311147554206;17358.3056677734;847.8261956298944;859.458541119091;893.1381217125505;896.3098414221014;941.9011003844635;8989.370744047854;9475.715728528156;9487.33588648788;9487.762805929908;9509.714708558755;409495;416060;416632;419765;420444;74510;75566.62216688882;77044;78354;80969;908.836409446306;920.6409500294891;926.8841394825647;935.6631612619451;940.1397721085131;14840.332185051915;14867.405303787727;15050.247487625356;15054.548363548673;15453.613659658598;34683.82658086693;35926.64073359233;36423.27153456863;36561.085972849825;36678.44982325214;48855.75572122117;49656.50343496663;49771.76939960144;49888.75055624699;50007;4666.393368862026;4844.733539655353;6682.732690692318;7703.537787732754;7929.484583502054;11244.606438774603;11830.881691182978;11914.940425298164;11944.16390852632;12333.62999110028;9847.606095756377;9994.750131246778;10089.545970431494;10645.627403040857;10653.201009924132;10311.948440257751;10314.587416503256;10429.478526073817;10491.318064325795;10569.841452378374;10227.232957528066;10523.263371563917;10591.8940810594;10654.573817047542;10744.51649675782;7672.232776722283;7856.528608283521;7900.4074694397;7989.081255655674;7999.880001799861;10434.06093451593;10448.164146868385;10518.105960993402;10559.313644613076;10595.841062383915 13:42:27 INFO - PROCESS | 14438 | |3;mootools.html;1213.1507944438895;1348.191085348791;1394.8186735724355;1461.8465061168577;1698.0830351610123;6754.425873800727;7402.777916662495;7610.315071643551;7611.1627720950655;7788.6105694715325;7557.848843023136;7587.848243035136;7652.961735191317;7654.578998155099;7660.387169026479;2215.4129155773694;2241.8766967816764;2244.820414366855;2244.887755612221;2247.0562363807157;2184.0936011555186;2218.6117429449864;2221.1115553778536;2224.3215819175143;2231.9553608927813;2166.880821554814;2179.967300490494;2182.2253100149455;2191.079746506471;2240.5630901974123;2163.5456554123652;2165.794249546306;2169.609470295346;2171.250918433138;2171.6742488626674;2126.5321629241544;2159.3845753960045;2160.6542953127423;2160.8487405881597;2161.4704397422574;7717.382609391235;7767.262110099531;7771.611419429062;7785.4939428937505;7841.176676448948;4624.583787459112;4801.5438533339275;4816.61467082636;4821.228603423436;4829.203181475053;2889.2632378743288;3052.145399288203;3133.686631336848;3135.890243841455;3136.9372612547622;931.7344556801347;931.7484279244634;935.7754139006657;955.2214944820018;959.889612694542;10860.402677852715;10925.125989920787;10928.508217130247;10945.124390048777;10979.560817567288;4097.651699605507;4121.793910304533;4173.4157217989505;4206.684498662613;4267.445232119804;8617.870731939025;8698.304135669132;8703.95648021756;8712;8717.259032982141;4615.3077038443835;4620.722756634613;4622.537746225418;4625.098105869323;4627.6529260305615;3513.508108864761;3579.194681196762;3932.938106711172;4280.850170244026;4345.978270108692;3415.2998635280205;3493.144179675945;3508.6315936826268;3544.91137721559;3551.0234685461705;1024.9538770755184;1059.777446736194;1071.9303245289186;1097.9231453798318;1105.6793529876406;730.5288089182554;769.9345555627834;828.842519921213;847.5169153582522;855.4567849415541;4860.1737704590305;5079.288899554065;5120.641555091182;5350.30446042012;5494.697791621419;410.5483967635637;412.5152945289333;419.1135747893184;425.6594724220611;428.18430889156207;3612.3317186320614;3687.0597997510463;3714.2200137971327;3720.720945929066;3777.301199278142;9676.274279429072;10056.648017319505;10062.69811905644;10126.189904807597;10165.695029149138;10013.599456021677;10027.498625068863;10038;10054.447005414773;10060.647877324405;7028.718851245892;7169.964150179216;7247.804112321408;7256.9274307256255;7266.273372662691;5121.436641969306;5238.0833354162105;5276.657017294017;5336.733163341895;5387.568994480511;9062.184403403726;9259.074092590687;9304.255659547085;9374.625014999596;9377.202937750368;8914.643414263357;9212.216961558343;9243.722688319362;9382.765430864283;9527.857082143912;6083.117947897442;6822.829429264308;6825.488088393291;7033.366996970297;7047;7597.240275972358;7598.392128629807;7618.771436856903;7659.310662040443;7679.040119985002;6462.644554549357;6637.2699003108655;6637.435817955335;6696.765613203709;6813.591184528944;6525.869482610226;6555.3772391622715;6587.9670601646685;6599.208095028435;6628.038934354588;5909.8227053188475;6009.789657361971;6093.360197179232;6108.633481991094;6112.388761123852;4314.6548276138465;4424;4485.46174459067;4503;4537.274036154199;4170.645495132948;4378.649708023414;4459.2865141577195;4486.282194848808;4491.3487544306545 13:42:27 INFO - PROCESS | 14438 | |4;prototype.html;288.3627183923529;295.9095732226745;301.88528359223494;307.06192581663026;307.3300205551896;4862.951370486294;4893.853184404474;4896.877578060546;4908.656394052417;4912.2631605259185;4814.9759251203695;4833.76738931572;4839.2499162629765;4860.809101770072;4866.880617457978;3594.6585074417953;3702.61122582129;3755.117547376364;3819.4461803038544;3871.477350557681;3785.5457345118625;3828.3300422425964;3838.2323535293053;3853.3256680081013;3860.7683538987612;3794.880510249483;3815;3817.0075780297184;3818.5608655004753;3830.387138057911;3622.094476380905;3715.516982792247;3773.6981041516615;3816.2749077675153;3830;3354.9161270968175;3366.5286859839644;3375.4599264117624;3380.9661903381143;3408.880689175867;4720.858374248778;4747.169245382044;4756.5243475652505;4758.762061896926;4759.358021482583;4181.080162364275;4349.41282926804;4368.213721530124;4381.583749543788;4397.846075387378;5047.7476126193915;5048.1670524363435;5055.317532133152;5062.696238225718;5064.670796398223;3731.458938453909;3733.5812391291406;3739.083924438503;3741.8690345838036;3762.097096696773;5113.798257409543;5264.341957255381;5283.89038301957;5331.134103063935;5338.492843179892;3799.4680744695765;3809.2571948470336;3810.580836108026;3821.121142137324;3824.827882745283;3883.456316115746;3886;3890.688744900401;3897.201073779925;3899.74651647642;4390.716827249812;4400.537943515948;4404.757738324359;4412;4426.9778651106535;4864.78108485119;5094.388673359221;5096.51583099605;5135.2553879687985;5154.92267615986;1332.460353556811;1351.7972304154455;1353.7495563320817;1354.8170996915487;1355.8169647097516;871.6382701179067;875.7722992021993;879.6173664455854;915.7252824152728;933.3466573398513;4425.181341451842;4437.5784300491405;4439.64482841372;4441.356698021753;4454.910901781946;5198.350206224222;5218.425973142951;5225.268462415189;5230.529252367229;5241.240020197126;4312.266914624522;4345.174416860787;4382.627476664519;4398.318260669601;4425.3140763181755;2774.694783573805;2776.972230277712;2784.4152727927362;2785.749282564579;2803.845788481653;4851.175300198904;4852.539008794159;4872.953359588982;4880.267959806058;4883.194272944925;5114.5652619527755;5313.229581710631;5318.361796584435;5332.520073193431;5440.646357986719;4962.6774259673;4972.756810797301;4976.581674222829;4979.178435558165;4980.153373926441;5292.629515933848;5293.2589437479555;5302.920456193083;5333.266688326232;5339.359276886798;4926.3349447824085;5194.636375453833;5214.556762675215;5249.133892907627;5251.763670634754;4938.456769755396;4943.604511639132;4958.305837182726;4965.9571489986065;4974.577160941216;3743.288775132716;3749.887503374903;3759.5864454910484;3768.9057773555883;3784.4890939723887;5093.898122037613;5315;5318.228856815663;5335.199720042025;5338.492843179892;5121.79512819498;5136.357955255593;5136.8202112925865;5139.820106296262;5149.716765577929;5085.186370180753;5119.0529751996;5128.538431541179;5162.9483705162465;5167.793288268427;4884.78018489176;5088.262201980618;5097.643164978416;5101.489851014869;5112.335396398445;4964.478729733471;5018.673786203885;5188.455212202664;5195.272661827423;5198.168293073241;5079.9238011429115;5095.592352611708;5100.617453690914;5114.284000239895;5118.513741194581 13:42:27 INFO - PROCESS | 14438 | |5;yui.html;684.5379368925974;719.9640017999099;723.612867116093;726.0017475970541;730.4652854594555;12129.514819407224;12808.487660493593;12918.741625167491;12954;13045.217286962778;12511.311877846714;13720.725585488284;13745.106568073094;13754.10598311109;13765.449382024706;609.9085137229429;767.9769606911774;774.4307933668763;783.2363445640483;799.8680217764062;793.0443815202667;793.896793416855;796.9721059762909;797.0554892452434;797.1589972578927;841.970531031414;843.4896887383137;844.4890841041174;844.6156998565668;845.1252953193415;641.6984017511762;661.170231359643;662.9602223866583;663.8970959501285;839.9076101628847;581.7004242814953;600.570592026703;600.5945986459122;602.5812060617873;602.6444397805273;12546.686332841751;12575.622731318075;12963.287019214034;13001.86998130016;13048.217106973612;12133.393330333536;12895.613131606067;12943.67640808978;12987.935060324733;13215.33923303831;11877.22798018126;11996.70008249792;12099.697507562294;12141.878581214163;12349.5060197592;3190.8521644432208;3319.9834000830083;3327.617324007722;3361.983190084034;4192.685548583869;59078.40921590772;59543.702281488746;60037.6998115011;60406;61231.38768612346;10526.684199474028;10588.470576471145;10923.508442120125;10943.562257509611;11235.66293011211;18967.33614323492;19017.524561885788;19035.238590456225;19189.61620767577;19192.040397980047;6870.965645171742;6979.546329488567;7028.472864535181;7059.647017649097;7210.891836622455;3697.149655579232;3789.412641040643;3810.0855794609647;3854.8265328060306;3900.863469778544;3015.1557563882147;3098.209956461088;3110.9688903111132;3114.6106736657916;3131.8434078295995;531.452603818068;538.0315432221985;538.5449295345427;542.2760614579502;543.5026950340394;443.85574688226455;480.96152307815294;508.41786154852485;568.9260396148557;574.3165632896839;7468.9626551866895;7672.232776722395;7801.45389822707;8001.8399632008195;8063.072746634095;556.629841155627;565.3046752494455;586.7330364684059;601.8555546668767;603.6528995827417;3435.261418794971;3542.6457354264367;3555.8577656893435;3615.3492371373404;3647.94528082079;91819.5409022964;91881;94159;96879;98244;80605.59697201593;82010;84401;85051;86020.56989715011;61353;73269;76354.6182269074;77458.2254177451;79586.60206698929;8084.83830323402;8170.428070035278;8245.715539771989;8514.91485085166;8718.346124040596;39760.60239397569;40185;41831.581684183984;41841.79079104585;42366.78816605897;56610.71694641501;60272.69863650654;60474.69762651159;60839.39160608514;61388;10702.89297107019;10817.837732433862;11068.16988725865;11589.072874170215;11650.76698466009;12239;12266.693332666755;12720.300383478627;12782.105252632227;12848.550300739429;11359.261647992855;11869.703257418289;11891.82162267584;12268.509259629514;12491.063170262085;11204.66386008421;11393.658190254306;11411.885881141414;11416.543338266376;11470.770584588428;10975.890241097486;10979.835302470628;11096.33421994683;11139.721506962067;11377.146713996317;9278.9536052322;9563.139317461462;9737.9026209737;9824;9926.057024582653;8944.776380590538;9095.408798428081;9174.770630734285;9201.125893040151;9257.120573545502 13:42:27 INFO - PROCESS | 14438 | __end_tp_report 13:42:27 INFO - PROCESS | 14438 | __start_cc_report 13:42:27 INFO - PROCESS | 14438 | _x_x_mozilla_cycle_collect,1139 13:42:27 INFO - PROCESS | 14438 | __end_cc_report 13:42:27 INFO - PROCESS | 14438 | __startTimestamp1466800947018__endTimestamp 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | ------- Summary: start ------- 13:42:27 INFO - PROCESS | 14438 | Number of tests: 6 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | [#0] dojo.html Cycles:165 Average:4741.12 Median:4810.86 stddev:501.20 (10.4%) stddev-sans-first:474.98 13:42:27 INFO - PROCESS | 14438 | Values: 2644.2 2651.4 2681.0 2692.9 2696.9 4626.9 4696.1 4705.1 4797.2 4865.9 4764.4 4765.4 4766.3 4797.4 4810.1 4327.4 4343.4 4369.4 4465.6 4551.7 4464.8 4485.9 4500.8 4517.8 4546.4 4309.1 4355.6 4357.5 4392.5 4410.4 4381.7 4392.6 4399.2 4431.4 4469.0 4411.9 4430.6 4446.4 4446.5 4489.9 4678.3 4770.1 4810.6 4810.9 4821.4 5196.3 5205.9 5237.5 5240.8 5265.3 5265.8 5279.4 5299.8 5300.4 5302.1 4636.1 4699.0 4767.4 4769.0 4779.9 5286.0 5331.6 5387.4 5388.1 5392.6 4939.1 5100.2 5153.1 5157.3 5157.4 5062.1 5114.8 5116.4 5133.4 5149.4 5103.5 5114.5 5125.6 5131.5 5179.7 4934.2 4993.4 5107.2 5122.0 5136.6 4346.7 4358.2 4372.6 4410.8 4433.4 3815.4 3821.0 3825.3 3860.3 3866.3 4286.1 4388.9 4391.2 4401.4 4443.8 5064.5 5108.5 5130.9 5207.9 5213.0 4402.2 4405.2 4406.5 4410.3 4443.4 4650.6 4654.7 4659.2 4662.0 4689.1 4652.5 4703.3 4756.4 4769.8 4786.8 5079.3 5112.8 5123.2 5124.9 5172.8 4655.4 4761.7 4761.9 4772.1 4823.1 4948.5 4982.7 4990.8 5015.7 5021.2 5052.6 5067.4 5069.2 5072.3 5089.4 4815.7 4944.4 4951.6 4967.4 4972.3 4969.9 4996.2 5041.0 5052.0 5090.8 4967.2 4969.2 5021.8 5028.0 5036.3 4872.6 4940.7 5003.4 5122.0 5140.1 4789.6 4835.1 4852.8 4880.1 4918.3 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | [#1] ext.html Cycles:180 Average:46134.94 Median:194802.82 stddev:84661.04 (43.5%) stddev-sans-first:84829.31 13:42:27 INFO - PROCESS | 14438 | Values: 536.1 562.1 569.6 570.5 604.4 26165.3 28157.7 28234.0 28242.6 38383.2 36206.0 39981.6 39996.8 40023.8 40107.6 7758.7 7910.0 7910.9 7917.2 7922.4 7550.6 7713.7 7805.0 9807.8 10147.7 10193.0 10251.7 10267.1 10282.2 10284.3 10099.7 10165.3 10169.9 10170.9 10175.9 7434.6 9812.1 10219.8 10224.7 10249.2 38000.0 39200.0 39319.6 39360.2 39403.0 3045.4 3318.2 3531.9 3549.2 3677.5 29534.7 30032.8 30368.5 30566.7 31429.0 3403.0 3445.9 3451.5 3528.2 3560.9 161381.0 162861.0 163984.0 164090.2 164935.0 56245.4 56822.4 56979.7 57068.7 57099.4 33945.3 33980.2 33999.2 36254.6 36383.8 16001.4 16165.3 16259.4 16263.1 16266.1 9590.8 12141.0 12212.5 12217.0 12217.9 18861.4 19512.6 19590.8 20235.6 20342.6 7290.9 7293.0 7426.7 7439.3 7521.6 832.0 910.9 962.8 963.6 999.7 25195.9 26137.3 26612.0 26612.2 27325.6 948.9 981.2 987.3 1032.6 1099.8 14110.9 14415.3 14719.1 14859.3 14877.9 389108.0 389474.0 393045.0 393785.0 394109.0 33361.2 50059.0 50060.2 50066.5 50138.2 1089.3 1183.4 1184.4 1196.1 1233.3 26908.5 27457.3 28354.9 28646.6 29260.7 45761.8 46271.3 46466.3 46472.8 46517.5 354167.0 356962.0 357925.0 358046.0 358225.0 32396.2 37659.2 39023.8 39517.0 41778.8 41258.8 41501.6 41533.6 41799.6 42420.0 35292.8 35395.6 35653.8 35904.8 36299.5 35524.0 35619.0 35806.8 35963.3 36288.3 34254.3 34790.5 35438.6 35694.6 35720.3 31332.5 32369.7 32542.3 32717.3 32928.5 24722.1 24912.6 24963.9 25227.9 25525.7 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | [#2] jquery.html Cycles:180 Average:24715.43 Median:4399.85 stddev:68600.45 (1559.2%) stddev-sans-first:68768.54 13:42:27 INFO - PROCESS | 14438 | Values: 370.4 371.8 376.3 387.0 393.2 15804.9 16931.9 17291.8 17310.4 17333.7 15379.7 16238.8 17867.7 17901.6 17927.6 4518.7 4756.7 4761.3 4764.6 4770.7 3500.2 4716.7 5189.8 5480.0 5519.8 5506.9 5551.4 5557.9 5581.4 5590.4 5297.2 5513.5 5558.0 5568.3 5575.3 3417.4 5045.3 5358.4 5389.4 5402.7 12319.8 12342.5 12406.8 12515.2 12619.7 1766.2 1809.1 1911.7 1913.1 2129.8 9111.7 9200.6 9649.3 9707.4 9830.8 1688.3 1754.8 1767.0 1815.6 1817.3 66444.7 66577.0 66979.7 67328.3 70861.6 10054.3 10140.4 10170.6 10228.4 10312.5 13764.7 13954.7 13990.4 14004.2 14019.1 6991.5 7533.9 7540.1 7612.5 7782.4 7382.3 7512.9 7597.3 7606.0 7634.9 4336.3 4463.4 4481.7 4487.4 4546.4 1700.9 1782.9 1804.0 1813.6 1814.1 785.7 891.5 926.4 926.7 950.3 15402.5 16554.4 16910.8 17221.3 17358.3 847.8 859.5 893.1 896.3 941.9 8989.4 9475.7 9487.3 9487.8 9509.7 409495.0 416060.0 416632.0 419765.0 420444.0 74510.0 75566.6 77044.0 78354.0 80969.0 908.8 920.6 926.9 935.7 940.1 14840.3 14867.4 15050.2 15054.5 15453.6 34683.8 35926.6 36423.3 36561.1 36678.4 48855.8 49656.5 49771.8 49888.8 50007.0 4666.4 4844.7 6682.7 7703.5 7929.5 11244.6 11830.9 11914.9 11944.2 12333.6 9847.6 9994.8 10089.5 10645.6 10653.2 10311.9 10314.6 10429.5 10491.3 10569.8 10227.2 10523.3 10591.9 10654.6 10744.5 7672.2 7856.5 7900.4 7989.1 7999.9 10434.1 10448.2 10518.1 10559.3 10595.8 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | [#3] mootools.html Cycles:180 Average:5128.23 Median:4621.63 stddev:2944.93 (63.7%) stddev-sans-first:2938.49 13:42:27 INFO - PROCESS | 14438 | Values: 1213.2 1348.2 1394.8 1461.8 1698.1 6754.4 7402.8 7610.3 7611.2 7788.6 7557.8 7587.8 7653.0 7654.6 7660.4 2215.4 2241.9 2244.8 2244.9 2247.1 2184.1 2218.6 2221.1 2224.3 2232.0 2166.9 2180.0 2182.2 2191.1 2240.6 2163.5 2165.8 2169.6 2171.3 2171.7 2126.5 2159.4 2160.7 2160.8 2161.5 7717.4 7767.3 7771.6 7785.5 7841.2 4624.6 4801.5 4816.6 4821.2 4829.2 2889.3 3052.1 3133.7 3135.9 3136.9 931.7 931.7 935.8 955.2 959.9 10860.4 10925.1 10928.5 10945.1 10979.6 4097.7 4121.8 4173.4 4206.7 4267.4 8617.9 8698.3 8704.0 8712.0 8717.3 4615.3 4620.7 4622.5 4625.1 4627.7 3513.5 3579.2 3932.9 4280.9 4346.0 3415.3 3493.1 3508.6 3544.9 3551.0 1025.0 1059.8 1071.9 1097.9 1105.7 730.5 769.9 828.8 847.5 855.5 4860.2 5079.3 5120.6 5350.3 5494.7 410.5 412.5 419.1 425.7 428.2 3612.3 3687.1 3714.2 3720.7 3777.3 9676.3 10056.6 10062.7 10126.2 10165.7 10013.6 10027.5 10038.0 10054.4 10060.6 7028.7 7170.0 7247.8 7256.9 7266.3 5121.4 5238.1 5276.7 5336.7 5387.6 9062.2 9259.1 9304.3 9374.6 9377.2 8914.6 9212.2 9243.7 9382.8 9527.9 6083.1 6822.8 6825.5 7033.4 7047.0 7597.2 7598.4 7618.8 7659.3 7679.0 6462.6 6637.3 6637.4 6696.8 6813.6 6525.9 6555.4 6588.0 6599.2 6628.0 5909.8 6009.8 6093.4 6108.6 6112.4 4314.7 4424.0 4485.5 4503.0 4537.3 4170.6 4378.6 4459.3 4486.3 4491.3 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | [#4] prototype.html Cycles:180 Average:4253.40 Median:4861.88 stddev:1223.44 (25.2%) stddev-sans-first:1190.13 13:42:27 INFO - PROCESS | 14438 | Values: 288.4 295.9 301.9 307.1 307.3 4863.0 4893.9 4896.9 4908.7 4912.3 4815.0 4833.8 4839.2 4860.8 4866.9 3594.7 3702.6 3755.1 3819.4 3871.5 3785.5 3828.3 3838.2 3853.3 3860.8 3794.9 3815.0 3817.0 3818.6 3830.4 3622.1 3715.5 3773.7 3816.3 3830.0 3354.9 3366.5 3375.5 3381.0 3408.9 4720.9 4747.2 4756.5 4758.8 4759.4 4181.1 4349.4 4368.2 4381.6 4397.8 5047.7 5048.2 5055.3 5062.7 5064.7 3731.5 3733.6 3739.1 3741.9 3762.1 5113.8 5264.3 5283.9 5331.1 5338.5 3799.5 3809.3 3810.6 3821.1 3824.8 3883.5 3886.0 3890.7 3897.2 3899.7 4390.7 4400.5 4404.8 4412.0 4427.0 4864.8 5094.4 5096.5 5135.3 5154.9 1332.5 1351.8 1353.7 1354.8 1355.8 871.6 875.8 879.6 915.7 933.3 4425.2 4437.6 4439.6 4441.4 4454.9 5198.4 5218.4 5225.3 5230.5 5241.2 4312.3 4345.2 4382.6 4398.3 4425.3 2774.7 2777.0 2784.4 2785.7 2803.8 4851.2 4852.5 4873.0 4880.3 4883.2 5114.6 5313.2 5318.4 5332.5 5440.6 4962.7 4972.8 4976.6 4979.2 4980.2 5292.6 5293.3 5302.9 5333.3 5339.4 4926.3 5194.6 5214.6 5249.1 5251.8 4938.5 4943.6 4958.3 4966.0 4974.6 3743.3 3749.9 3759.6 3768.9 3784.5 5093.9 5315.0 5318.2 5335.2 5338.5 5121.8 5136.4 5136.8 5139.8 5149.7 5085.2 5119.1 5128.5 5162.9 5167.8 4884.8 5088.3 5097.6 5101.5 5112.3 4964.5 5018.7 5188.5 5195.3 5198.2 5079.9 5095.6 5100.6 5114.3 5118.5 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - PROCESS | 14438 | [#5] yui.html Cycles:180 Average:17419.50 Median:540.41 stddev:24664.45 (4564.0%) stddev-sans-first:24701.63 13:42:27 INFO - PROCESS | 14438 | Values: 684.5 720.0 723.6 726.0 730.5 12129.5 12808.5 12918.7 12954.0 13045.2 12511.3 13720.7 13745.1 13754.1 13765.4 609.9 768.0 774.4 783.2 799.9 793.0 793.9 797.0 797.1 797.2 842.0 843.5 844.5 844.6 845.1 641.7 661.2 663.0 663.9 839.9 581.7 600.6 600.6 602.6 602.6 12546.7 12575.6 12963.3 13001.9 13048.2 12133.4 12895.6 12943.7 12987.9 13215.3 11877.2 11996.7 12099.7 12141.9 12349.5 3190.9 3320.0 3327.6 3362.0 4192.7 59078.4 59543.7 60037.7 60406.0 61231.4 10526.7 10588.5 10923.5 10943.6 11235.7 18967.3 19017.5 19035.2 19189.6 19192.0 6871.0 6979.5 7028.5 7059.6 7210.9 3697.1 3789.4 3810.1 3854.8 3900.9 3015.2 3098.2 3111.0 3114.6 3131.8 531.5 538.0 538.5 542.3 543.5 443.9 481.0 508.4 568.9 574.3 7469.0 7672.2 7801.5 8001.8 8063.1 556.6 565.3 586.7 601.9 603.7 3435.3 3542.6 3555.9 3615.3 3647.9 91819.5 91881.0 94159.0 96879.0 98244.0 80605.6 82010.0 84401.0 85051.0 86020.6 61353.0 73269.0 76354.6 77458.2 79586.6 8084.8 8170.4 8245.7 8514.9 8718.3 39760.6 40185.0 41831.6 41841.8 42366.8 56610.7 60272.7 60474.7 60839.4 61388.0 10702.9 10817.8 11068.2 11589.1 11650.8 12239.0 12266.7 12720.3 12782.1 12848.6 11359.3 11869.7 11891.8 12268.5 12491.1 11204.7 11393.7 11411.9 11416.5 11470.8 10975.9 10979.8 11096.3 11139.7 11377.1 9279.0 9563.1 9737.9 9824.0 9926.1 8944.8 9095.4 9174.8 9201.1 9257.1 13:42:27 INFO - PROCESS | 14438 | -------- Summary: end -------- 13:42:27 INFO - PROCESS | 14438 | 13:42:27 INFO - TEST-INFO | 14438: exit 0 13:42:27 INFO - TEST-OK | dromaeo_css | took 1119460ms 13:42:27 INFO - TEST-START | kraken 13:42:27 INFO - operating with platform_type : linux_ 13:42:27 INFO - Initialising browser for kraken test... 13:42:27 INFO - TEST-INFO | started process 14615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgfG4jY/profile http://localhost:36296/getInfo.html) 13:42:31 INFO - PROCESS | 14615 | __metrics Screen width/height:1600/1200 13:42:31 INFO - PROCESS | 14615 | colorDepth:24 13:42:31 INFO - PROCESS | 14615 | Browser inner width/height: 1024/697 13:42:31 INFO - PROCESS | 14615 | __metrics 13:42:32 INFO - PROCESS | 14615 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:42:33 INFO - TEST-INFO | 14615: exit 0 13:42:33 INFO - Browser initialized. 13:42:33 INFO - Running cycle 1/1 for kraken test... 13:42:33 INFO - TEST-INFO | started process 14699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgfG4jY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:46 INFO - PROCESS | 14699 | RSS: Main: 176078848 13:42:46 INFO - PROCESS | 14699 | 13:42:48 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36296/tests/kraken/driver.html?testName=audio-beat-detection) 13:42:49 INFO - PROCESS | 14699 | RSS: Main: 233078784 13:42:49 INFO - PROCESS | 14699 | 13:42:52 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36296/tests/kraken/driver.html?testName=audio-dft) 13:42:53 INFO - PROCESS | 14699 | RSS: Main: 221593600 13:42:53 INFO - PROCESS | 14699 | 13:42:56 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36296/tests/kraken/driver.html?testName=audio-fft) 13:42:56 INFO - PROCESS | 14699 | RSS: Main: 288268288 13:42:56 INFO - PROCESS | 14699 | 13:42:59 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36296/tests/kraken/driver.html?testName=audio-oscillator) 13:42:59 INFO - PROCESS | 14699 | RSS: Main: 198840320 13:42:59 INFO - PROCESS | 14699 | 13:43:01 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:43:02 INFO - PROCESS | 14699 | RSS: Main: 202031104 13:43:02 INFO - PROCESS | 14699 | 13:43:05 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36296/tests/kraken/driver.html?testName=imaging-darkroom) 13:43:06 INFO - PROCESS | 14699 | RSS: Main: 238936064 13:43:06 INFO - PROCESS | 14699 | 13:43:09 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36296/tests/kraken/driver.html?testName=imaging-desaturate) 13:43:10 INFO - PROCESS | 14699 | RSS: Main: 239394816 13:43:10 INFO - PROCESS | 14699 | 13:43:13 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36296/tests/kraken/driver.html?testName=json-parse-financial) 13:43:13 INFO - PROCESS | 14699 | RSS: Main: 238559232 13:43:13 INFO - PROCESS | 14699 | 13:43:15 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:43:16 INFO - PROCESS | 14699 | RSS: Main: 225665024 13:43:16 INFO - PROCESS | 14699 | 13:43:18 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:43:18 INFO - PROCESS | 14699 | RSS: Main: 231399424 13:43:18 INFO - PROCESS | 14699 | 13:43:20 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:43:21 INFO - PROCESS | 14699 | RSS: Main: 237039616 13:43:21 INFO - PROCESS | 14699 | 13:43:24 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:43:25 INFO - PROCESS | 14699 | RSS: Main: 240226304 13:43:25 INFO - PROCESS | 14699 | 13:43:28 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:43:28 INFO - PROCESS | 14699 | RSS: Main: 240848896 13:43:28 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | Cycle 1(1): loaded http://localhost:36296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36296/tests/kraken/driver.html?testName=ai-astar) 13:43:30 INFO - PROCESS | 14699 | RSS: Main: 282910720 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | __start_tp_report 13:43:30 INFO - PROCESS | 14699 | _x_x_mozilla_page_load 13:43:30 INFO - PROCESS | 14699 | _x_x_mozilla_page_load_details 13:43:30 INFO - PROCESS | 14699 | |i|pagename|runs| 13:43:30 INFO - PROCESS | 14699 | |0;ai-astar;102;114;115;113;113;114;111;112;111;113 13:43:30 INFO - PROCESS | 14699 | |1;audio-beat-detection;158;130;130;187;131;130;160;137;190;130 13:43:30 INFO - PROCESS | 14699 | |2;audio-dft;162;160;161;162;160;162;161;164;160;161 13:43:30 INFO - PROCESS | 14699 | |3;audio-fft;76;75;77;109;75;77;76;77;102;77 13:43:30 INFO - PROCESS | 14699 | |4;audio-oscillator;85;87;127;86;85;87;119;86;87;119 13:43:30 INFO - PROCESS | 14699 | |5;imaging-gaussian-blur;117;117;118;119;119;119;118;118;117;118 13:43:30 INFO - PROCESS | 14699 | |6;imaging-darkroom;145;148;146;146;146;147;147;145;148;146 13:43:30 INFO - PROCESS | 14699 | |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;94 13:43:30 INFO - PROCESS | 14699 | |8;json-parse-financial;64;64;64;64;65;65;64;65;64;65 13:43:30 INFO - PROCESS | 14699 | |9;json-stringify-tinderbox;65;65;65;65;65;64;66;66;66;67 13:43:30 INFO - PROCESS | 14699 | |10;stanford-crypto-aes;90;82;82;82;84;84;87;88;108;83 13:43:30 INFO - PROCESS | 14699 | |11;stanford-crypto-ccm;142;130;131;134;130;133;147;139;138;128 13:43:30 INFO - PROCESS | 14699 | |12;stanford-crypto-pbkdf2;173;171;171;171;170;170;176;173;178;170 13:43:30 INFO - PROCESS | 14699 | |13;stanford-crypto-sha256-iterative;70;66;68;67;66;67;67;70;67;65 13:43:30 INFO - PROCESS | 14699 | __end_tp_report 13:43:30 INFO - PROCESS | 14699 | __start_cc_report 13:43:30 INFO - PROCESS | 14699 | _x_x_mozilla_cycle_collect,1956 13:43:30 INFO - PROCESS | 14699 | __end_cc_report 13:43:30 INFO - PROCESS | 14699 | __startTimestamp1466801010647__endTimestamp 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | ------- Summary: start ------- 13:43:30 INFO - PROCESS | 14699 | Number of tests: 14 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:3.68 (3.3%) stddev-sans-first:1.36 13:43:30 INFO - PROCESS | 14699 | Values: 102.0 114.0 115.0 113.0 113.0 114.0 111.0 112.0 111.0 113.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:147.50 stddev:24.12 (16.3%) stddev-sans-first:25.32 13:43:30 INFO - PROCESS | 14699 | Values: 158.0 130.0 130.0 187.0 131.0 130.0 160.0 137.0 190.0 130.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 13:43:30 INFO - PROCESS | 14699 | Values: 162.0 160.0 161.0 162.0 160.0 162.0 161.0 164.0 160.0 161.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.50 stddev:12.47 (16.3%) stddev-sans-first:13.03 13:43:30 INFO - PROCESS | 14699 | Values: 76.0 75.0 77.0 109.0 75.0 77.0 76.0 77.0 102.0 77.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:86.00 stddev:17.31 (20.1%) stddev-sans-first:17.83 13:43:30 INFO - PROCESS | 14699 | Values: 85.0 87.0 127.0 86.0 85.0 87.0 119.0 86.0 87.0 119.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 13:43:30 INFO - PROCESS | 14699 | Values: 117.0 117.0 118.0 119.0 119.0 119.0 118.0 118.0 117.0 118.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 13:43:30 INFO - PROCESS | 14699 | Values: 145.0 148.0 146.0 146.0 146.0 147.0 147.0 145.0 148.0 146.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:43:30 INFO - PROCESS | 14699 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:43:30 INFO - PROCESS | 14699 | Values: 64.0 64.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 65.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 13:43:30 INFO - PROCESS | 14699 | Values: 65.0 65.0 65.0 65.0 65.0 64.0 66.0 66.0 66.0 67.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:84.00 stddev:7.89 (9.4%) stddev-sans-first:8.29 13:43:30 INFO - PROCESS | 14699 | Values: 90.0 82.0 82.0 82.0 84.0 84.0 87.0 88.0 108.0 83.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:136.00 stddev:6.12 (4.5%) stddev-sans-first:5.98 13:43:30 INFO - PROCESS | 14699 | Values: 142.0 130.0 131.0 134.0 130.0 133.0 147.0 139.0 138.0 128.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:172.00 stddev:2.75 (1.6%) stddev-sans-first:2.91 13:43:30 INFO - PROCESS | 14699 | Values: 173.0 171.0 171.0 171.0 170.0 170.0 176.0 173.0 178.0 170.0 13:43:30 INFO - PROCESS | 14699 | 13:43:30 INFO - PROCESS | 14699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.64 (2.4%) stddev-sans-first:1.41 13:43:30 INFO - PROCESS | 14699 | Values: 70.0 66.0 68.0 67.0 66.0 67.0 67.0 70.0 67.0 65.0 13:43:30 INFO - PROCESS | 14699 | -------- Summary: end -------- 13:43:30 INFO - PROCESS | 14699 | 13:43:31 INFO - TEST-INFO | 14699: exit 0 13:43:31 INFO - TEST-OK | kraken | took 63916ms 13:43:31 INFO - SUITE-END | took 1183s 13:43:31 INFO - Completed test suite (00:19:43) 13:43:31 INFO - javascript benchmark 13:43:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.153870761356, 2651.4431969286447, 2680.9597856032165, 2692.8788204530792, 2696.8651567421625, 4626.930596041062, 4696.131215725093, 4705.082508910759, 4797.208460604001, 4865.878353041176, 4764.356811830402, 4765.428148622162, 4766.3088852116425, 4797.40032495938, 4810.110129626013, 4327.437433133696, 4343.370211319357, 4369.366441865927, 4465.620422264112, 4551.658625603093, 4464.776761161929, 4485.932711009337, 4500.842470513533, 4517.774111294422, 4546.408966834323, 4309.1381723655395, 4355.586219309161, 4357.477102747691, 4392.516823149451, 4410.3825464435, 4381.715188512769, 4392.560743925614, 4399.23013472641, 4431.357453169305, 4469.016816300409, 4411.867643970686, 4430.645548356156, 4446.421965144543, 4446.533114023014, 4489.887752806173, 4678.3216433616935, 4770.0698363819065, 4810.5670489656095, 4810.855674329776, 4821.445533763627, 5196.324477817897, 5205.869853253661, 5237.528622423962, 5240.816571419982, 5265.289185959923, 5265.7893684252585, 5279.392869819982, 5299.841004769824, 5300.416954135042, 5302.125149350352, 4636.11913736389, 4698.9530104698515, 4767.380240568704, 4768.9523104769205, 4779.904401911942, 5285.995660824431, 5331.600129990266, 5387.4073851876265, 5388.057090009311, 5392.595555333366, 4939.135651261015, 5100.158473851847, 5153.123968925292, 5157.303763991888, 5157.355330583677, 5062.139436295838, 5114.769835357418, 5116.411612664591, 5133.4096578893905, 5149.356330458692, 5103.515166059218, 5114.514121158484, 5125.56432703217, 5131.461196574381, 5179.663321884065, 4934.235193545006, 4993.350864387607, 5107.182850743863, 5122.026814905156, 5136.563392111638, 4346.695731298779, 4358.193734159191, 4372.584604462571, 4410.779461026936, 4433.357163211316, 3815.3513902636064, 3820.9808950955066, 3825.2731980923536, 3860.3051450738576, 3866.323393406199, 4286.142771445723, 4388.912221755547, 4391.231534481453, 4401.364671712859, 4443.822247110144, 5064.518870707277, 5108.514691104339, 5130.948690513047, 5207.92188117171, 5212.973935130376, 4402.185595664748, 4405.163019026375, 4406.481998882463, 4410.316400957857, 4443.400140980991, 4650.627949764011, 4654.720716757005, 4659.2312268475325, 4662.044280922402, 4689.085628302449, 4652.534746525321, 4703.31801888731, 4756.357891684716, 4769.785359658893, 4786.832460863853, 5079.263506791568, 5112.769925353442, 5123.154679477844, 5124.923126153036, 5172.818951336685, 4655.3947986761505, 4761.666683332133, 4761.928571071506, 4772.0694464580465, 4823.107725070873, 4948.480409557089, 4982.676126051795, 4990.750462476934, 5015.7492125392855, 5021.246812978083, 5052.595792336678, 5067.442581315979, 5069.163588008085, 5072.289879416959, 5089.440161582297, 4815.711057336431, 4944.3572335596145, 4951.579115775199, 4967.40391153064, 4972.266047490156, 4969.900601988013, 4996.200607902718, 5041.0, 5051.974740126423, 5090.821821236239, 4967.205247160437, 4969.204927211629, 5021.799128034984, 5027.974860125676, 5036.345275114359, 4872.634552408513, 4940.654154209315, 5003.44962054181, 5122.026814905156, 5140.100482415637, 4789.592884604847, 4835.0571638531555, 4852.8301509447, 4880.145974454385, 4918.336024636628], "value": 4709.032155498794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.1476381285627, 562.1202817590473, 569.6468189722373, 570.4979617936216, 604.4469310580818, 26165.34586635335, 28157.718422815793, 28234.0, 28242.576361354597, 38383.23233535328, 36206.0, 39981.600183998155, 39996.80001599988, 40023.799881000625, 40107.59892401075, 7758.728444504443, 7909.96045019777, 7910.920890791105, 7917.208279172066, 7922.405819563527, 7550.6224688765615, 7713.73001944932, 7805.024371953506, 9807.803843923117, 10147.746306342327, 10193.0, 10251.743706407326, 10267.075963163314, 10282.228832837567, 10284.280100392938, 10099.747506312327, 10165.288429809953, 10169.898301016969, 10170.949145254226, 10175.949120254425, 7434.628268586549, 9812.116909478182, 10219.846702299472, 10224.693259202237, 10249.231307651882, 38000.0, 39200.0, 39319.60680393188, 39360.21279574421, 39403.0, 3045.3604743004, 3318.1870441741685, 3531.876384326536, 3549.1836877518317, 3677.4667673187505, 29534.70465295341, 30032.8498357509, 30368.54447183294, 30566.694333056606, 31429.0, 3402.9829850850833, 3445.9483107753404, 3451.475782793509, 3528.1708798432346, 3560.893173204808, 161381.0, 162861.0, 163984.0, 164090.17954910267, 164935.0, 56245.43754562402, 56822.43177568171, 56979.715101424226, 57068.714656426455, 57099.42900570941, 33945.32109357799, 33980.150496237795, 33999.150021249174, 36254.637453625124, 36383.81808090943, 16001.439949601709, 16165.27256273447, 16259.430919917746, 16263.105529195771, 16266.105364205083, 9590.760230994281, 12141.0, 12212.511499539918, 12217.022638188924, 12217.877821221851, 18861.434156975312, 19512.609747805247, 19590.804091958897, 20235.595288094155, 20342.593148136955, 7290.890636640454, 7292.96353518229, 7426.74006409773, 7439.293267139613, 7521.586312752851, 831.9542425166553, 910.913463220993, 962.841131213356, 963.5808423335732, 999.6950929966284, 25195.874020630145, 26137.31669189365, 26612.0, 26612.201633951012, 27325.590116148273, 948.8624149498422, 981.215027977615, 987.3335498538602, 1032.5972870580479, 1099.8130317845985, 14110.85889141116, 14415.279236038155, 14719.116852988855, 14859.2570371481, 14877.851221487646, 389108.0, 389474.0, 393045.0, 393785.0, 394109.0, 33361.165970850925, 50059.0, 50060.249096263586, 50066.499335006185, 50138.24792628113, 1089.3137323486312, 1183.3846399872018, 1184.437392238697, 1196.0670676872053, 1233.3216730798204, 26908.461830763667, 27457.31356716018, 28354.85822570874, 28646.57030144591, 29260.707392926648, 45761.77119114383, 46271.30593041174, 46466.30300545562, 46472.83817904444, 46517.53482465132, 354167.0, 356962.0, 357925.0, 358046.0, 358225.0, 32396.190095247806, 37659.24681506409, 39023.804880976546, 39517.0, 41778.79110604428, 41258.793706031276, 41501.58498414977, 41533.58466415418, 41799.58200417957, 42420.0, 35292.82353588318, 35395.64604353924, 35653.82173089222, 35904.82047589745, 36299.45550816793, 35524.0, 35619.0, 35806.82096589501, 35963.28073438569, 36288.27423451569, 34254.31491370209, 34790.47814282737, 35438.64561354354, 35694.64305356913, 35720.285594288485, 31332.53001204938, 32369.676303236665, 32542.349153016334, 32717.34565308633, 32928.506072409415, 24722.13472528453, 24912.62631060572, 24963.87518062398, 25227.873860630578, 25525.744742552335], "value": 17877.150040501972, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.3537327363751, 371.7973704331141, 376.29069204549427, 386.96904247660154, 393.22338381696153, 15804.920975395122, 16931.915340423297, 17291.827081729178, 17310.394136205236, 17333.7399939001, 15379.69240615187, 16238.75641865373, 17867.731984020218, 17901.552461188476, 17927.64144717108, 4518.706284091531, 4756.690815097025, 4761.285807128924, 4764.571188593026, 4770.713757174563, 3500.1949551603147, 4716.740579268139, 5189.8183563575285, 5480.0, 5519.779208831662, 5506.91739623906, 5551.444855514456, 5557.916631250535, 5581.386047534768, 5590.385057643656, 5297.231901374298, 5513.5037846594, 5558.027345214612, 5568.303962004749, 5575.275214222145, 3417.3507033663523, 5045.318881950926, 5358.4373640767935, 5389.434109418494, 5402.6758394496455, 12319.815202771966, 12342.506299748, 12406.81389779154, 12515.249085054926, 12619.684507887285, 1766.1963806468154, 1809.1406581873637, 1911.722800193964, 1913.062599326334, 2129.7763734807777, 9111.717273466205, 9200.631974721004, 9649.324547281693, 9707.369021013612, 9830.754231144207, 1688.3499852556854, 1754.8420642142269, 1766.9751544104388, 1815.6459490399377, 1817.3457555280088, 66444.66777666128, 66577.0, 66979.66510167466, 67328.32671673318, 70861.6456917712, 10054.29619926598, 10140.44227567476, 10170.593176273014, 10228.437435941094, 10312.535935882903, 13764.724705505834, 13954.651133721534, 13990.440382384793, 14004.229767362893, 14019.088759230617, 6991.510594258353, 7533.924660753432, 7540.095188577406, 7612.5051871629275, 7782.416318776114, 7382.2617738225745, 7512.887306690404, 7597.278258565428, 7606.0, 7634.923650763421, 4336.306191009423, 4463.397441345377, 4481.731096134243, 4487.394201782783, 4546.431696037996, 1700.9404670836461, 1782.9197686104158, 1803.9549011274823, 1813.6372725454698, 1814.1201517264117, 785.681798871458, 891.5319457284977, 926.4348747264163, 926.7405126564438, 950.2825366847985, 15402.537923862303, 16554.42059527911, 16910.830891690926, 17221.311147554206, 17358.3056677734, 847.8261956298944, 859.458541119091, 893.1381217125505, 896.3098414221014, 941.9011003844635, 8989.370744047854, 9475.715728528156, 9487.33588648788, 9487.762805929908, 9509.714708558755, 409495.0, 416060.0, 416632.0, 419765.0, 420444.0, 74510.0, 75566.62216688882, 77044.0, 78354.0, 80969.0, 908.836409446306, 920.6409500294891, 926.8841394825647, 935.6631612619451, 940.1397721085131, 14840.332185051915, 14867.405303787727, 15050.247487625356, 15054.548363548673, 15453.613659658598, 34683.82658086693, 35926.64073359233, 36423.27153456863, 36561.085972849825, 36678.44982325214, 48855.75572122117, 49656.50343496663, 49771.76939960144, 49888.75055624699, 50007.0, 4666.393368862026, 4844.733539655353, 6682.732690692318, 7703.537787732754, 7929.484583502054, 11244.606438774603, 11830.881691182978, 11914.940425298164, 11944.16390852632, 12333.62999110028, 9847.606095756377, 9994.750131246778, 10089.545970431494, 10645.627403040857, 10653.201009924132, 10311.948440257751, 10314.587416503256, 10429.478526073817, 10491.318064325795, 10569.841452378374, 10227.232957528066, 10523.263371563917, 10591.8940810594, 10654.573817047542, 10744.51649675782, 7672.232776722283, 7856.528608283521, 7900.4074694397, 7989.081255655674, 7999.880001799861, 10434.06093451593, 10448.164146868385, 10518.105960993402, 10559.313644613076, 10595.841062383915], "value": 8080.105993628938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.1507944438895, 1348.191085348791, 1394.8186735724355, 1461.8465061168577, 1698.0830351610123, 6754.425873800727, 7402.777916662495, 7610.315071643551, 7611.1627720950655, 7788.6105694715325, 7557.848843023136, 7587.848243035136, 7652.961735191317, 7654.578998155099, 7660.387169026479, 2215.4129155773694, 2241.8766967816764, 2244.820414366855, 2244.887755612221, 2247.0562363807157, 2184.0936011555186, 2218.6117429449864, 2221.1115553778536, 2224.3215819175143, 2231.9553608927813, 2166.880821554814, 2179.967300490494, 2182.2253100149455, 2191.079746506471, 2240.5630901974123, 2163.5456554123652, 2165.794249546306, 2169.609470295346, 2171.250918433138, 2171.6742488626674, 2126.5321629241544, 2159.3845753960045, 2160.6542953127423, 2160.8487405881597, 2161.4704397422574, 7717.382609391235, 7767.262110099531, 7771.611419429062, 7785.4939428937505, 7841.176676448948, 4624.583787459112, 4801.5438533339275, 4816.61467082636, 4821.228603423436, 4829.203181475053, 2889.2632378743288, 3052.145399288203, 3133.686631336848, 3135.890243841455, 3136.9372612547622, 931.7344556801347, 931.7484279244634, 935.7754139006657, 955.2214944820018, 959.889612694542, 10860.402677852715, 10925.125989920787, 10928.508217130247, 10945.124390048777, 10979.560817567288, 4097.651699605507, 4121.793910304533, 4173.4157217989505, 4206.684498662613, 4267.445232119804, 8617.870731939025, 8698.304135669132, 8703.95648021756, 8712.0, 8717.259032982141, 4615.3077038443835, 4620.722756634613, 4622.537746225418, 4625.098105869323, 4627.6529260305615, 3513.508108864761, 3579.194681196762, 3932.938106711172, 4280.850170244026, 4345.978270108692, 3415.2998635280205, 3493.144179675945, 3508.6315936826268, 3544.91137721559, 3551.0234685461705, 1024.9538770755184, 1059.777446736194, 1071.9303245289186, 1097.9231453798318, 1105.6793529876406, 730.5288089182554, 769.9345555627834, 828.842519921213, 847.5169153582522, 855.4567849415541, 4860.1737704590305, 5079.288899554065, 5120.641555091182, 5350.30446042012, 5494.697791621419, 410.5483967635637, 412.5152945289333, 419.1135747893184, 425.6594724220611, 428.18430889156207, 3612.3317186320614, 3687.0597997510463, 3714.2200137971327, 3720.720945929066, 3777.301199278142, 9676.274279429072, 10056.648017319505, 10062.69811905644, 10126.189904807597, 10165.695029149138, 10013.599456021677, 10027.498625068863, 10038.0, 10054.447005414773, 10060.647877324405, 7028.718851245892, 7169.964150179216, 7247.804112321408, 7256.9274307256255, 7266.273372662691, 5121.436641969306, 5238.0833354162105, 5276.657017294017, 5336.733163341895, 5387.568994480511, 9062.184403403726, 9259.074092590687, 9304.255659547085, 9374.625014999596, 9377.202937750368, 8914.643414263357, 9212.216961558343, 9243.722688319362, 9382.765430864283, 9527.857082143912, 6083.117947897442, 6822.829429264308, 6825.488088393291, 7033.366996970297, 7047.0, 7597.240275972358, 7598.392128629807, 7618.771436856903, 7659.310662040443, 7679.040119985002, 6462.644554549357, 6637.2699003108655, 6637.435817955335, 6696.765613203709, 6813.591184528944, 6525.869482610226, 6555.3772391622715, 6587.9670601646685, 6599.208095028435, 6628.038934354588, 5909.8227053188475, 6009.789657361971, 6093.360197179232, 6108.633481991094, 6112.388761123852, 4314.6548276138465, 4424.0, 4485.46174459067, 4503.0, 4537.274036154199, 4170.645495132948, 4378.649708023414, 4459.2865141577195, 4486.282194848808, 4491.3487544306545], "value": 4040.5358368889188, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.3627183923529, 295.9095732226745, 301.88528359223494, 307.06192581663026, 307.3300205551896, 4862.951370486294, 4893.853184404474, 4896.877578060546, 4908.656394052417, 4912.2631605259185, 4814.9759251203695, 4833.76738931572, 4839.2499162629765, 4860.809101770072, 4866.880617457978, 3594.6585074417953, 3702.61122582129, 3755.117547376364, 3819.4461803038544, 3871.477350557681, 3785.5457345118625, 3828.3300422425964, 3838.2323535293053, 3853.3256680081013, 3860.7683538987612, 3794.880510249483, 3815.0, 3817.0075780297184, 3818.5608655004753, 3830.387138057911, 3622.094476380905, 3715.516982792247, 3773.6981041516615, 3816.2749077675153, 3830.0, 3354.9161270968175, 3366.5286859839644, 3375.4599264117624, 3380.9661903381143, 3408.880689175867, 4720.858374248778, 4747.169245382044, 4756.5243475652505, 4758.762061896926, 4759.358021482583, 4181.080162364275, 4349.41282926804, 4368.213721530124, 4381.583749543788, 4397.846075387378, 5047.7476126193915, 5048.1670524363435, 5055.317532133152, 5062.696238225718, 5064.670796398223, 3731.458938453909, 3733.5812391291406, 3739.083924438503, 3741.8690345838036, 3762.097096696773, 5113.798257409543, 5264.341957255381, 5283.89038301957, 5331.134103063935, 5338.492843179892, 3799.4680744695765, 3809.2571948470336, 3810.580836108026, 3821.121142137324, 3824.827882745283, 3883.456316115746, 3886.0, 3890.688744900401, 3897.201073779925, 3899.74651647642, 4390.716827249812, 4400.537943515948, 4404.757738324359, 4412.0, 4426.9778651106535, 4864.78108485119, 5094.388673359221, 5096.51583099605, 5135.2553879687985, 5154.92267615986, 1332.460353556811, 1351.7972304154455, 1353.7495563320817, 1354.8170996915487, 1355.8169647097516, 871.6382701179067, 875.7722992021993, 879.6173664455854, 915.7252824152728, 933.3466573398513, 4425.181341451842, 4437.5784300491405, 4439.64482841372, 4441.356698021753, 4454.910901781946, 5198.350206224222, 5218.425973142951, 5225.268462415189, 5230.529252367229, 5241.240020197126, 4312.266914624522, 4345.174416860787, 4382.627476664519, 4398.318260669601, 4425.3140763181755, 2774.694783573805, 2776.972230277712, 2784.4152727927362, 2785.749282564579, 2803.845788481653, 4851.175300198904, 4852.539008794159, 4872.953359588982, 4880.267959806058, 4883.194272944925, 5114.5652619527755, 5313.229581710631, 5318.361796584435, 5332.520073193431, 5440.646357986719, 4962.6774259673, 4972.756810797301, 4976.581674222829, 4979.178435558165, 4980.153373926441, 5292.629515933848, 5293.2589437479555, 5302.920456193083, 5333.266688326232, 5339.359276886798, 4926.3349447824085, 5194.636375453833, 5214.556762675215, 5249.133892907627, 5251.763670634754, 4938.456769755396, 4943.604511639132, 4958.305837182726, 4965.9571489986065, 4974.577160941216, 3743.288775132716, 3749.887503374903, 3759.5864454910484, 3768.9057773555883, 3784.4890939723887, 5093.898122037613, 5315.0, 5318.228856815663, 5335.199720042025, 5338.492843179892, 5121.79512819498, 5136.357955255593, 5136.8202112925865, 5139.820106296262, 5149.716765577929, 5085.186370180753, 5119.0529751996, 5128.538431541179, 5162.9483705162465, 5167.793288268427, 4884.78018489176, 5088.262201980618, 5097.643164978416, 5101.489851014869, 5112.335396398445, 4964.478729733471, 5018.673786203885, 5188.455212202664, 5195.272661827423, 5198.168293073241, 5079.9238011429115, 5095.592352611708, 5100.617453690914, 5114.284000239895, 5118.513741194581], "value": 3866.2534879014142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5379368925974, 719.9640017999099, 723.612867116093, 726.0017475970541, 730.4652854594555, 12129.514819407224, 12808.487660493593, 12918.741625167491, 12954.0, 13045.217286962778, 12511.311877846714, 13720.725585488284, 13745.106568073094, 13754.10598311109, 13765.449382024706, 609.9085137229429, 767.9769606911774, 774.4307933668763, 783.2363445640483, 799.8680217764062, 793.0443815202667, 793.896793416855, 796.9721059762909, 797.0554892452434, 797.1589972578927, 841.970531031414, 843.4896887383137, 844.4890841041174, 844.6156998565668, 845.1252953193415, 641.6984017511762, 661.170231359643, 662.9602223866583, 663.8970959501285, 839.9076101628847, 581.7004242814953, 600.570592026703, 600.5945986459122, 602.5812060617873, 602.6444397805273, 12546.686332841751, 12575.622731318075, 12963.287019214034, 13001.86998130016, 13048.217106973612, 12133.393330333536, 12895.613131606067, 12943.67640808978, 12987.935060324733, 13215.33923303831, 11877.22798018126, 11996.70008249792, 12099.697507562294, 12141.878581214163, 12349.5060197592, 3190.8521644432208, 3319.9834000830083, 3327.617324007722, 3361.983190084034, 4192.685548583869, 59078.40921590772, 59543.702281488746, 60037.6998115011, 60406.0, 61231.38768612346, 10526.684199474028, 10588.470576471145, 10923.508442120125, 10943.562257509611, 11235.66293011211, 18967.33614323492, 19017.524561885788, 19035.238590456225, 19189.61620767577, 19192.040397980047, 6870.965645171742, 6979.546329488567, 7028.472864535181, 7059.647017649097, 7210.891836622455, 3697.149655579232, 3789.412641040643, 3810.0855794609647, 3854.8265328060306, 3900.863469778544, 3015.1557563882147, 3098.209956461088, 3110.9688903111132, 3114.6106736657916, 3131.8434078295995, 531.452603818068, 538.0315432221985, 538.5449295345427, 542.2760614579502, 543.5026950340394, 443.85574688226455, 480.96152307815294, 508.41786154852485, 568.9260396148557, 574.3165632896839, 7468.9626551866895, 7672.232776722395, 7801.45389822707, 8001.8399632008195, 8063.072746634095, 556.629841155627, 565.3046752494455, 586.7330364684059, 601.8555546668767, 603.6528995827417, 3435.261418794971, 3542.6457354264367, 3555.8577656893435, 3615.3492371373404, 3647.94528082079, 91819.5409022964, 91881.0, 94159.0, 96879.0, 98244.0, 80605.59697201593, 82010.0, 84401.0, 85051.0, 86020.56989715011, 61353.0, 73269.0, 76354.6182269074, 77458.2254177451, 79586.60206698929, 8084.83830323402, 8170.428070035278, 8245.715539771989, 8514.91485085166, 8718.346124040596, 39760.60239397569, 40185.0, 41831.581684183984, 41841.79079104585, 42366.78816605897, 56610.71694641501, 60272.69863650654, 60474.69762651159, 60839.39160608514, 61388.0, 10702.89297107019, 10817.837732433862, 11068.16988725865, 11589.072874170215, 11650.76698466009, 12239.0, 12266.693332666755, 12720.300383478627, 12782.105252632227, 12848.550300739429, 11359.261647992855, 11869.703257418289, 11891.82162267584, 12268.509259629514, 12491.063170262085, 11204.66386008421, 11393.658190254306, 11411.885881141414, 11416.543338266376, 11470.770584588428, 10975.890241097486, 10979.835302470628, 11096.33421994683, 11139.721506962067, 11377.146713996317, 9278.9536052322, 9563.139317461462, 9737.9026209737, 9824.0, 9926.057024582653, 8944.776380590538, 9095.408798428081, 9174.770630734285, 9201.125893040151, 9257.120573545502], "value": 6503.50603642634, "unit": "score"}], "name": "dromaeo_css", "value": 6406.128605062915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 115.0, 113.0, 113.0, 114.0, 111.0, 112.0, 111.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 130.0, 187.0, 131.0, 130.0, 160.0, 137.0, 190.0, 130.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 162.0, 160.0, 162.0, 161.0, 164.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 109.0, 75.0, 77.0, 76.0, 77.0, 102.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 127.0, 86.0, 85.0, 87.0, 119.0, 86.0, 87.0, 119.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 119.0, 119.0, 119.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 148.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0, 66.0, 67.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 82.0, 82.0, 84.0, 84.0, 87.0, 88.0, 108.0, 83.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 130.0, 131.0, 134.0, 130.0, 133.0, 147.0, 139.0, 138.0, 128.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 171.0, 171.0, 170.0, 170.0, 176.0, 173.0, 178.0, 170.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 70.0, 67.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1551.4, "alertThreshold": 2.0}]} 13:43:31 INFO - Return code: 0 13:43:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:43:31 INFO - # TBPL SUCCESS # 13:43:31 INFO - Running post-action listener: _resource_record_post_action 13:43:31 INFO - ##### 13:43:31 INFO - ##### Finished run-tests step (success) 13:43:31 INFO - ##### 13:43:31 INFO - Running post-run listener: _resource_record_post_run 13:43:32 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 73728; Write bytes: 541052928; Read time: 20; Write time: 434156 13:43:32 INFO - TinderboxPrint: CPU usage
13.1% 13:43:32 INFO - TinderboxPrint: I/O read bytes / time
73,728 / 20 13:43:32 INFO - TinderboxPrint: I/O write bytes / time
541,052,928 / 434,156 13:43:32 INFO - TinderboxPrint: CPU idle
8,323.8 (86.8%) 13:43:32 INFO - TinderboxPrint: CPU user
1,214.3 (12.7%) 13:43:32 INFO - TinderboxPrint: Swap in / out
0 / 0 13:43:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 257507328; Read time: 0; Write time: 241240 13:43:32 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 73728; Write bytes: 283545600; Read time: 20; Write time: 192916 13:43:32 INFO - Running post-run listener: _upload_blobber_files 13:43:32 INFO - Blob upload gear active. 13:43:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:43:32 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 13:43:32 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'] 13:43:32 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 13:43:33 INFO - (blobuploader) - INFO - Open directory for files ... 13:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:33 INFO - (blobuploader) - INFO - Done attempting. 13:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:37 INFO - (blobuploader) - INFO - Done attempting. 13:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:43:37 INFO - (blobuploader) - INFO - Done attempting. 13:43:37 INFO - (blobuploader) - INFO - Iteration through files over. 13:43:37 INFO - Return code: 0 13:43:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:43:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:43:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d405aa5748d493966e8f1a064f0089873f6388059a0099d0fa6cb9b0788db2780ea0803ce8ed1f828abb65b113a1d620228a91f02f92690e01840eea1869c280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05a5d1635e14e05ffd6db5f86f91cc16278ef542b0b3785127f9084d55175525c30f53360ca3aa9295799e1de7259f23e7f9bda48f6ceb9b8ce0538f241ea1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa290d4941823d8010ad875b849c4fcd3ef6b3d0cca5955accbcbf2b54ebfc3c5c1746e81a9eb64610885c26920461b14af584a66d4973e007698f3525330527"} 13:43:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:43:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:43:37 INFO - Contents: 13:43:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d405aa5748d493966e8f1a064f0089873f6388059a0099d0fa6cb9b0788db2780ea0803ce8ed1f828abb65b113a1d620228a91f02f92690e01840eea1869c280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05a5d1635e14e05ffd6db5f86f91cc16278ef542b0b3785127f9084d55175525c30f53360ca3aa9295799e1de7259f23e7f9bda48f6ceb9b8ce0538f241ea1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa290d4941823d8010ad875b849c4fcd3ef6b3d0cca5955accbcbf2b54ebfc3c5c1746e81a9eb64610885c26920461b14af584a66d4973e007698f3525330527"} 13:43:37 INFO - Running post-run listener: copy_logs_to_upload_dir 13:43:37 INFO - Copying logs to upload dir... 13:43:37 INFO - mkdir: /builds/slave/test/build/upload/logs 13:43:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.941512 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-24 13:43:37.983538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 13:43:37.986960) ========= 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=6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188 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/d405aa5748d493966e8f1a064f0089873f6388059a0099d0fa6cb9b0788db2780ea0803ce8ed1f828abb65b113a1d620228a91f02f92690e01840eea1869c280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05a5d1635e14e05ffd6db5f86f91cc16278ef542b0b3785127f9084d55175525c30f53360ca3aa9295799e1de7259f23e7f9bda48f6ceb9b8ce0538f241ea1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa290d4941823d8010ad875b849c4fcd3ef6b3d0cca5955accbcbf2b54ebfc3c5c1746e81a9eb64610885c26920461b14af584a66d4973e007698f3525330527"} build_url:https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/cO3Vbm5uTeK_1YhQ2mAtjw/artifacts/public/build/firefox-50.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/d405aa5748d493966e8f1a064f0089873f6388059a0099d0fa6cb9b0788db2780ea0803ce8ed1f828abb65b113a1d620228a91f02f92690e01840eea1869c280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/05a5d1635e14e05ffd6db5f86f91cc16278ef542b0b3785127f9084d55175525c30f53360ca3aa9295799e1de7259f23e7f9bda48f6ceb9b8ce0538f241ea1a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa290d4941823d8010ad875b849c4fcd3ef6b3d0cca5955accbcbf2b54ebfc3c5c1746e81a9eb64610885c26920461b14af584a66d4973e007698f3525330527"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 13:43:38.012869) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:43:38.013197) ========= 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=6dbc10da6d83fee962c624be000001a8-1466799775.178579-1237728188 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 13:43:38.097644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 13:43:38.098016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 13:43:38.098534) ========= ========= Total master_lag: 0.18 =========