builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1465488315.68 results: success (0) buildid: 20160609082929 builduid: 81ccf73b36bd41218424baecddad7816 revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.676937) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.677353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.677638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.711133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.711388) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 09:05:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2016-06-09 09:05:16 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.850234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.853551) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018184 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.905512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:15.905827) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1c88261bd7310a5837cccffc767df53737fd9ce --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 f1c88261bd7310a5837cccffc767df53737fd9ce --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=516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 09:05:16,411 truncating revision to first 12 chars 2016-06-09 09:05:16,411 Setting DEBUG logging. 2016-06-09 09:05:16,411 attempt 1/10 2016-06-09 09:05:16,411 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1c88261bd73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 09:05:16,758 unpacking tar archive at: fx-team-f1c88261bd73/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695416 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:16.616852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:16.617134) ========= script_repo_revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:16.617581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:16.617902) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 09:05:16.636980) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-09 09:05:16.637329) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:17 INFO - MultiFileLogger online at 20160609 09:05:17 in /builds/slave/test 09:05:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:05:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:17 INFO - {'append_to_log': False, 09:05:17 INFO - 'base_work_dir': '/builds/slave/test', 09:05:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:05:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:17 INFO - 'branch': 'Fx-Team-Non-PGO', 09:05:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:17 INFO - 'config_files': ('talos/linux_config.py',), 09:05:17 INFO - 'default_actions': ('clobber', 09:05:17 INFO - 'read-buildbot-config', 09:05:17 INFO - 'download-and-extract', 09:05:17 INFO - 'populate-webroot', 09:05:17 INFO - 'create-virtualenv', 09:05:17 INFO - 'install', 09:05:17 INFO - 'run-tests'), 09:05:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:17 INFO - 'download_minidump_stackwalk': True, 09:05:17 INFO - 'download_symbols': 'ondemand', 09:05:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:17 INFO - 'installer_path': 'installer.exe', 09:05:17 INFO - 'log_level': 'info', 09:05:17 INFO - 'log_name': 'talos', 09:05:17 INFO - 'log_to_console': True, 09:05:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:17 INFO - 'opt_config_files': (), 09:05:17 INFO - 'pip_index': False, 09:05:17 INFO - 'sps_profile': False, 09:05:17 INFO - 'sps_profile_interval': 0, 09:05:17 INFO - 'suite': 'dromaeojs', 09:05:17 INFO - 'system_bits': '32', 09:05:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:17 INFO - 'title': 'talos-linux64-ix-061', 09:05:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:17 INFO - 'use_talos_json': True, 09:05:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:17 INFO - 'work_dir': 'build'} 09:05:17 INFO - ##### 09:05:17 INFO - ##### Running clobber step. 09:05:17 INFO - ##### 09:05:17 INFO - Running pre-action listener: _resource_record_pre_action 09:05:17 INFO - Running main action method: clobber 09:05:17 INFO - rmtree: /builds/slave/test/build 09:05:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:18 INFO - Running post-action listener: _resource_record_post_action 09:05:18 INFO - ##### 09:05:18 INFO - ##### Finished clobber step (success) 09:05:18 INFO - ##### 09:05:18 INFO - ##### 09:05:18 INFO - ##### Running read-buildbot-config step. 09:05:18 INFO - ##### 09:05:18 INFO - Running pre-action listener: _resource_record_pre_action 09:05:18 INFO - Running main action method: read_buildbot_config 09:05:18 INFO - Using buildbot properties: 09:05:18 INFO - { 09:05:18 INFO - "project": "", 09:05:18 INFO - "product": "firefox", 09:05:18 INFO - "script_repo_revision": "production", 09:05:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:05:18 INFO - "repository": "", 09:05:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:05:18 INFO - "buildid": "20160609082929", 09:05:18 INFO - "pgo_build": "False", 09:05:18 INFO - "basedir": "/builds/slave/test", 09:05:18 INFO - "buildnumber": 1837, 09:05:18 INFO - "slavename": "talos-linux64-ix-061", 09:05:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:05:18 INFO - "platform": "ubuntu64_hw", 09:05:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:05:18 INFO - "branch": "fx-team", 09:05:18 INFO - "repo_path": "integration/fx-team", 09:05:18 INFO - "revision": "f1c88261bd7310a5837cccffc767df53737fd9ce", 09:05:18 INFO - "stage_platform": "linux64", 09:05:18 INFO - "builduid": "81ccf73b36bd41218424baecddad7816", 09:05:18 INFO - "slavebuilddir": "test" 09:05:18 INFO - } 09:05:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:05:18 INFO - Running post-action listener: _resource_record_post_action 09:05:18 INFO - ##### 09:05:18 INFO - ##### Finished read-buildbot-config step (success) 09:05:18 INFO - ##### 09:05:18 INFO - ##### 09:05:18 INFO - ##### Running download-and-extract step. 09:05:18 INFO - ##### 09:05:18 INFO - Running pre-action listener: _resource_record_pre_action 09:05:18 INFO - Running main action method: download_and_extract 09:05:18 INFO - mkdir: /builds/slave/test/build/tests 09:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:18 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:05:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:05:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:05:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:25 INFO - Downloaded 1361 bytes. 09:05:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:05:25 INFO - Using the following test package requirements: 09:05:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:05:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:05:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'jsshell-linux-x86_64.zip'], 09:05:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:05:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:05:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:05:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:05:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:05:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:05:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:05:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:25 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:05:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:32 INFO - Downloaded 22879604 bytes. 09:05:32 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'] 09:05:32 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 09:05:33 INFO - Return code: 0 09:05:33 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 09:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:33 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:05:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:05:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:36 INFO - Downloaded 22879604 bytes. 09:05:36 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'] 09:05:36 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 09:05:38 INFO - Return code: 0 09:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:38 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:05:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:05:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:05:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:39 INFO - Downloaded 10833377 bytes. 09:05:39 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'] 09:05:39 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 09:05:39 INFO - Return code: 0 09:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:39 INFO - https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:05:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVakswhjR2WtCuI7Kw8wVg/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 09:05:40 INFO - Downloaded 55366398 bytes. 09:05:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:40 INFO - mkdir: /builds/slave/test/properties 09:05:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:40 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:40 INFO - Contents: 09:05:40 INFO - build_url:https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:05:41 INFO - Running post-action listener: _resource_record_post_action 09:05:41 INFO - Running post-action listener: set_extra_try_arguments 09:05:41 INFO - ##### 09:05:41 INFO - ##### Finished download-and-extract step (success) 09:05:41 INFO - ##### 09:05:41 INFO - ##### 09:05:41 INFO - ##### Running populate-webroot step. 09:05:41 INFO - ##### 09:05:41 INFO - Running pre-action listener: _resource_record_pre_action 09:05:41 INFO - Running main action method: populate_webroot 09:05:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:41 INFO - '--tppagecycles', 09:05:41 INFO - '7'], 09:05:41 INFO - 'tests': ['tsvgm']}}, 09:05:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['damp', 'tps']}, 09:05:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'tests': ['damp', 'tps']}, 09:05:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['dromaeo_dom']}, 09:05:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['a11yr', 09:05:41 INFO - 'ts_paint', 09:05:41 INFO - 'tpaint', 09:05:41 INFO - 'sessionrestore', 09:05:41 INFO - 'sessionrestore_no_auto_restore', 09:05:41 INFO - 'tabpaint']}, 09:05:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:41 INFO - 'ts_paint', 09:05:41 INFO - 'tpaint', 09:05:41 INFO - 'sessionrestore', 09:05:41 INFO - 'sessionrestore_no_auto_restore', 09:05:41 INFO - 'tabpaint']}, 09:05:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:41 INFO - 'ts_paint', 09:05:41 INFO - 'tpaint', 09:05:41 INFO - 'sessionrestore', 09:05:41 INFO - 'sessionrestore_no_auto_restore', 09:05:41 INFO - 'tabpaint']}, 09:05:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:41 INFO - 'ts_paint', 09:05:41 INFO - 'tpaint', 09:05:41 INFO - 'sessionrestore', 09:05:41 INFO - 'sessionrestore_no_auto_restore', 09:05:41 INFO - 'tabpaint']}, 09:05:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['a11yr', 09:05:41 INFO - 'ts_paint', 09:05:41 INFO - 'tpaint', 09:05:41 INFO - 'sessionrestore', 09:05:41 INFO - 'sessionrestore_no_auto_restore', 09:05:41 INFO - 'tabpaint']}, 09:05:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['a11yr', 09:05:41 INFO - 'ts_paint', 09:05:41 INFO - 'tpaint', 09:05:41 INFO - 'sessionrestore', 09:05:41 INFO - 'sessionrestore_no_auto_restore', 09:05:41 INFO - 'tabpaint']}, 09:05:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['tsvgx', 09:05:41 INFO - 'tsvgr_opacity', 09:05:41 INFO - 'tart', 09:05:41 INFO - 'tscrollx', 09:05:41 INFO - 'cart']}, 09:05:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:41 INFO - 'tsvgr_opacity', 09:05:41 INFO - 'tart', 09:05:41 INFO - 'tscrollx', 09:05:41 INFO - 'cart']}, 09:05:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'talos_options': ['--disable-e10s'], 09:05:41 INFO - 'tests': ['tp5o']}, 09:05:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'tests': ['tp5o']}, 09:05:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'talos_options': ['--disable-e10s', 09:05:41 INFO - '--xperf_path', 09:05:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:41 INFO - 'tests': ['tp5n']}, 09:05:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:41 INFO - 'talos_options': ['--xperf_path', 09:05:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:41 INFO - 'tests': ['tp5n']}}, 09:05:41 INFO - 'talos.zip': {'path': '', 09:05:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:41 INFO - Running post-action listener: _resource_record_post_action 09:05:41 INFO - ##### 09:05:41 INFO - ##### Finished populate-webroot step (success) 09:05:41 INFO - ##### 09:05:41 INFO - ##### 09:05:41 INFO - ##### Running create-virtualenv step. 09:05:41 INFO - ##### 09:05:41 INFO - Running pre-action listener: _resource_record_pre_action 09:05:41 INFO - Running main action method: create_virtualenv 09:05:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:05:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:41 INFO - Using real prefix '/usr' 09:05:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:42 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:44 INFO - Installing pip.................done. 09:05:44 INFO - Return code: 0 09:05:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:44 INFO - Using env: {'DISPLAY': ':0', 09:05:44 INFO - 'HOME': '/home/cltbld', 09:05:44 INFO - 'LANG': 'en_US.UTF-8', 09:05:44 INFO - 'LANGUAGE': 'en_US:en', 09:05:44 INFO - 'LOGNAME': 'cltbld', 09:05:44 INFO - 'MAIL': '/var/mail/cltbld', 09:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:44 INFO - 'MOZ_NO_REMOTE': '1', 09:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:44 INFO - 'NO_EM_RESTART': '1', 09:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:44 INFO - 'PWD': '/builds/slave/test', 09:05:44 INFO - 'SHELL': '/bin/bash', 09:05:44 INFO - 'SHLVL': '1', 09:05:44 INFO - 'TERM': 'linux', 09:05:44 INFO - 'TMOUT': '86400', 09:05:44 INFO - 'USER': 'cltbld', 09:05:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:44 INFO - '_': '/tools/buildbot/bin/python'} 09:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:05:44 INFO - Cleaning up... 09:05:44 INFO - Return code: 0 09:05:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:05:44 INFO - Using env: {'DISPLAY': ':0', 09:05:44 INFO - 'HOME': '/home/cltbld', 09:05:44 INFO - 'LANG': 'en_US.UTF-8', 09:05:44 INFO - 'LANGUAGE': 'en_US:en', 09:05:44 INFO - 'LOGNAME': 'cltbld', 09:05:44 INFO - 'MAIL': '/var/mail/cltbld', 09:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:44 INFO - 'MOZ_NO_REMOTE': '1', 09:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:44 INFO - 'NO_EM_RESTART': '1', 09:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:44 INFO - 'PWD': '/builds/slave/test', 09:05:44 INFO - 'SHELL': '/bin/bash', 09:05:44 INFO - 'SHLVL': '1', 09:05:44 INFO - 'TERM': 'linux', 09:05:44 INFO - 'TMOUT': '86400', 09:05:44 INFO - 'USER': 'cltbld', 09:05:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:44 INFO - '_': '/tools/buildbot/bin/python'} 09:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:44 INFO - Downloading/unpacking psutil>=3.1.1 09:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:46 INFO - Installing collected packages: psutil 09:05:46 INFO - Running setup.py install for psutil 09:05:46 INFO - building 'psutil._psutil_linux' extension 09:05:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:05:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:05:47 INFO - building 'psutil._psutil_posix' extension 09:05:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:05:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:05:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:47 INFO - Successfully installed psutil 09:05:47 INFO - Cleaning up... 09:05:47 INFO - Return code: 0 09:05:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:05:47 INFO - Using env: {'DISPLAY': ':0', 09:05:47 INFO - 'HOME': '/home/cltbld', 09:05:47 INFO - 'LANG': 'en_US.UTF-8', 09:05:47 INFO - 'LANGUAGE': 'en_US:en', 09:05:47 INFO - 'LOGNAME': 'cltbld', 09:05:47 INFO - 'MAIL': '/var/mail/cltbld', 09:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:47 INFO - 'MOZ_NO_REMOTE': '1', 09:05:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:47 INFO - 'NO_EM_RESTART': '1', 09:05:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:47 INFO - 'PWD': '/builds/slave/test', 09:05:47 INFO - 'SHELL': '/bin/bash', 09:05:47 INFO - 'SHLVL': '1', 09:05:47 INFO - 'TERM': 'linux', 09:05:47 INFO - 'TMOUT': '86400', 09:05:47 INFO - 'USER': 'cltbld', 09:05:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:47 INFO - '_': '/tools/buildbot/bin/python'} 09:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:49 INFO - Installing collected packages: mozsystemmonitor 09:05:49 INFO - Running setup.py install for mozsystemmonitor 09:05:49 INFO - Successfully installed mozsystemmonitor 09:05:49 INFO - Cleaning up... 09:05:49 INFO - Return code: 0 09:05:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:49 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 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:49 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 09:05:49 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 09:05:49 INFO - Using env: {'DISPLAY': ':0', 09:05:49 INFO - 'HOME': '/home/cltbld', 09:05:49 INFO - 'LANG': 'en_US.UTF-8', 09:05:49 INFO - 'LANGUAGE': 'en_US:en', 09:05:49 INFO - 'LOGNAME': 'cltbld', 09:05:49 INFO - 'MAIL': '/var/mail/cltbld', 09:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:49 INFO - 'MOZ_NO_REMOTE': '1', 09:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:49 INFO - 'NO_EM_RESTART': '1', 09:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:49 INFO - 'PWD': '/builds/slave/test', 09:05:49 INFO - 'SHELL': '/bin/bash', 09:05:49 INFO - 'SHLVL': '1', 09:05:49 INFO - 'TERM': 'linux', 09:05:49 INFO - 'TMOUT': '86400', 09:05:49 INFO - 'USER': 'cltbld', 09:05:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:49 INFO - '_': '/tools/buildbot/bin/python'} 09:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:49 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:51 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:52 INFO - warning: no files found matching '*.txt' 09:05:52 INFO - no previously-included directories found matching 'build' 09:05:52 INFO - no previously-included directories found matching 'dist' 09:05:52 INFO - no previously-included directories found matching '.git*' 09:05:52 INFO - Installing collected packages: jsonschema, functools32 09:05:52 INFO - Running setup.py install for functools32 09:05:52 INFO - warning: no files found matching '*.txt' 09:05:52 INFO - no previously-included directories found matching 'build' 09:05:52 INFO - no previously-included directories found matching 'dist' 09:05:52 INFO - no previously-included directories found matching '.git*' 09:05:52 INFO - Successfully installed jsonschema functools32 09:05:52 INFO - Cleaning up... 09:05:52 INFO - Return code: 0 09:05:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:52 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 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:05:52 INFO - Using env: {'DISPLAY': ':0', 09:05:52 INFO - 'HOME': '/home/cltbld', 09:05:52 INFO - 'LANG': 'en_US.UTF-8', 09:05:52 INFO - 'LANGUAGE': 'en_US:en', 09:05:52 INFO - 'LOGNAME': 'cltbld', 09:05:52 INFO - 'MAIL': '/var/mail/cltbld', 09:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:52 INFO - 'MOZ_NO_REMOTE': '1', 09:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:52 INFO - 'NO_EM_RESTART': '1', 09:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:52 INFO - 'PWD': '/builds/slave/test', 09:05:52 INFO - 'SHELL': '/bin/bash', 09:05:52 INFO - 'SHLVL': '1', 09:05:52 INFO - 'TERM': 'linux', 09:05:52 INFO - 'TMOUT': '86400', 09:05:52 INFO - 'USER': 'cltbld', 09:05:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:52 INFO - '_': '/tools/buildbot/bin/python'} 09:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:55 INFO - Downloading docopt-0.6.1.tar.gz 09:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:55 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:55 INFO - Running setup.py install for blobuploader 09:05:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:55 INFO - Running setup.py install for requests 09:05:55 INFO - Running setup.py install for docopt 09:05:55 INFO - Successfully installed blobuploader requests docopt 09:05:55 INFO - Cleaning up... 09:05:55 INFO - Return code: 0 09:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:55 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 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:55 INFO - Using env: {'DISPLAY': ':0', 09:05:55 INFO - 'HOME': '/home/cltbld', 09:05:55 INFO - 'LANG': 'en_US.UTF-8', 09:05:55 INFO - 'LANGUAGE': 'en_US:en', 09:05:55 INFO - 'LOGNAME': 'cltbld', 09:05:55 INFO - 'MAIL': '/var/mail/cltbld', 09:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:55 INFO - 'MOZ_NO_REMOTE': '1', 09:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:55 INFO - 'NO_EM_RESTART': '1', 09:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:55 INFO - 'PWD': '/builds/slave/test', 09:05:55 INFO - 'SHELL': '/bin/bash', 09:05:55 INFO - 'SHLVL': '1', 09:05:55 INFO - 'TERM': 'linux', 09:05:55 INFO - 'TMOUT': '86400', 09:05:55 INFO - 'USER': 'cltbld', 09:05:55 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:55 INFO - '_': '/tools/buildbot/bin/python'} 09:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:55 INFO - Running setup.py (path:/tmp/pip-Q83Ulq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:56 INFO - Running setup.py (path:/tmp/pip-3oMfS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:56 INFO - Running setup.py (path:/tmp/pip-SwGRYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:56 INFO - Running setup.py (path:/tmp/pip-oWfpEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:56 INFO - Running setup.py (path:/tmp/pip-PSa4Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:56 INFO - Running setup.py (path:/tmp/pip-8FuibB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:56 INFO - Running setup.py (path:/tmp/pip-K7AmNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:56 INFO - Running setup.py (path:/tmp/pip-7ZtUSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:56 INFO - Running setup.py (path:/tmp/pip-x2UQit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:56 INFO - Running setup.py (path:/tmp/pip-WS0_NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:56 INFO - Running setup.py (path:/tmp/pip-sS7yaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:56 INFO - Running setup.py (path:/tmp/pip-I6N3ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:56 INFO - Running setup.py (path:/tmp/pip-gzAgDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:56 INFO - Running setup.py (path:/tmp/pip-mtdMKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:57 INFO - Running setup.py (path:/tmp/pip-1G27t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:57 INFO - Running setup.py (path:/tmp/pip-805N5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:57 INFO - Running setup.py (path:/tmp/pip-BXNHMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:57 INFO - Running setup.py install for manifestparser 09:05:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:57 INFO - Running setup.py install for mozcrash 09:05:57 INFO - Running setup.py install for mozdebug 09:05:57 INFO - Running setup.py install for mozdevice 09:05:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:57 INFO - Running setup.py install for mozfile 09:05:57 INFO - Running setup.py install for mozhttpd 09:05:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:57 INFO - Running setup.py install for mozinfo 09:05:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:57 INFO - Running setup.py install for mozInstall 09:05:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Running setup.py install for mozleak 09:05:58 INFO - Running setup.py install for mozlog 09:05:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Running setup.py install for moznetwork 09:05:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Running setup.py install for mozprocess 09:05:58 INFO - Running setup.py install for mozprofile 09:05:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Running setup.py install for mozrunner 09:05:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:58 INFO - Running setup.py install for mozscreenshot 09:05:58 INFO - Running setup.py install for moztest 09:05:58 INFO - Running setup.py install for mozversion 09:05:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:59 INFO - Cleaning up... 09:05:59 INFO - Return code: 0 09:05:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:59 INFO - Using env: {'DISPLAY': ':0', 09:05:59 INFO - 'HOME': '/home/cltbld', 09:05:59 INFO - 'LANG': 'en_US.UTF-8', 09:05:59 INFO - 'LANGUAGE': 'en_US:en', 09:05:59 INFO - 'LOGNAME': 'cltbld', 09:05:59 INFO - 'MAIL': '/var/mail/cltbld', 09:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:59 INFO - 'MOZ_NO_REMOTE': '1', 09:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:59 INFO - 'NO_EM_RESTART': '1', 09:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:59 INFO - 'PWD': '/builds/slave/test', 09:05:59 INFO - 'SHELL': '/bin/bash', 09:05:59 INFO - 'SHLVL': '1', 09:05:59 INFO - 'TERM': 'linux', 09:05:59 INFO - 'TMOUT': '86400', 09:05:59 INFO - 'USER': 'cltbld', 09:05:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:59 INFO - '_': '/tools/buildbot/bin/python'} 09:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:59 INFO - Running setup.py (path:/tmp/pip-pqZMyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:59 INFO - Running setup.py (path:/tmp/pip-axiFgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:59 INFO - Running setup.py (path:/tmp/pip-FbExxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:59 INFO - Running setup.py (path:/tmp/pip-Ueah4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:59 INFO - Running setup.py (path:/tmp/pip-H7_vNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:59 INFO - Running setup.py (path:/tmp/pip-ehI_Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:59 INFO - Running setup.py (path:/tmp/pip-YhANKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:59 INFO - Running setup.py (path:/tmp/pip-hrHR4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:59 INFO - Running setup.py (path:/tmp/pip-u9B2hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:59 INFO - Running setup.py (path:/tmp/pip-UXEhmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:59 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)) 09:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:59 INFO - Running setup.py (path:/tmp/pip-89jGa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:00 INFO - Running setup.py (path:/tmp/pip-b2CV70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:00 INFO - Running setup.py (path:/tmp/pip-n_TcXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:00 INFO - Running setup.py (path:/tmp/pip-LNAoUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:00 INFO - Running setup.py (path:/tmp/pip-Zj3HOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:00 INFO - Running setup.py (path:/tmp/pip-rQaZDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:00 INFO - Running setup.py (path:/tmp/pip-07wccx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:02 INFO - Downloading blessings-1.6.tar.gz 09:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:02 INFO - Installing collected packages: blessings 09:06:02 INFO - Running setup.py install for blessings 09:06:02 INFO - Successfully installed blessings 09:06:02 INFO - Cleaning up... 09:06:02 INFO - Return code: 0 09:06:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:03 INFO - Reading from file tmpfile_stdout 09:06:03 INFO - Current package versions: 09:06:03 INFO - argparse == 1.2.1 09:06:03 INFO - blessings == 1.6 09:06:03 INFO - blobuploader == 1.2.4 09:06:03 INFO - docopt == 0.6.1 09:06:03 INFO - functools32 == 3.2.3-2 09:06:03 INFO - jsonschema == 2.5.1 09:06:03 INFO - manifestparser == 1.1 09:06:03 INFO - mozInstall == 1.12 09:06:03 INFO - mozcrash == 0.17 09:06:03 INFO - mozdebug == 0.1 09:06:03 INFO - mozdevice == 0.48 09:06:03 INFO - mozfile == 1.2 09:06:03 INFO - mozhttpd == 0.7 09:06:03 INFO - mozinfo == 0.9 09:06:03 INFO - mozleak == 0.1 09:06:03 INFO - mozlog == 3.2 09:06:03 INFO - moznetwork == 0.27 09:06:03 INFO - mozprocess == 0.22 09:06:03 INFO - mozprofile == 0.28 09:06:03 INFO - mozrunner == 6.11 09:06:03 INFO - mozscreenshot == 0.1 09:06:03 INFO - mozsystemmonitor == 0.3 09:06:03 INFO - moztest == 0.7 09:06:03 INFO - mozversion == 1.4 09:06:03 INFO - psutil == 3.1.1 09:06:03 INFO - requests == 1.2.3 09:06:03 INFO - wsgiref == 0.1.2 09:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:03 INFO - Using env: {'DISPLAY': ':0', 09:06:03 INFO - 'HOME': '/home/cltbld', 09:06:03 INFO - 'LANG': 'en_US.UTF-8', 09:06:03 INFO - 'LANGUAGE': 'en_US:en', 09:06:03 INFO - 'LOGNAME': 'cltbld', 09:06:03 INFO - 'MAIL': '/var/mail/cltbld', 09:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:03 INFO - 'MOZ_NO_REMOTE': '1', 09:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:03 INFO - 'NO_EM_RESTART': '1', 09:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:03 INFO - 'PWD': '/builds/slave/test', 09:06:03 INFO - 'SHELL': '/bin/bash', 09:06:03 INFO - 'SHLVL': '1', 09:06:03 INFO - 'TERM': 'linux', 09:06:03 INFO - 'TMOUT': '86400', 09:06:03 INFO - 'USER': 'cltbld', 09:06:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:03 INFO - '_': '/tools/buildbot/bin/python'} 09:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:06:03 INFO - Cleaning up... 09:06:03 INFO - Return code: 0 09:06:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:06:03 INFO - Using env: {'DISPLAY': ':0', 09:06:03 INFO - 'HOME': '/home/cltbld', 09:06:03 INFO - 'LANG': 'en_US.UTF-8', 09:06:03 INFO - 'LANGUAGE': 'en_US:en', 09:06:03 INFO - 'LOGNAME': 'cltbld', 09:06:03 INFO - 'MAIL': '/var/mail/cltbld', 09:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:03 INFO - 'MOZ_NO_REMOTE': '1', 09:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:03 INFO - 'NO_EM_RESTART': '1', 09:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:03 INFO - 'PWD': '/builds/slave/test', 09:06:03 INFO - 'SHELL': '/bin/bash', 09:06:03 INFO - 'SHLVL': '1', 09:06:03 INFO - 'TERM': 'linux', 09:06:03 INFO - 'TMOUT': '86400', 09:06:03 INFO - 'USER': 'cltbld', 09:06:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:03 INFO - '_': '/tools/buildbot/bin/python'} 09:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:03 INFO - Cleaning up... 09:06:03 INFO - Return code: 0 09:06:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0950a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:06:03 INFO - Using env: {'DISPLAY': ':0', 09:06:03 INFO - 'HOME': '/home/cltbld', 09:06:03 INFO - 'LANG': 'en_US.UTF-8', 09:06:03 INFO - 'LANGUAGE': 'en_US:en', 09:06:03 INFO - 'LOGNAME': 'cltbld', 09:06:03 INFO - 'MAIL': '/var/mail/cltbld', 09:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:03 INFO - 'MOZ_NO_REMOTE': '1', 09:06:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:03 INFO - 'NO_EM_RESTART': '1', 09:06:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:03 INFO - 'PWD': '/builds/slave/test', 09:06:03 INFO - 'SHELL': '/bin/bash', 09:06:03 INFO - 'SHLVL': '1', 09:06:03 INFO - 'TERM': 'linux', 09:06:03 INFO - 'TMOUT': '86400', 09:06:03 INFO - 'USER': 'cltbld', 09:06:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:03 INFO - '_': '/tools/buildbot/bin/python'} 09:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:03 INFO - Downloading/unpacking flake8 09:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:06:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:06:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:06:06 INFO - no previously-included directories found matching 'docs/_build' 09:06:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:06:06 INFO - Running setup.py install for pep8 09:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:06:06 INFO - no previously-included directories found matching 'docs/_build' 09:06:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:06:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:06:06 INFO - Cleaning up... 09:06:06 INFO - Return code: 0 09:06:06 INFO - Running post-action listener: _resource_record_post_action 09:06:06 INFO - Running post-action listener: _start_resource_monitoring 09:06:06 INFO - Starting resource monitoring. 09:06:06 INFO - ##### 09:06:06 INFO - ##### Finished create-virtualenv step (success) 09:06:06 INFO - ##### 09:06:06 INFO - ##### 09:06:06 INFO - ##### Running install step. 09:06:06 INFO - ##### 09:06:06 INFO - Running pre-action listener: _resource_record_pre_action 09:06:06 INFO - Running main action method: install 09:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:06 INFO - Reading from file tmpfile_stdout 09:06:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:06 INFO - Reading from file tmpfile_stdout 09:06:06 INFO - Output received: 09:06:06 INFO - Usage: mozinstall [options] installer 09:06:06 INFO - Options: 09:06:06 INFO - -h, --help show this help message and exit 09:06:06 INFO - -d DEST, --destination=DEST 09:06:06 INFO - Directory to install application into. [default: 09:06:06 INFO - "/builds/slave/test"] 09:06:06 INFO - --app=APP Application being installed. [default: firefox] 09:06:06 INFO - mkdir: /builds/slave/test/build/application 09:06:06 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'] 09:06:06 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 09:06:22 INFO - Reading from file tmpfile_stdout 09:06:22 INFO - Output received: 09:06:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:06:22 INFO - Running post-action listener: _resource_record_post_action 09:06:22 INFO - ##### 09:06:22 INFO - ##### Finished install step (success) 09:06:22 INFO - ##### 09:06:22 INFO - ##### 09:06:22 INFO - ##### Running run-tests step. 09:06:22 INFO - ##### 09:06:22 INFO - Running pre-action listener: _resource_record_pre_action 09:06:22 INFO - Running main action method: run_tests 09:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:22 INFO - Python 2.7.3 09:06:22 INFO - Return code: 0 09:06:22 INFO - grabbing minidump binary from tooltool 09:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:06:22 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 0xfd71c0>, '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 0xfd80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfd8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:06:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:06:22 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 09:06:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:23 INFO - Return code: 0 09:06:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:06:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:06:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:06:23 INFO - Return code: 0 09:06:23 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/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:06:23 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/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:06:23 INFO - Using env: {'DISPLAY': ':0', 09:06:23 INFO - 'HOME': '/home/cltbld', 09:06:23 INFO - 'LANG': 'en_US.UTF-8', 09:06:23 INFO - 'LANGUAGE': 'en_US:en', 09:06:23 INFO - 'LOGNAME': 'cltbld', 09:06:23 INFO - 'MAIL': '/var/mail/cltbld', 09:06:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:23 INFO - 'MOZ_NO_REMOTE': '1', 09:06:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:06:23 INFO - 'NO_EM_RESTART': '1', 09:06:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:23 INFO - 'PWD': '/builds/slave/test', 09:06:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:23 INFO - 'SHELL': '/bin/bash', 09:06:23 INFO - 'SHLVL': '1', 09:06:23 INFO - 'TERM': 'linux', 09:06:23 INFO - 'TMOUT': '86400', 09:06:23 INFO - 'USER': 'cltbld', 09:06:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881', 09:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:23 INFO - '_': '/tools/buildbot/bin/python'} 09:06:23 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/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:06:24 INFO - mozversion application_buildid: 20160609082929 09:06:24 INFO - mozversion application_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 09:06:24 INFO - mozversion application_display_name: Nightly 09:06:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:24 INFO - mozversion application_name: Firefox 09:06:24 INFO - mozversion application_remotingname: firefox 09:06:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:06:24 INFO - mozversion application_vendor: Mozilla 09:06:24 INFO - mozversion application_version: 50.0a1 09:06:24 INFO - mozversion platform_buildid: 20160609082929 09:06:24 INFO - mozversion platform_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 09:06:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:06:24 INFO - mozversion platform_version: 50.0a1 09:06:24 INFO - using testdate: 1465488384 09:06:24 INFO - actual date: 1465488384 09:06:24 INFO - starting webserver on 'localhost:39929' 09:06:24 INFO - SUITE-START | Running 2 tests 09:06:24 INFO - TEST-START | dromaeo_css 09:06:24 INFO - operating with platform_type : linux_ 09:06:24 INFO - Initialising browser for dromaeo_css test... 09:06:24 INFO - TEST-INFO | started process 5626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoB9zx9/profile http://localhost:39929/getInfo.html) 09:06:28 INFO - PROCESS | 5626 | __metrics Screen width/height:1600/1200 09:06:28 INFO - PROCESS | 5626 | colorDepth:24 09:06:28 INFO - PROCESS | 5626 | Browser inner width/height: 1024/697 09:06:28 INFO - PROCESS | 5626 | __metrics 09:06:29 ERROR - PROCESS | 5626 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:06:30 INFO - PROCESS | 5626 | console.error: PushService: 09:06:30 INFO - PROCESS | 5626 | stateChangeProcessEnqueue: Error transitioning state 09:06:30 INFO - PROCESS | 5626 | UnknownError 09:06:31 INFO - TEST-INFO | 5626: exit 0 09:06:31 INFO - Browser initialized. 09:06:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:31 INFO - TEST-INFO | started process 5706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoB9zx9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:43 INFO - PROCESS | 5706 | RSS: Main: 175271936 09:06:43 INFO - PROCESS | 5706 | 09:07:35 INFO - PROCESS | 5706 | 1465488455132 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:09:46 INFO - PROCESS | 5706 | Cycle 1(1): loaded http://localhost:39929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39929/tests/dromaeo/cssquery-ext.html) 09:09:47 INFO - PROCESS | 5706 | RSS: Main: 291594240 09:09:47 INFO - PROCESS | 5706 | 09:12:50 INFO - PROCESS | 5706 | Cycle 1(1): loaded http://localhost:39929/tests/dromaeo/cssquery-ext.html (next: http://localhost:39929/tests/dromaeo/cssquery-jquery.html) 09:12:51 INFO - PROCESS | 5706 | RSS: Main: 263823360 09:12:51 INFO - PROCESS | 5706 | 09:15:53 INFO - PROCESS | 5706 | Cycle 1(1): loaded http://localhost:39929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39929/tests/dromaeo/cssquery-mootools.html) 09:15:53 INFO - PROCESS | 5706 | RSS: Main: 261361664 09:15:53 INFO - PROCESS | 5706 | 09:18:56 INFO - PROCESS | 5706 | Cycle 1(1): loaded http://localhost:39929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39929/tests/dromaeo/cssquery-prototype.html) 09:18:56 INFO - PROCESS | 5706 | RSS: Main: 255848448 09:18:56 INFO - PROCESS | 5706 | 09:21:59 INFO - PROCESS | 5706 | Cycle 1(1): loaded http://localhost:39929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39929/tests/dromaeo/cssquery-yui.html) 09:22:00 INFO - PROCESS | 5706 | RSS: Main: 233005056 09:22:00 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | Cycle 1(1): loaded http://localhost:39929/tests/dromaeo/cssquery-yui.html (next: http://localhost:39929/tests/dromaeo/cssquery-dojo.html) 09:25:03 INFO - PROCESS | 5706 | RSS: Main: 326041600 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | __start_tp_report 09:25:03 INFO - PROCESS | 5706 | _x_x_mozilla_page_load 09:25:03 INFO - PROCESS | 5706 | _x_x_mozilla_page_load_details 09:25:03 INFO - PROCESS | 5706 | |i|pagename|runs| 09:25:03 INFO - PROCESS | 5706 | |0;dojo.html;2594.156899007823;2597.12996146291;2642.524345617789;2652.08503066442;2654.7477989590993;4484.349769283452;4613.423322084739;4645.094206629705;4732.290156476531;4737.0289090736405;4618.907621847561;4648.62810975122;4682.41469816273;4709.081729062834;4764.976175119128;4247.341662042373;4248.766317852517;4266.402703621496;4332.653387728982;4407.18467083589;4295.312749960007;4355.063661312817;4372.27857403528;4418.801153948064;4425.380446737459;4175.853845115436;4310.159518893817;4322.567743225683;4380;4381.452318460192;4207.747535147901;4265.1469706058915;4276.508201556799;4285.121550082225;4321.891952701176;4255.446791917031;4325.13497300538;4325.567443255649;4337.934930976038;4386.429764130675;4417.3815665806815;4776.80892764289;4779.880502987418;4798.4001999750035;4814.590759785422;4922.630802689777;5010.123228435045;5012.448630650625;5016.749162541895;5080.542751152414;5007.799688012475;5014.648974571782;5032.4967503249745;5045.217991211368;5083.415407228179;4539.682222244477;4683.157031734287;4719.315699223594;4728.148933191989;4733.124371991193;5175.404828444777;5180.766865491062;5207.71357575337;5213.7914483421;5236.345456817898;4954.603631709455;5004.549590536869;5013.924791128136;5014.373203349582;5016.749162541858;4866.878328041827;4964.255361695775;5025.547700706954;5086.9745651271505;5106.285120083191;4932.704037757746;4983.202687569971;4997.5002499749735;5005.849824505271;5032.924506132411;4896.143174944371;4910.312556242129;4910.558049775537;4914.90170196594;4946.950530494721;4013.2976729072298;4053.0677944073027;4075.6128167824604;4111.465509483748;4189.49726032878;3614.530111085542;3648.689861361814;3659.780413175218;3694.722895782827;3695.2055308108884;4365.061511774984;4370.300751879748;4382.211201983673;4385.144896745168;4417.646588272931;4874.341963834908;4902.90194196114;5028.270900719375;5077.644564880497;5080.110980578458;4421.38100665907;4422.800973956116;4424.203643344229;4450.621697155713;4466.419365482531;4512.758991277425;4518.164139634178;4519.435070616173;4526.728396296233;4566.748828814447;4610.193216187086;4717.198076327101;4742.668013239178;4760.024195040078;4802.951970480321;5013.774380152975;5025.070361983045;5030.4718004608985;5030.748462576929;5090.847274581621;4747.335373047845;4749.35883655702;4755.809767609257;4760.738159401266;4805.231163014041;4778.737169455574;4942.728149951788;4964.205727083649;4996.750162491933;5015.17249653803;5043.646944713835;5044.4451110377095;5058.140116180185;5066.670666406671;5116.232565115262;4743.383360163295;4932.062908047459;4946.183879659816;4947.678400903929;4995.25071239317;4884.267359896044;4919.557239848431;4943.382077240345;4948;4960.603151747924;4887.413510378778;4903.754812259444;4937.407511098691;4948.604111671129;4950.628702847229;4726.243800991962;4883.755812209304;4996.850094497171;5030.044291584733;5042;4613.723176609415;4660.790264438177;4764.523547645208;4806.423229212517;4813.1336359454235 09:25:03 INFO - PROCESS | 5706 | |1;ext.html;569.8746275819319;571.5341996273037;572.8224250482351;574.6580784433261;579.8898209340226;27438.45123097539;39636.60363396365;41143;41150.17699646009;44917.32624010643;42420;42550;42820.35769463461;42917;42983;7807.453478256539;7955.085165205988;7959.243871832166;7960.681572737112;7963.681452741884;7842.607869606525;7963.522188668699;7965.44241903067;7969.362451003934;7972.043354797433;7942.523448593103;7977.401694872879;7982;7984.920150798475;7986.6805327786815;7935.484193527403;7964.044314682217;7981.48120372174;7983.560904150269;7987.281144696947;7806.804829879242;7879.724209652692;7880.290773830383;7883.921160788376;7885;38748.80625596854;39195.412068818994;39221.60778392208;39231.8038409809;39258.214835703126;2716.8369897806197;2891.465078960399;3055.496269971665;3338.4491558892755;3378.2061215614312;29707.70292297071;29828.10515684533;30183.849080754677;30393.24016899595;31113.22216944572;3446.2245994651253;3579.2125732338845;3584.874529391485;3604.711623070148;3717.925641487155;248698;248806.9999999982;249728.75135624388;249820;249830;33852.1536961573;34925.82537087298;34975.30049398998;53543;54519.72740136274;34530.309393811986;34605.653943460246;34695.65304346975;34713.65286347155;34716.13209669728;14087.15477071379;14214.076085054437;14237.43050277998;14238.28808559568;14259.144451332953;11813.763724725457;11898.821517677241;11902.464389102512;11903.404829758478;11908.761824763456;7970.242826931432;8017.799555011172;8019.198080191934;8090.757277281691;8097.190280971856;3105.6583775784648;3119.0954623159028;3119.656837747891;3160.2099475131217;3176.8252746098724;832.7002279179491;851.5912362066243;885.371386315723;987.2842189412619;1021.0555236406294;28241.293967650563;28323.716762832108;28648.570271445944;28992.275193120342;29359.706402936125;914.5610107148606;943.9339246252696;951.2580187453797;1063.3672964586058;1083.5286650307141;14775.335109920079;14947.476838310607;15229.543113706384;15407.845921540866;15524;121418;387557;391726;391829;392127;51189;51624.741876290376;51657.483425165265;51704.74147629238;51727;1073.414988831089;1147.4836323654388;1164.831099490586;1168.4216312925157;1204.8795120488057;28417.85791071114;29023.7097629021;29053;29116.56325155082;29772.70227297786;42534;42826.357604635334;43065.354019689104;43095.78452107719;43191.56808432001;293152;294271;294302;294477;295129;22142.446438839157;24768.876155619106;25515.362115946507;26015.479690406464;26037.869810650827;35609.1097722559;35842;39561.208775824896;41034.1793164141;41256.58743412527;32854;34978;35166.296674066885;35440.46839297361;35634.287314254085;35010.64989350074;35219;35485.82257088698;35670.64329356673;35714.10714732049;34008.489872652426;35108;35161.824190878884;35197.120071998404;35409.82295088508;29482.852585737794;31830;31928;32041;32088.197795055312;24144.51710965806;24166.516669666158;24431.877840610683;24800.25599232026;24995.500089998462 09:25:03 INFO - PROCESS | 5706 | |2;jquery.html;351.6764576589537;356.5115791365829;359.40697848549905;367.79954924566107;373.12874438186833;15720.764188537167;16633.500994970156;17622.735658965095;17665.55836104098;17670.381536646204;16452.341906323763;16632.75050874235;16810;16947.83052169478;16988.660226795455;4892.3884514435695;5093.26147708582;5107.8467645970495;5124.231365295198;5147.150720131174;3112.1441603559088;3264.379767844102;5040.747962601874;5575.526080283161;5927.288725352963;5821.27234095738;5907.527397808187;5913.704314784265;5929.970350148244;5937.67342796146;5603.254405341394;5924.88150236995;5957.523398128183;5964.850878728023;5964.88070238595;2836;4751.928721069186;5159.25190847325;5160.071187186305;5182;19972.600547989103;21157.365279041653;21160.365189044198;21492.24777132793;21562.1375144994;1849.9630007399776;1906.609145125246;2115.9788402115937;2141.764405915348;2218.4010317214425;12629.936850315782;12858.807117893239;12923.806142907864;12959.28723920184;13104.2137471752;1517.9013364131297;1549.4189678870423;1554.2850288867135;1625.6098536351308;1650.2573841771132;64758.352416475704;67031.66484167548;67642.66178669124;68337.65831170812;68450;8812.691555795516;9159.77100572491;9466.857997130048;9743.65897193609;9892.763404574429;12904.419301131471;12948.805767913489;13019.414126364336;13046.282454464907;13079.280639564915;7588;7653.464257501922;7660.846783064308;7746.109197442366;7775.22247775218;7671.654775535114;7673.117591477052;7678.308952194329;7791.142974272825;7809.477151955428;6063.151158837766;6099.359567245464;6111.205543279345;6136.110264011782;6272.153259310026;1482.3477669825243;1567.968640627204;1654.436557453195;1682.6550557135758;1749.22159638962;781.1368437876179;828.3745771942146;924.0159230419716;954.4845783276953;966.7148191283447;17535.953739936795;17604;17825.643487130186;18193.45419637413;18312.633747325246;823.0822632764424;865.264525153627;871.9258862996717;929.5506340791927;933.071593764209;9282.48946307946;10138.797224055477;10349.586016559404;10376.740581485523;10422.322549034288;402514;405208;405413;406611;407508;83390;83474.16525834786;84297.57851210705;84816.15183848083;86349.56825215834;923.9445633262026;924.7364501117283;937.231470194434;945.432740355781;964.8359778837474;15391.84608153904;15725.842741572438;15796.842031579537;15896.046237225804;16222.26999784989;26969.325766855985;35732.64267357293;36167;37028.44457333088;37106.25787484181;51139.74430127825;51602.48397516127;53069.61186746683;53095;53882.191767124306;6657;6991.8252043697275;7243.130824301117;7358.11702595692;7707;8695.217430431292;10840.241183117107;11523.596674116367;11580.594679186524;11585.189036767682;9533;9593.376430531993;10075.84886226722;10088.243381746252;10421.791564168825;10187.592496300362;10515.211359148247;10601.575936962743;10665.626703065356;10863.130949524177;7349.77950661481;10393.636222732168;10408.843867342148;10458.111060559937;10511.369317840954;7170.211276759448;7205.315495027964;7225.602591857499;7329.303716146957;7367.447441441806;8017.438779285394;9602.615895364108;10548.683539493828;10705.625303114353;10804.783904322027 09:25:03 INFO - PROCESS | 5706 | |3;mootools.html;1205.5057426455155;1360.3334366160582;1367.4940272099325;1463.3926920328065;1709.1198033013;6496.545241833073;7210.2789721027875;7396.704131834734;7428.9257107428975;7616.543007419558;7372.520786148896;7465.664045117969;7473.4768566200255;7491.812704682386;7503.13713922899;1852.7220916862443;2069.492974221318;2141.1649456711893;2147.999999999996;2172.228858755143;2210.624193887043;2224.3882932193615;2227.1536816009893;2231.843770936035;2235.4299653588314;2153.54775497145;2178.1396348442354;2190.693302937582;2190.715207023085;2193.2433310507927;1581.430684953416;2071.8653287536413;2104.8947552622385;2143.571285742842;2143.8499305048654;2157.6655618379177;2172.2940044485604;2189.8467107302336;2191.0359441845694;2192.6162921488835;7876.5667888266125;7904.525728456253;7925.603719813987;7929.682812687485;7943.046834379911;4505.346724724896;4682.508336624674;4683.110209060268;4694.413198350207;4706.835260765857;2679.7856171506232;2785.860706964664;2831.5044867148167;2872.224499385154;2874.152125123073;887.8535041718109;895.8074014087002;904.7285814255763;916.5508900638706;920.2270093121743;10566.577336906592;10597.629082982136;10609.15126789855;10612.575496980111;10629.574817007311;4084.3056680363816;4223.873283801491;4224.640905523003;4236.788160591958;4296.5273819879785;8994.730158095268;9042.683506077386;9075;9075.183233509017;9077.409968352036;4712.764361781898;4727.338172655762;4729.0541891621815;4730;4730.787114579852;3561.28774245152;4051.4125451809323;4239.660827133822;4276.2516559601945;4276.444062271947;3575.5351804265797;3619.7104231661406;3627.5828279748166;3714.9442758358646;3716.591174970751;1159.6636975277245;1171.5255321594768;1183.177691504396;1204.1390405859852;1208;777.3470284960661;788.968441262343;793.7579038393345;795.6061749434067;812.1999830167281;4799.3760811094335;4966.726830024383;4976.452590215146;5026.974865125651;5079.949200507947;879.1077056787366;885.3713863157102;901.3780491461002;920.2729843423621;934.345957829522;3235.255891145003;3254.1213872254357;3290.1116698491273;3309.6690330966712;3349.6315405305395;8944.01615822259;9085.273178145733;9096.499692516843;9241.768955776024;9263;8949.821003580022;8959.955200223958;8967.372283940193;8981.640734370552;9155.084491550791;7115.501914866013;7161.104861892263;7249.492535522569;7264;7375.8156046099275;4921.483244259444;4948.356713627206;4983.202687569971;5009.4489606144025;5061.443241243386;8603.483790972561;8760.78098047554;8928.86606700887;9024;9062.22971047442;8836.513991730517;9023.819523609622;9065.229455496357;9072.047435019493;9170.862437063583;5233.633645644768;5463.699496527729;5467.753951072291;6188.504919606511;6334.4932405406535;6650.667466626553;6721.529492935448;6738.157730283715;7017.578945263301;7021.929780702128;6364.93635063662;6566.409023187936;6655.700493477708;6715.093462382516;6746.966265168643;6224.844378890382;6233.532485063548;6242.906356404566;6321.462675672619;6346.048092786119;5855.238818953509;5876.030454974882;5913.733881975408;5932.584719069796;5940.376260492586;4105.302098643178;4158.480189976253;4210.789460527023;4241.575842415734;4272.295071313323;4226.4928208615165;4263.914721705611;4293.806778694904;4331.97834010828;4367.45406824147 09:25:03 INFO - PROCESS | 5706 | |4;prototype.html;286.188655162614;288.69686828829737;295.34433557502365;295.7205440858388;296.7759341697017;4724.669273150885;4803.25549539821;4807.975960120195;4821.252705830598;4845.127876982142;4685.88285292867;4736.43162820462;4738.384010078685;4753.358296629954;4770.045990801845;3497.492863534786;3552.307300076486;3611.9277614447697;3719.6094410086957;3742.4760533525327;3694.8891533254045;3703.6296570269037;3703.8518459261595;3714.405695088786;3717.814109294538;3687.211702324384;3692.612275711052;3693.1136527233407;3705.3515634763944;3713.591504934455;3462.567179102612;3579.463080537927;3712;3718.367877460811;3733.4959780429836;3267.983660081708;3289.490129030004;3291.374638818617;3291.913668489393;3301.5542901708204;4616.746078965655;4649.395578574798;4653.930191047103;4655.255159174516;4680.508546602592;3940.4483372327895;4145.937810932808;4249.32010878258;4268.231718290706;4283.3360829071235;4848;4900.191468407708;4906.582940450066;4914.533119353656;4922.187839006559;3467.150548115728;3468.9479657805155;3484.6341134181052;3492.7205823534055;3504.4743288506675;5048.570871475929;5137.820176293849;5211.42674305826;5217.191335343028;5218.191180367049;3548.290341931624;3548.964510354915;3560.608333083359;3571.125074356747;3572.4105522589;3603.9099022524647;3604.891853244407;3630.854765809338;3643.799591022519;3648.1426864686778;4171.707980441401;4181.916361672749;4191.7694526801315;4200.4959404871;4204.201201771715;4825.276208568743;4941.308216849644;4942.431620363633;4994.175960966472;5020.949790502048;1232.8828761267666;1243.4031664800946;1248.151257145132;1251.4919521975996;1260.350919276555;769.869122249219;772.5055964182927;784.3920961254959;791.9208079192035;800.3197282310106;4366.388705581221;4450.666200035011;4474.418325617649;4482.439695038121;4506.887327816765;5072.416672082684;5107.54032137102;5118.38579370478;5127.743612819344;5152.330197074356;4432.246518091933;4464.352668862996;4469.932951005738;4472.709273897186;4482.574155455227;2594.364380726734;2729;2730.2901245676267;2743.3553115017953;2743.711910249435;4873.6832105913;4880.902381952341;4888;4892.31215230752;4900.901981960341;4961.8511444656715;5172;5201.635885487979;5204.557612602971;5225.406251093453;4842.498825364149;4850.5149485051215;4881.707097574157;4888.706677599355;4901;5108.974455127701;5158.922616160686;5184.662996905189;5198.116320225647;5198.246254293182;4753.9049219016115;4998.550130488274;5036.949630503795;5037.546620804145;5044.848654540223;4825.420949486084;4846.248831431134;4874.780634871368;4894.311462545416;4900.681455705368;3645.325614761278;3656.926861462809;3669.4495825625304;3704.722145839127;3713.2387860489075;4961.355023846877;5120.564751996122;5121.180611102206;5181.145111056633;5209.374875015023;4882.780274887709;4897.3878265216845;4933.235348520985;4977.328060711902;5013.523715247045;4884.194107972145;4918.508149185053;4982.900341993212;5020.347354843847;5042.823501177441;4644.349791029326;4899.975500122477;4900.754962251945;4930.161872481615;4956.355673762388;4800.447948485829;4925.8228442655;5009.743666616729;5072.898542029213;5074.908894587681;4896.338994235875;4918.82784102569;4929.162042452864;4935.8025678972435;4950.282209079592 09:25:03 INFO - PROCESS | 5706 | |5;yui.html;526.7050451747019;553.7923278770461;562.2353599105217;593.4925289764;605.6517502436099;11326.716832079192;12040.518379264819;12049.337286449241;12052;12076;12178.634640960785;12361.50553977842;12379.381030948462;12456.937715311411;12573.748525029494;611.761413048909;628.6605233174081;759.2066290726191;759.8480303939207;771.8301973565834;775.90689117306;781.8319061401797;783.9176886426928;784.0591290451453;785.1441928298154;827.0241115483727;828.7223780033696;829.2785276809185;829.3903980574273;829.5105887526358;642.4346575014005;781.6482582837689;810.9716159934374;811.3184924663311;823.9217274358926;593.326574338125;593.6527131628003;593.6675461741438;595.036041612586;595.0568349166576;10981.505832237568;11043.944780276128;11101.72245693856;11134.16493762971;11137.05335046522;11662;11905.464254108585;11944.163908526407;12234.327112008836;12431.12982091254;10661.253712240146;10696.62561810333;10746.78506429867;10848.457577121191;11014.889851101467;4096.692748043879;4144.212599606095;4168.2080404723;4184.309588917825;4322.135572885435;56131.15803262914;56774;58391.99999999958;58921;59694.70152649252;9448.952755236318;9530.237580993504;9559.856602150974;9684.322097453252;9748.658796942214;18279.086045697662;18292.634147316978;18293.634127317644;18320.816791831912;18367.81632183661;6591.934080659228;6646.734130634817;6660.866782664417;6720.2943690912725;6775.3902148805855;3425.9143521412166;3428.3314753622803;3445.328161008629;3532.5760908691122;3533.505309256706;2507.18516482144;2605.9087931922672;2618.1883616079076;2628.1458525979133;2628.8422694638384;359.34419684076664;466.274942464471;476.4966530595975;478.62906247657645;479.7673128532659;535.9490848369398;540.3758658749151;550.402812947948;558.4638746803033;565.7793460550389;7266.7093316266755;7362.555351012403;7422.591757453392;7480.925190748132;7528.548287102792;437.4116812886662;491.15276148644017;518.142474205191;520.3599572525738;541.0990700483651;3341.4820702791108;3434.3303055904357;3621.6921561667555;3691.1325838427947;3748.475213470116;58083.4191658078;93838;102133.48933255287;103235;104929;53019.73490132602;53411.46588534065;54422;74357.6282118586;78247.21752782514;77848;80280;80304;80720.78918816222;80759.59620201861;6830.59016459014;7038.260982596754;7114.644267786486;7132.786016419515;7259.419246460165;43420.782896085315;47776;48327.516724832305;48693;48780.51219487902;52381.7380913093;54506.45493545172;67274;70367;70584.29415705982;10368.585256589953;11100.333979961228;11147.888521114684;11529.942350288195;11880.22778519428;11411.942940285246;11739.530418783153;11753.294802311888;11849.466773995018;11976.28142311464;11122.388268645302;11360.261582997078;11819.349935753617;11994.76010479803;12003.799620038275;10929;10968.396738179477;11050.281731687415;11419;11560.768784624428;8585.699500517452;9077.636894524145;9351.251899847859;9622.422654640744;10432.895671043496;9249;9738.853917191389;9801.950990245003;9973.650922217977;10145.49272536385;9125.45247285165;9640.903590964;9754.17089547368;9755.951220244136;9817.65638202688 09:25:03 INFO - PROCESS | 5706 | __end_tp_report 09:25:03 INFO - PROCESS | 5706 | __start_cc_report 09:25:03 INFO - PROCESS | 5706 | _x_x_mozilla_cycle_collect,1044 09:25:03 INFO - PROCESS | 5706 | __end_cc_report 09:25:03 INFO - PROCESS | 5706 | __startTimestamp1465489503595__endTimestamp 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | ------- Summary: start ------- 09:25:03 INFO - PROCESS | 5706 | Number of tests: 6 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | [#0] dojo.html Cycles:165 Average:4641.47 Median:4764.52 stddev:496.20 (10.4%) stddev-sans-first:471.01 09:25:03 INFO - PROCESS | 5706 | Values: 2594.2 2597.1 2642.5 2652.1 2654.7 4484.3 4613.4 4645.1 4732.3 4737.0 4618.9 4648.6 4682.4 4709.1 4765.0 4247.3 4248.8 4266.4 4332.7 4407.2 4295.3 4355.1 4372.3 4418.8 4425.4 4175.9 4310.2 4322.6 4380.0 4381.5 4207.7 4265.1 4276.5 4285.1 4321.9 4255.4 4325.1 4325.6 4337.9 4386.4 4417.4 4776.8 4779.9 4798.4 4814.6 4922.6 5010.1 5012.4 5016.7 5080.5 5007.8 5014.6 5032.5 5045.2 5083.4 4539.7 4683.2 4719.3 4728.1 4733.1 5175.4 5180.8 5207.7 5213.8 5236.3 4954.6 5004.5 5013.9 5014.4 5016.7 4866.9 4964.3 5025.5 5087.0 5106.3 4932.7 4983.2 4997.5 5005.8 5032.9 4896.1 4910.3 4910.6 4914.9 4947.0 4013.3 4053.1 4075.6 4111.5 4189.5 3614.5 3648.7 3659.8 3694.7 3695.2 4365.1 4370.3 4382.2 4385.1 4417.6 4874.3 4902.9 5028.3 5077.6 5080.1 4421.4 4422.8 4424.2 4450.6 4466.4 4512.8 4518.2 4519.4 4526.7 4566.7 4610.2 4717.2 4742.7 4760.0 4803.0 5013.8 5025.1 5030.5 5030.7 5090.8 4747.3 4749.4 4755.8 4760.7 4805.2 4778.7 4942.7 4964.2 4996.8 5015.2 5043.6 5044.4 5058.1 5066.7 5116.2 4743.4 4932.1 4946.2 4947.7 4995.3 4884.3 4919.6 4943.4 4948.0 4960.6 4887.4 4903.8 4937.4 4948.6 4950.6 4726.2 4883.8 4996.9 5030.0 5042.0 4613.7 4660.8 4764.5 4806.4 4813.1 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | [#1] ext.html Cycles:180 Average:44112.46 Median:35181.71 stddev:79688.90 (226.5%) stddev-sans-first:79845.39 09:25:03 INFO - PROCESS | 5706 | Values: 569.9 571.5 572.8 574.7 579.9 27438.5 39636.6 41143.0 41150.2 44917.3 42420.0 42550.0 42820.4 42917.0 42983.0 7807.5 7955.1 7959.2 7960.7 7963.7 7842.6 7963.5 7965.4 7969.4 7972.0 7942.5 7977.4 7982.0 7984.9 7986.7 7935.5 7964.0 7981.5 7983.6 7987.3 7806.8 7879.7 7880.3 7883.9 7885.0 38748.8 39195.4 39221.6 39231.8 39258.2 2716.8 2891.5 3055.5 3338.4 3378.2 29707.7 29828.1 30183.8 30393.2 31113.2 3446.2 3579.2 3584.9 3604.7 3717.9 248698.0 248807.0 249728.8 249820.0 249830.0 33852.2 34925.8 34975.3 53543.0 54519.7 34530.3 34605.7 34695.7 34713.7 34716.1 14087.2 14214.1 14237.4 14238.3 14259.1 11813.8 11898.8 11902.5 11903.4 11908.8 7970.2 8017.8 8019.2 8090.8 8097.2 3105.7 3119.1 3119.7 3160.2 3176.8 832.7 851.6 885.4 987.3 1021.1 28241.3 28323.7 28648.6 28992.3 29359.7 914.6 943.9 951.3 1063.4 1083.5 14775.3 14947.5 15229.5 15407.8 15524.0 121418.0 387557.0 391726.0 391829.0 392127.0 51189.0 51624.7 51657.5 51704.7 51727.0 1073.4 1147.5 1164.8 1168.4 1204.9 28417.9 29023.7 29053.0 29116.6 29772.7 42534.0 42826.4 43065.4 43095.8 43191.6 293152.0 294271.0 294302.0 294477.0 295129.0 22142.4 24768.9 25515.4 26015.5 26037.9 35609.1 35842.0 39561.2 41034.2 41256.6 32854.0 34978.0 35166.3 35440.5 35634.3 35010.6 35219.0 35485.8 35670.6 35714.1 34008.5 35108.0 35161.8 35197.1 35409.8 29482.9 31830.0 31928.0 32041.0 32088.2 24144.5 24166.5 24431.9 24800.3 24995.5 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | [#2] jquery.html Cycles:180 Average:24995.63 Median:206129.96 stddev:66975.69 (32.5%) stddev-sans-first:67138.01 09:25:03 INFO - PROCESS | 5706 | Values: 351.7 356.5 359.4 367.8 373.1 15720.8 16633.5 17622.7 17665.6 17670.4 16452.3 16632.8 16810.0 16947.8 16988.7 4892.4 5093.3 5107.8 5124.2 5147.2 3112.1 3264.4 5040.7 5575.5 5927.3 5821.3 5907.5 5913.7 5930.0 5937.7 5603.3 5924.9 5957.5 5964.9 5964.9 2836.0 4751.9 5159.3 5160.1 5182.0 19972.6 21157.4 21160.4 21492.2 21562.1 1850.0 1906.6 2116.0 2141.8 2218.4 12629.9 12858.8 12923.8 12959.3 13104.2 1517.9 1549.4 1554.3 1625.6 1650.3 64758.4 67031.7 67642.7 68337.7 68450.0 8812.7 9159.8 9466.9 9743.7 9892.8 12904.4 12948.8 13019.4 13046.3 13079.3 7588.0 7653.5 7660.8 7746.1 7775.2 7671.7 7673.1 7678.3 7791.1 7809.5 6063.2 6099.4 6111.2 6136.1 6272.2 1482.3 1568.0 1654.4 1682.7 1749.2 781.1 828.4 924.0 954.5 966.7 17536.0 17604.0 17825.6 18193.5 18312.6 823.1 865.3 871.9 929.6 933.1 9282.5 10138.8 10349.6 10376.7 10422.3 402514.0 405208.0 405413.0 406611.0 407508.0 83390.0 83474.2 84297.6 84816.2 86349.6 923.9 924.7 937.2 945.4 964.8 15391.8 15725.8 15796.8 15896.0 16222.3 26969.3 35732.6 36167.0 37028.4 37106.3 51139.7 51602.5 53069.6 53095.0 53882.2 6657.0 6991.8 7243.1 7358.1 7707.0 8695.2 10840.2 11523.6 11580.6 11585.2 9533.0 9593.4 10075.8 10088.2 10421.8 10187.6 10515.2 10601.6 10665.6 10863.1 7349.8 10393.6 10408.8 10458.1 10511.4 7170.2 7205.3 7225.6 7329.3 7367.4 8017.4 9602.6 10548.7 10705.6 10804.8 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | [#3] mootools.html Cycles:180 Average:4962.32 Median:4996.33 stddev:2787.89 (55.8%) stddev-sans-first:2781.41 09:25:03 INFO - PROCESS | 5706 | Values: 1205.5 1360.3 1367.5 1463.4 1709.1 6496.5 7210.3 7396.7 7428.9 7616.5 7372.5 7465.7 7473.5 7491.8 7503.1 1852.7 2069.5 2141.2 2148.0 2172.2 2210.6 2224.4 2227.2 2231.8 2235.4 2153.5 2178.1 2190.7 2190.7 2193.2 1581.4 2071.9 2104.9 2143.6 2143.8 2157.7 2172.3 2189.8 2191.0 2192.6 7876.6 7904.5 7925.6 7929.7 7943.0 4505.3 4682.5 4683.1 4694.4 4706.8 2679.8 2785.9 2831.5 2872.2 2874.2 887.9 895.8 904.7 916.6 920.2 10566.6 10597.6 10609.2 10612.6 10629.6 4084.3 4223.9 4224.6 4236.8 4296.5 8994.7 9042.7 9075.0 9075.2 9077.4 4712.8 4727.3 4729.1 4730.0 4730.8 3561.3 4051.4 4239.7 4276.3 4276.4 3575.5 3619.7 3627.6 3714.9 3716.6 1159.7 1171.5 1183.2 1204.1 1208.0 777.3 789.0 793.8 795.6 812.2 4799.4 4966.7 4976.5 5027.0 5079.9 879.1 885.4 901.4 920.3 934.3 3235.3 3254.1 3290.1 3309.7 3349.6 8944.0 9085.3 9096.5 9241.8 9263.0 8949.8 8960.0 8967.4 8981.6 9155.1 7115.5 7161.1 7249.5 7264.0 7375.8 4921.5 4948.4 4983.2 5009.4 5061.4 8603.5 8760.8 8928.9 9024.0 9062.2 8836.5 9023.8 9065.2 9072.0 9170.9 5233.6 5463.7 5467.8 6188.5 6334.5 6650.7 6721.5 6738.2 7017.6 7021.9 6364.9 6566.4 6655.7 6715.1 6747.0 6224.8 6233.5 6242.9 6321.5 6346.0 5855.2 5876.0 5913.7 5932.6 5940.4 4105.3 4158.5 4210.8 4241.6 4272.3 4226.5 4263.9 4293.8 4332.0 4367.5 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | [#4] prototype.html Cycles:180 Average:4129.60 Median:4753.63 stddev:1210.98 (25.5%) stddev-sans-first:1179.52 09:25:03 INFO - PROCESS | 5706 | Values: 286.2 288.7 295.3 295.7 296.8 4724.7 4803.3 4808.0 4821.3 4845.1 4685.9 4736.4 4738.4 4753.4 4770.0 3497.5 3552.3 3611.9 3719.6 3742.5 3694.9 3703.6 3703.9 3714.4 3717.8 3687.2 3692.6 3693.1 3705.4 3713.6 3462.6 3579.5 3712.0 3718.4 3733.5 3268.0 3289.5 3291.4 3291.9 3301.6 4616.7 4649.4 4653.9 4655.3 4680.5 3940.4 4145.9 4249.3 4268.2 4283.3 4848.0 4900.2 4906.6 4914.5 4922.2 3467.2 3468.9 3484.6 3492.7 3504.5 5048.6 5137.8 5211.4 5217.2 5218.2 3548.3 3549.0 3560.6 3571.1 3572.4 3603.9 3604.9 3630.9 3643.8 3648.1 4171.7 4181.9 4191.8 4200.5 4204.2 4825.3 4941.3 4942.4 4994.2 5020.9 1232.9 1243.4 1248.2 1251.5 1260.4 769.9 772.5 784.4 791.9 800.3 4366.4 4450.7 4474.4 4482.4 4506.9 5072.4 5107.5 5118.4 5127.7 5152.3 4432.2 4464.4 4469.9 4472.7 4482.6 2594.4 2729.0 2730.3 2743.4 2743.7 4873.7 4880.9 4888.0 4892.3 4900.9 4961.9 5172.0 5201.6 5204.6 5225.4 4842.5 4850.5 4881.7 4888.7 4901.0 5109.0 5158.9 5184.7 5198.1 5198.2 4753.9 4998.6 5036.9 5037.5 5044.8 4825.4 4846.2 4874.8 4894.3 4900.7 3645.3 3656.9 3669.4 3704.7 3713.2 4961.4 5120.6 5121.2 5181.1 5209.4 4882.8 4897.4 4933.2 4977.3 5013.5 4884.2 4918.5 4982.9 5020.3 5042.8 4644.3 4900.0 4900.8 4930.2 4956.4 4800.4 4925.8 5009.7 5072.9 5074.9 4896.3 4918.8 4929.2 4935.8 4950.3 09:25:03 INFO - PROCESS | 5706 | 09:25:03 INFO - PROCESS | 5706 | [#5] yui.html Cycles:180 Average:16805.35 Median:26773.22 stddev:24164.09 (90.3%) stddev-sans-first:24200.96 09:25:03 INFO - PROCESS | 5706 | Values: 526.7 553.8 562.2 593.5 605.7 11326.7 12040.5 12049.3 12052.0 12076.0 12178.6 12361.5 12379.4 12456.9 12573.7 611.8 628.7 759.2 759.8 771.8 775.9 781.8 783.9 784.1 785.1 827.0 828.7 829.3 829.4 829.5 642.4 781.6 811.0 811.3 823.9 593.3 593.7 593.7 595.0 595.1 10981.5 11043.9 11101.7 11134.2 11137.1 11662.0 11905.5 11944.2 12234.3 12431.1 10661.3 10696.6 10746.8 10848.5 11014.9 4096.7 4144.2 4168.2 4184.3 4322.1 56131.2 56774.0 58392.0 58921.0 59694.7 9449.0 9530.2 9559.9 9684.3 9748.7 18279.1 18292.6 18293.6 18320.8 18367.8 6591.9 6646.7 6660.9 6720.3 6775.4 3425.9 3428.3 3445.3 3532.6 3533.5 2507.2 2605.9 2618.2 2628.1 2628.8 359.3 466.3 476.5 478.6 479.8 535.9 540.4 550.4 558.5 565.8 7266.7 7362.6 7422.6 7480.9 7528.5 437.4 491.2 518.1 520.4 541.1 3341.5 3434.3 3621.7 3691.1 3748.5 58083.4 93838.0 102133.5 103235.0 104929.0 53019.7 53411.5 54422.0 74357.6 78247.2 77848.0 80280.0 80304.0 80720.8 80759.6 6830.6 7038.3 7114.6 7132.8 7259.4 43420.8 47776.0 48327.5 48693.0 48780.5 52381.7 54506.5 67274.0 70367.0 70584.3 10368.6 11100.3 11147.9 11529.9 11880.2 11411.9 11739.5 11753.3 11849.5 11976.3 11122.4 11360.3 11819.3 11994.8 12003.8 10929.0 10968.4 11050.3 11419.0 11560.8 8585.7 9077.6 9351.3 9622.4 10432.9 9249.0 9738.9 9802.0 9973.7 10145.5 9125.5 9640.9 9754.2 9756.0 9817.7 09:25:03 INFO - PROCESS | 5706 | -------- Summary: end -------- 09:25:03 INFO - PROCESS | 5706 | 09:25:04 INFO - TEST-INFO | 5706: exit 0 09:25:04 INFO - TEST-OK | dromaeo_css | took 1120281ms 09:25:04 INFO - TEST-START | kraken 09:25:04 INFO - operating with platform_type : linux_ 09:25:04 INFO - Initialising browser for kraken test... 09:25:04 INFO - TEST-INFO | started process 5886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yUmqf/profile http://localhost:39929/getInfo.html) 09:25:08 INFO - PROCESS | 5886 | __metrics Screen width/height:1600/1200 09:25:08 INFO - PROCESS | 5886 | colorDepth:24 09:25:08 INFO - PROCESS | 5886 | Browser inner width/height: 1024/697 09:25:08 INFO - PROCESS | 5886 | __metrics 09:25:10 ERROR - PROCESS | 5886 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:25:10 INFO - PROCESS | 5886 | console.error: PushService: 09:25:10 INFO - PROCESS | 5886 | stateChangeProcessEnqueue: Error transitioning state 09:25:10 INFO - PROCESS | 5886 | UnknownError 09:25:11 INFO - TEST-INFO | 5886: exit 0 09:25:11 INFO - Browser initialized. 09:25:11 INFO - Running cycle 1/1 for kraken test... 09:25:11 INFO - TEST-INFO | started process 5966 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yUmqf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:23 INFO - PROCESS | 5966 | RSS: Main: 174747648 09:25:23 INFO - PROCESS | 5966 | 09:25:25 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39929/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:26 INFO - PROCESS | 5966 | RSS: Main: 232857600 09:25:26 INFO - PROCESS | 5966 | 09:25:29 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39929/tests/kraken/driver.html?testName=audio-dft) 09:25:30 INFO - PROCESS | 5966 | RSS: Main: 219418624 09:25:30 INFO - PROCESS | 5966 | 09:25:33 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39929/tests/kraken/driver.html?testName=audio-fft) 09:25:34 INFO - PROCESS | 5966 | RSS: Main: 287371264 09:25:34 INFO - PROCESS | 5966 | 09:25:36 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39929/tests/kraken/driver.html?testName=audio-oscillator) 09:25:36 INFO - PROCESS | 5966 | RSS: Main: 197730304 09:25:36 INFO - PROCESS | 5966 | 09:25:39 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:39 INFO - PROCESS | 5966 | RSS: Main: 201703424 09:25:39 INFO - PROCESS | 5966 | 09:25:42 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39929/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:43 INFO - PROCESS | 5966 | RSS: Main: 238002176 09:25:43 INFO - PROCESS | 5966 | 09:25:47 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39929/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:47 INFO - PROCESS | 5966 | RSS: Main: 239267840 09:25:47 INFO - PROCESS | 5966 | 09:25:50 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39929/tests/kraken/driver.html?testName=json-parse-financial) 09:25:51 INFO - PROCESS | 5966 | RSS: Main: 238592000 09:25:51 INFO - PROCESS | 5966 | 09:25:52 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:53 INFO - PROCESS | 5966 | RSS: Main: 221437952 09:25:53 INFO - PROCESS | 5966 | 09:25:55 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:56 INFO - PROCESS | 5966 | RSS: Main: 226795520 09:25:56 INFO - PROCESS | 5966 | 09:25:58 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:58 INFO - PROCESS | 5966 | RSS: Main: 235298816 09:25:58 INFO - PROCESS | 5966 | 09:26:01 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:02 INFO - PROCESS | 5966 | RSS: Main: 242401280 09:26:02 INFO - PROCESS | 5966 | 09:26:05 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:05 INFO - PROCESS | 5966 | RSS: Main: 241991680 09:26:05 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | Cycle 1(1): loaded http://localhost:39929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39929/tests/kraken/driver.html?testName=ai-astar) 09:26:07 INFO - PROCESS | 5966 | RSS: Main: 284033024 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | __start_tp_report 09:26:07 INFO - PROCESS | 5966 | _x_x_mozilla_page_load 09:26:07 INFO - PROCESS | 5966 | _x_x_mozilla_page_load_details 09:26:07 INFO - PROCESS | 5966 | |i|pagename|runs| 09:26:07 INFO - PROCESS | 5966 | |0;ai-astar;113;108;114;114;114;114;113;114;113;112 09:26:07 INFO - PROCESS | 5966 | |1;audio-beat-detection;166;132;133;183;130;131;153;130;166;130 09:26:07 INFO - PROCESS | 5966 | |2;audio-dft;161;160;163;162;161;162;161;161;162;161 09:26:07 INFO - PROCESS | 5966 | |3;audio-fft;75;76;76;120;75;76;76;75;99;75 09:26:07 INFO - PROCESS | 5966 | |4;audio-oscillator;85;87;112;87;88;86;111;87;86;137 09:26:07 INFO - PROCESS | 5966 | |5;imaging-gaussian-blur;117;117;118;117;118;117;118;118;118;118 09:26:07 INFO - PROCESS | 5966 | |6;imaging-darkroom;146;147;146;146;146;147;146;147;146;146 09:26:07 INFO - PROCESS | 5966 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;95 09:26:07 INFO - PROCESS | 5966 | |8;json-parse-financial;62;63;63;63;63;65;68;63;64;63 09:26:07 INFO - PROCESS | 5966 | |9;json-stringify-tinderbox;64;64;65;64;65;64;65;65;65;64 09:26:07 INFO - PROCESS | 5966 | |10;stanford-crypto-aes;83;83;82;88;91;85;87;92;119;87 09:26:07 INFO - PROCESS | 5966 | |11;stanford-crypto-ccm;135;133;131;131;138;140;131;129;151;142 09:26:07 INFO - PROCESS | 5966 | |12;stanford-crypto-pbkdf2;168;168;166;166;165;168;168;179;165;170 09:26:07 INFO - PROCESS | 5966 | |13;stanford-crypto-sha256-iterative;66;67;67;68;66;65;71;67;67;75 09:26:07 INFO - PROCESS | 5966 | __end_tp_report 09:26:07 INFO - PROCESS | 5966 | __start_cc_report 09:26:07 INFO - PROCESS | 5966 | _x_x_mozilla_cycle_collect,1889 09:26:07 INFO - PROCESS | 5966 | __end_cc_report 09:26:07 INFO - PROCESS | 5966 | __startTimestamp1465489567783__endTimestamp 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | ------- Summary: start ------- 09:26:07 INFO - PROCESS | 5966 | Number of tests: 14 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:1.85 (1.6%) stddev-sans-first:1.96 09:26:07 INFO - PROCESS | 5966 | Values: 113.0 108.0 114.0 114.0 114.0 114.0 113.0 114.0 113.0 112.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:143.00 stddev:19.92 (13.9%) stddev-sans-first:19.69 09:26:07 INFO - PROCESS | 5966 | Values: 166.0 132.0 133.0 183.0 130.0 131.0 153.0 130.0 166.0 130.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 09:26:07 INFO - PROCESS | 5966 | Values: 161.0 160.0 163.0 162.0 161.0 162.0 161.0 161.0 162.0 161.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:15.17 (20.0%) stddev-sans-first:15.86 09:26:07 INFO - PROCESS | 5966 | Values: 75.0 76.0 76.0 120.0 75.0 76.0 76.0 75.0 99.0 75.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:86.50 stddev:17.60 (20.3%) stddev-sans-first:18.16 09:26:07 INFO - PROCESS | 5966 | Values: 85.0 87.0 112.0 87.0 88.0 86.0 111.0 87.0 86.0 137.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:26:07 INFO - PROCESS | 5966 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:26:07 INFO - PROCESS | 5966 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:26:07 INFO - PROCESS | 5966 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.69 09:26:07 INFO - PROCESS | 5966 | Values: 62.0 63.0 63.0 63.0 63.0 65.0 68.0 63.0 64.0 63.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 09:26:07 INFO - PROCESS | 5966 | Values: 64.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 65.0 64.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:87.00 stddev:10.82 (12.4%) stddev-sans-first:11.20 09:26:07 INFO - PROCESS | 5966 | Values: 83.0 83.0 82.0 88.0 91.0 85.0 87.0 92.0 119.0 87.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:136.50 stddev:6.79 (5.0%) stddev-sans-first:7.19 09:26:07 INFO - PROCESS | 5966 | Values: 135.0 133.0 131.0 131.0 138.0 140.0 131.0 129.0 151.0 142.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.00 stddev:4.08 (2.4%) stddev-sans-first:4.33 09:26:07 INFO - PROCESS | 5966 | Values: 168.0 168.0 166.0 166.0 165.0 168.0 168.0 179.0 165.0 170.0 09:26:07 INFO - PROCESS | 5966 | 09:26:07 INFO - PROCESS | 5966 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.00 stddev:2.96 (4.4%) stddev-sans-first:3.06 09:26:07 INFO - PROCESS | 5966 | Values: 66.0 67.0 67.0 68.0 66.0 65.0 71.0 67.0 67.0 75.0 09:26:07 INFO - PROCESS | 5966 | -------- Summary: end -------- 09:26:07 INFO - PROCESS | 5966 | 09:26:08 INFO - TEST-INFO | 5966: exit 0 09:26:08 INFO - TEST-OK | kraken | took 64512ms 09:26:08 INFO - SUITE-END | took 1184s 09:26:08 INFO - Completed test suite (00:19:44) 09:26:08 INFO - javascript benchmark 09:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.156899007823, 2597.12996146291, 2642.524345617789, 2652.08503066442, 2654.7477989590993, 4484.349769283452, 4613.423322084739, 4645.094206629705, 4732.290156476531, 4737.0289090736405, 4618.907621847561, 4648.62810975122, 4682.41469816273, 4709.081729062834, 4764.976175119128, 4247.341662042373, 4248.766317852517, 4266.402703621496, 4332.653387728982, 4407.18467083589, 4295.312749960007, 4355.063661312817, 4372.27857403528, 4418.801153948064, 4425.380446737459, 4175.853845115436, 4310.159518893817, 4322.567743225683, 4380.0, 4381.452318460192, 4207.747535147901, 4265.1469706058915, 4276.508201556799, 4285.121550082225, 4321.891952701176, 4255.446791917031, 4325.13497300538, 4325.567443255649, 4337.934930976038, 4386.429764130675, 4417.3815665806815, 4776.80892764289, 4779.880502987418, 4798.4001999750035, 4814.590759785422, 4922.630802689777, 5010.123228435045, 5012.448630650625, 5016.749162541895, 5080.542751152414, 5007.799688012475, 5014.648974571782, 5032.4967503249745, 5045.217991211368, 5083.415407228179, 4539.682222244477, 4683.157031734287, 4719.315699223594, 4728.148933191989, 4733.124371991193, 5175.404828444777, 5180.766865491062, 5207.71357575337, 5213.7914483421, 5236.345456817898, 4954.603631709455, 5004.549590536869, 5013.924791128136, 5014.373203349582, 5016.749162541858, 4866.878328041827, 4964.255361695775, 5025.547700706954, 5086.9745651271505, 5106.285120083191, 4932.704037757746, 4983.202687569971, 4997.5002499749735, 5005.849824505271, 5032.924506132411, 4896.143174944371, 4910.312556242129, 4910.558049775537, 4914.90170196594, 4946.950530494721, 4013.2976729072298, 4053.0677944073027, 4075.6128167824604, 4111.465509483748, 4189.49726032878, 3614.530111085542, 3648.689861361814, 3659.780413175218, 3694.722895782827, 3695.2055308108884, 4365.061511774984, 4370.300751879748, 4382.211201983673, 4385.144896745168, 4417.646588272931, 4874.341963834908, 4902.90194196114, 5028.270900719375, 5077.644564880497, 5080.110980578458, 4421.38100665907, 4422.800973956116, 4424.203643344229, 4450.621697155713, 4466.419365482531, 4512.758991277425, 4518.164139634178, 4519.435070616173, 4526.728396296233, 4566.748828814447, 4610.193216187086, 4717.198076327101, 4742.668013239178, 4760.024195040078, 4802.951970480321, 5013.774380152975, 5025.070361983045, 5030.4718004608985, 5030.748462576929, 5090.847274581621, 4747.335373047845, 4749.35883655702, 4755.809767609257, 4760.738159401266, 4805.231163014041, 4778.737169455574, 4942.728149951788, 4964.205727083649, 4996.750162491933, 5015.17249653803, 5043.646944713835, 5044.4451110377095, 5058.140116180185, 5066.670666406671, 5116.232565115262, 4743.383360163295, 4932.062908047459, 4946.183879659816, 4947.678400903929, 4995.25071239317, 4884.267359896044, 4919.557239848431, 4943.382077240345, 4948.0, 4960.603151747924, 4887.413510378778, 4903.754812259444, 4937.407511098691, 4948.604111671129, 4950.628702847229, 4726.243800991962, 4883.755812209304, 4996.850094497171, 5030.044291584733, 5042.0, 4613.723176609415, 4660.790264438177, 4764.523547645208, 4806.423229212517, 4813.1336359454235], "value": 4609.496194065772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.8746275819319, 571.5341996273037, 572.8224250482351, 574.6580784433261, 579.8898209340226, 27438.45123097539, 39636.60363396365, 41143.0, 41150.17699646009, 44917.32624010643, 42420.0, 42550.0, 42820.35769463461, 42917.0, 42983.0, 7807.453478256539, 7955.085165205988, 7959.243871832166, 7960.681572737112, 7963.681452741884, 7842.607869606525, 7963.522188668699, 7965.44241903067, 7969.362451003934, 7972.043354797433, 7942.523448593103, 7977.401694872879, 7982.0, 7984.920150798475, 7986.6805327786815, 7935.484193527403, 7964.044314682217, 7981.48120372174, 7983.560904150269, 7987.281144696947, 7806.804829879242, 7879.724209652692, 7880.290773830383, 7883.921160788376, 7885.0, 38748.80625596854, 39195.412068818994, 39221.60778392208, 39231.8038409809, 39258.214835703126, 2716.8369897806197, 2891.465078960399, 3055.496269971665, 3338.4491558892755, 3378.2061215614312, 29707.70292297071, 29828.10515684533, 30183.849080754677, 30393.24016899595, 31113.22216944572, 3446.2245994651253, 3579.2125732338845, 3584.874529391485, 3604.711623070148, 3717.925641487155, 248698.0, 248806.9999999982, 249728.75135624388, 249820.0, 249830.0, 33852.1536961573, 34925.82537087298, 34975.30049398998, 53543.0, 54519.72740136274, 34530.309393811986, 34605.653943460246, 34695.65304346975, 34713.65286347155, 34716.13209669728, 14087.15477071379, 14214.076085054437, 14237.43050277998, 14238.28808559568, 14259.144451332953, 11813.763724725457, 11898.821517677241, 11902.464389102512, 11903.404829758478, 11908.761824763456, 7970.242826931432, 8017.799555011172, 8019.198080191934, 8090.757277281691, 8097.190280971856, 3105.6583775784648, 3119.0954623159028, 3119.656837747891, 3160.2099475131217, 3176.8252746098724, 832.7002279179491, 851.5912362066243, 885.371386315723, 987.2842189412619, 1021.0555236406294, 28241.293967650563, 28323.716762832108, 28648.570271445944, 28992.275193120342, 29359.706402936125, 914.5610107148606, 943.9339246252696, 951.2580187453797, 1063.3672964586058, 1083.5286650307141, 14775.335109920079, 14947.476838310607, 15229.543113706384, 15407.845921540866, 15524.0, 121418.0, 387557.0, 391726.0, 391829.0, 392127.0, 51189.0, 51624.741876290376, 51657.483425165265, 51704.74147629238, 51727.0, 1073.414988831089, 1147.4836323654388, 1164.831099490586, 1168.4216312925157, 1204.8795120488057, 28417.85791071114, 29023.7097629021, 29053.0, 29116.56325155082, 29772.70227297786, 42534.0, 42826.357604635334, 43065.354019689104, 43095.78452107719, 43191.56808432001, 293152.0, 294271.0, 294302.0, 294477.0, 295129.0, 22142.446438839157, 24768.876155619106, 25515.362115946507, 26015.479690406464, 26037.869810650827, 35609.1097722559, 35842.0, 39561.208775824896, 41034.1793164141, 41256.58743412527, 32854.0, 34978.0, 35166.296674066885, 35440.46839297361, 35634.287314254085, 35010.64989350074, 35219.0, 35485.82257088698, 35670.64329356673, 35714.10714732049, 34008.489872652426, 35108.0, 35161.824190878884, 35197.120071998404, 35409.82295088508, 29482.852585737794, 31830.0, 31928.0, 32041.0, 32088.197795055312, 24144.51710965806, 24166.516669666158, 24431.877840610683, 24800.25599232026, 24995.500089998462], "value": 16423.90455059664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6764576589537, 356.5115791365829, 359.40697848549905, 367.79954924566107, 373.12874438186833, 15720.764188537167, 16633.500994970156, 17622.735658965095, 17665.55836104098, 17670.381536646204, 16452.341906323763, 16632.75050874235, 16810.0, 16947.83052169478, 16988.660226795455, 4892.3884514435695, 5093.26147708582, 5107.8467645970495, 5124.231365295198, 5147.150720131174, 3112.1441603559088, 3264.379767844102, 5040.747962601874, 5575.526080283161, 5927.288725352963, 5821.27234095738, 5907.527397808187, 5913.704314784265, 5929.970350148244, 5937.67342796146, 5603.254405341394, 5924.88150236995, 5957.523398128183, 5964.850878728023, 5964.88070238595, 2836.0, 4751.928721069186, 5159.25190847325, 5160.071187186305, 5182.0, 19972.600547989103, 21157.365279041653, 21160.365189044198, 21492.24777132793, 21562.1375144994, 1849.9630007399776, 1906.609145125246, 2115.9788402115937, 2141.764405915348, 2218.4010317214425, 12629.936850315782, 12858.807117893239, 12923.806142907864, 12959.28723920184, 13104.2137471752, 1517.9013364131297, 1549.4189678870423, 1554.2850288867135, 1625.6098536351308, 1650.2573841771132, 64758.352416475704, 67031.66484167548, 67642.66178669124, 68337.65831170812, 68450.0, 8812.691555795516, 9159.77100572491, 9466.857997130048, 9743.65897193609, 9892.763404574429, 12904.419301131471, 12948.805767913489, 13019.414126364336, 13046.282454464907, 13079.280639564915, 7588.0, 7653.464257501922, 7660.846783064308, 7746.109197442366, 7775.22247775218, 7671.654775535114, 7673.117591477052, 7678.308952194329, 7791.142974272825, 7809.477151955428, 6063.151158837766, 6099.359567245464, 6111.205543279345, 6136.110264011782, 6272.153259310026, 1482.3477669825243, 1567.968640627204, 1654.436557453195, 1682.6550557135758, 1749.22159638962, 781.1368437876179, 828.3745771942146, 924.0159230419716, 954.4845783276953, 966.7148191283447, 17535.953739936795, 17604.0, 17825.643487130186, 18193.45419637413, 18312.633747325246, 823.0822632764424, 865.264525153627, 871.9258862996717, 929.5506340791927, 933.071593764209, 9282.48946307946, 10138.797224055477, 10349.586016559404, 10376.740581485523, 10422.322549034288, 402514.0, 405208.0, 405413.0, 406611.0, 407508.0, 83390.0, 83474.16525834786, 84297.57851210705, 84816.15183848083, 86349.56825215834, 923.9445633262026, 924.7364501117283, 937.231470194434, 945.432740355781, 964.8359778837474, 15391.84608153904, 15725.842741572438, 15796.842031579537, 15896.046237225804, 16222.26999784989, 26969.325766855985, 35732.64267357293, 36167.0, 37028.44457333088, 37106.25787484181, 51139.74430127825, 51602.48397516127, 53069.61186746683, 53095.0, 53882.191767124306, 6657.0, 6991.8252043697275, 7243.130824301117, 7358.11702595692, 7707.0, 8695.217430431292, 10840.241183117107, 11523.596674116367, 11580.594679186524, 11585.189036767682, 9533.0, 9593.376430531993, 10075.84886226722, 10088.243381746252, 10421.791564168825, 10187.592496300362, 10515.211359148247, 10601.575936962743, 10665.626703065356, 10863.130949524177, 7349.77950661481, 10393.636222732168, 10408.843867342148, 10458.111060559937, 10511.369317840954, 7170.211276759448, 7205.315495027964, 7225.602591857499, 7329.303716146957, 7367.447441441806, 8017.438779285394, 9602.615895364108, 10548.683539493828, 10705.625303114353, 10804.783904322027], "value": 8309.739896374878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.5057426455155, 1360.3334366160582, 1367.4940272099325, 1463.3926920328065, 1709.1198033013, 6496.545241833073, 7210.2789721027875, 7396.704131834734, 7428.9257107428975, 7616.543007419558, 7372.520786148896, 7465.664045117969, 7473.4768566200255, 7491.812704682386, 7503.13713922899, 1852.7220916862443, 2069.492974221318, 2141.1649456711893, 2147.999999999996, 2172.228858755143, 2210.624193887043, 2224.3882932193615, 2227.1536816009893, 2231.843770936035, 2235.4299653588314, 2153.54775497145, 2178.1396348442354, 2190.693302937582, 2190.715207023085, 2193.2433310507927, 1581.430684953416, 2071.8653287536413, 2104.8947552622385, 2143.571285742842, 2143.8499305048654, 2157.6655618379177, 2172.2940044485604, 2189.8467107302336, 2191.0359441845694, 2192.6162921488835, 7876.5667888266125, 7904.525728456253, 7925.603719813987, 7929.682812687485, 7943.046834379911, 4505.346724724896, 4682.508336624674, 4683.110209060268, 4694.413198350207, 4706.835260765857, 2679.7856171506232, 2785.860706964664, 2831.5044867148167, 2872.224499385154, 2874.152125123073, 887.8535041718109, 895.8074014087002, 904.7285814255763, 916.5508900638706, 920.2270093121743, 10566.577336906592, 10597.629082982136, 10609.15126789855, 10612.575496980111, 10629.574817007311, 4084.3056680363816, 4223.873283801491, 4224.640905523003, 4236.788160591958, 4296.5273819879785, 8994.730158095268, 9042.683506077386, 9075.0, 9075.183233509017, 9077.409968352036, 4712.764361781898, 4727.338172655762, 4729.0541891621815, 4730.0, 4730.787114579852, 3561.28774245152, 4051.4125451809323, 4239.660827133822, 4276.2516559601945, 4276.444062271947, 3575.5351804265797, 3619.7104231661406, 3627.5828279748166, 3714.9442758358646, 3716.591174970751, 1159.6636975277245, 1171.5255321594768, 1183.177691504396, 1204.1390405859852, 1208.0, 777.3470284960661, 788.968441262343, 793.7579038393345, 795.6061749434067, 812.1999830167281, 4799.3760811094335, 4966.726830024383, 4976.452590215146, 5026.974865125651, 5079.949200507947, 879.1077056787366, 885.3713863157102, 901.3780491461002, 920.2729843423621, 934.345957829522, 3235.255891145003, 3254.1213872254357, 3290.1116698491273, 3309.6690330966712, 3349.6315405305395, 8944.01615822259, 9085.273178145733, 9096.499692516843, 9241.768955776024, 9263.0, 8949.821003580022, 8959.955200223958, 8967.372283940193, 8981.640734370552, 9155.084491550791, 7115.501914866013, 7161.104861892263, 7249.492535522569, 7264.0, 7375.8156046099275, 4921.483244259444, 4948.356713627206, 4983.202687569971, 5009.4489606144025, 5061.443241243386, 8603.483790972561, 8760.78098047554, 8928.86606700887, 9024.0, 9062.22971047442, 8836.513991730517, 9023.819523609622, 9065.229455496357, 9072.047435019493, 9170.862437063583, 5233.633645644768, 5463.699496527729, 5467.753951072291, 6188.504919606511, 6334.4932405406535, 6650.667466626553, 6721.529492935448, 6738.157730283715, 7017.578945263301, 7021.929780702128, 6364.93635063662, 6566.409023187936, 6655.700493477708, 6715.093462382516, 6746.966265168643, 6224.844378890382, 6233.532485063548, 6242.906356404566, 6321.462675672619, 6346.048092786119, 5855.238818953509, 5876.030454974882, 5913.733881975408, 5932.584719069796, 5940.376260492586, 4105.302098643178, 4158.480189976253, 4210.789460527023, 4241.575842415734, 4272.295071313323, 4226.4928208615165, 4263.914721705611, 4293.806778694904, 4331.97834010828, 4367.45406824147], "value": 4010.1753136649204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.188655162614, 288.69686828829737, 295.34433557502365, 295.7205440858388, 296.7759341697017, 4724.669273150885, 4803.25549539821, 4807.975960120195, 4821.252705830598, 4845.127876982142, 4685.88285292867, 4736.43162820462, 4738.384010078685, 4753.358296629954, 4770.045990801845, 3497.492863534786, 3552.307300076486, 3611.9277614447697, 3719.6094410086957, 3742.4760533525327, 3694.8891533254045, 3703.6296570269037, 3703.8518459261595, 3714.405695088786, 3717.814109294538, 3687.211702324384, 3692.612275711052, 3693.1136527233407, 3705.3515634763944, 3713.591504934455, 3462.567179102612, 3579.463080537927, 3712.0, 3718.367877460811, 3733.4959780429836, 3267.983660081708, 3289.490129030004, 3291.374638818617, 3291.913668489393, 3301.5542901708204, 4616.746078965655, 4649.395578574798, 4653.930191047103, 4655.255159174516, 4680.508546602592, 3940.4483372327895, 4145.937810932808, 4249.32010878258, 4268.231718290706, 4283.3360829071235, 4848.0, 4900.191468407708, 4906.582940450066, 4914.533119353656, 4922.187839006559, 3467.150548115728, 3468.9479657805155, 3484.6341134181052, 3492.7205823534055, 3504.4743288506675, 5048.570871475929, 5137.820176293849, 5211.42674305826, 5217.191335343028, 5218.191180367049, 3548.290341931624, 3548.964510354915, 3560.608333083359, 3571.125074356747, 3572.4105522589, 3603.9099022524647, 3604.891853244407, 3630.854765809338, 3643.799591022519, 3648.1426864686778, 4171.707980441401, 4181.916361672749, 4191.7694526801315, 4200.4959404871, 4204.201201771715, 4825.276208568743, 4941.308216849644, 4942.431620363633, 4994.175960966472, 5020.949790502048, 1232.8828761267666, 1243.4031664800946, 1248.151257145132, 1251.4919521975996, 1260.350919276555, 769.869122249219, 772.5055964182927, 784.3920961254959, 791.9208079192035, 800.3197282310106, 4366.388705581221, 4450.666200035011, 4474.418325617649, 4482.439695038121, 4506.887327816765, 5072.416672082684, 5107.54032137102, 5118.38579370478, 5127.743612819344, 5152.330197074356, 4432.246518091933, 4464.352668862996, 4469.932951005738, 4472.709273897186, 4482.574155455227, 2594.364380726734, 2729.0, 2730.2901245676267, 2743.3553115017953, 2743.711910249435, 4873.6832105913, 4880.902381952341, 4888.0, 4892.31215230752, 4900.901981960341, 4961.8511444656715, 5172.0, 5201.635885487979, 5204.557612602971, 5225.406251093453, 4842.498825364149, 4850.5149485051215, 4881.707097574157, 4888.706677599355, 4901.0, 5108.974455127701, 5158.922616160686, 5184.662996905189, 5198.116320225647, 5198.246254293182, 4753.9049219016115, 4998.550130488274, 5036.949630503795, 5037.546620804145, 5044.848654540223, 4825.420949486084, 4846.248831431134, 4874.780634871368, 4894.311462545416, 4900.681455705368, 3645.325614761278, 3656.926861462809, 3669.4495825625304, 3704.722145839127, 3713.2387860489075, 4961.355023846877, 5120.564751996122, 5121.180611102206, 5181.145111056633, 5209.374875015023, 4882.780274887709, 4897.3878265216845, 4933.235348520985, 4977.328060711902, 5013.523715247045, 4884.194107972145, 4918.508149185053, 4982.900341993212, 5020.347354843847, 5042.823501177441, 4644.349791029326, 4899.975500122477, 4900.754962251945, 4930.161872481615, 4956.355673762388, 4800.447948485829, 4925.8228442655, 5009.743666616729, 5072.898542029213, 5074.908894587681, 4896.338994235875, 4918.82784102569, 4929.162042452864, 4935.8025678972435, 4950.282209079592], "value": 3738.85766498184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.7050451747019, 553.7923278770461, 562.2353599105217, 593.4925289764, 605.6517502436099, 11326.716832079192, 12040.518379264819, 12049.337286449241, 12052.0, 12076.0, 12178.634640960785, 12361.50553977842, 12379.381030948462, 12456.937715311411, 12573.748525029494, 611.761413048909, 628.6605233174081, 759.2066290726191, 759.8480303939207, 771.8301973565834, 775.90689117306, 781.8319061401797, 783.9176886426928, 784.0591290451453, 785.1441928298154, 827.0241115483727, 828.7223780033696, 829.2785276809185, 829.3903980574273, 829.5105887526358, 642.4346575014005, 781.6482582837689, 810.9716159934374, 811.3184924663311, 823.9217274358926, 593.326574338125, 593.6527131628003, 593.6675461741438, 595.036041612586, 595.0568349166576, 10981.505832237568, 11043.944780276128, 11101.72245693856, 11134.16493762971, 11137.05335046522, 11662.0, 11905.464254108585, 11944.163908526407, 12234.327112008836, 12431.12982091254, 10661.253712240146, 10696.62561810333, 10746.78506429867, 10848.457577121191, 11014.889851101467, 4096.692748043879, 4144.212599606095, 4168.2080404723, 4184.309588917825, 4322.135572885435, 56131.15803262914, 56774.0, 58391.99999999958, 58921.0, 59694.70152649252, 9448.952755236318, 9530.237580993504, 9559.856602150974, 9684.322097453252, 9748.658796942214, 18279.086045697662, 18292.634147316978, 18293.634127317644, 18320.816791831912, 18367.81632183661, 6591.934080659228, 6646.734130634817, 6660.866782664417, 6720.2943690912725, 6775.3902148805855, 3425.9143521412166, 3428.3314753622803, 3445.328161008629, 3532.5760908691122, 3533.505309256706, 2507.18516482144, 2605.9087931922672, 2618.1883616079076, 2628.1458525979133, 2628.8422694638384, 359.34419684076664, 466.274942464471, 476.4966530595975, 478.62906247657645, 479.7673128532659, 535.9490848369398, 540.3758658749151, 550.402812947948, 558.4638746803033, 565.7793460550389, 7266.7093316266755, 7362.555351012403, 7422.591757453392, 7480.925190748132, 7528.548287102792, 437.4116812886662, 491.15276148644017, 518.142474205191, 520.3599572525738, 541.0990700483651, 3341.4820702791108, 3434.3303055904357, 3621.6921561667555, 3691.1325838427947, 3748.475213470116, 58083.4191658078, 93838.0, 102133.48933255287, 103235.0, 104929.0, 53019.73490132602, 53411.46588534065, 54422.0, 74357.6282118586, 78247.21752782514, 77848.0, 80280.0, 80304.0, 80720.78918816222, 80759.59620201861, 6830.59016459014, 7038.260982596754, 7114.644267786486, 7132.786016419515, 7259.419246460165, 43420.782896085315, 47776.0, 48327.516724832305, 48693.0, 48780.51219487902, 52381.7380913093, 54506.45493545172, 67274.0, 70367.0, 70584.29415705982, 10368.585256589953, 11100.333979961228, 11147.888521114684, 11529.942350288195, 11880.22778519428, 11411.942940285246, 11739.530418783153, 11753.294802311888, 11849.466773995018, 11976.28142311464, 11122.388268645302, 11360.261582997078, 11819.349935753617, 11994.76010479803, 12003.799620038275, 10929.0, 10968.396738179477, 11050.281731687415, 11419.0, 11560.768784624428, 8585.699500517452, 9077.636894524145, 9351.251899847859, 9622.422654640744, 10432.895671043496, 9249.0, 9738.853917191389, 9801.950990245003, 9973.650922217977, 10145.49272536385, 9125.45247285165, 9640.903590964, 9754.17089547368, 9755.951220244136, 9817.65638202688], "value": 6194.133917551776, "unit": "score"}], "name": "dromaeo_css", "value": 6229.333171401807, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 132.0, 133.0, 183.0, 130.0, 131.0, 153.0, 130.0, 166.0, 130.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 120.0, 75.0, 76.0, 76.0, 75.0, 99.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 112.0, 87.0, 88.0, 86.0, 111.0, 87.0, 86.0, 137.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 65.0, 68.0, 63.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 88.0, 91.0, 85.0, 87.0, 92.0, 119.0, 87.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 131.0, 131.0, 138.0, 140.0, 131.0, 129.0, 151.0, 142.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 166.0, 165.0, 168.0, 168.0, 179.0, 165.0, 170.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 68.0, 66.0, 65.0, 71.0, 67.0, 67.0, 75.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1547.5, "alertThreshold": 2.0}]} 09:26:09 INFO - Return code: 0 09:26:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:09 ERROR - # TBPL SUCCESS # 09:26:09 INFO - Running post-action listener: _resource_record_post_action 09:26:09 INFO - ##### 09:26:09 INFO - ##### Finished run-tests step (success) 09:26:09 INFO - ##### 09:26:09 INFO - Running post-run listener: _resource_record_post_run 09:26:09 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533979136; Read time: 12; Write time: 452276 09:26:09 INFO - TinderboxPrint: CPU usage
13.1% 09:26:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:26:09 INFO - TinderboxPrint: I/O write bytes / time
533,979,136 / 452,276 09:26:09 INFO - TinderboxPrint: CPU idle
8,331.8 (86.8%) 09:26:09 INFO - TinderboxPrint: CPU user
1,214.4 (12.7%) 09:26:09 INFO - TinderboxPrint: Swap in / out
0 / 0 09:26:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238125056; Read time: 0; Write time: 243888 09:26:09 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295383040; Read time: 12; Write time: 208388 09:26:09 INFO - Running post-run listener: _upload_blobber_files 09:26:09 INFO - Blob upload gear active. 09:26:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:09 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 09:26:09 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'] 09:26:09 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 09:26:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:10 INFO - (blobuploader) - INFO - Done attempting. 09:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:14 INFO - (blobuploader) - INFO - Done attempting. 09:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:15 INFO - (blobuploader) - INFO - Done attempting. 09:26:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:15 INFO - Return code: 0 09:26:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe6d02cf2845458a30b7ef021ba1d8f54d9b4102dfd280f8e2fd4d33e9ea5de1e35401122459ae7a6cf251715f4a5c3aed4e59b18b2f9143605db55679ae64a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2a5e60f11bce7f57480e94520593b1518d4951b1252ca989703eda79c2f5566a55ea0b199611dd0daf0a10d80a7818b0fecaff57e5d688b7dede57b23126340", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85ce14ddfd8526ddba1108b2de476d9e37f5fcda571b5fa7051d0a3f188f7a1256a4d69845800624202e1529cef7e1959e7c9cd49fcdf95e638e61beb9f7315a"} 09:26:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:15 INFO - Contents: 09:26:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe6d02cf2845458a30b7ef021ba1d8f54d9b4102dfd280f8e2fd4d33e9ea5de1e35401122459ae7a6cf251715f4a5c3aed4e59b18b2f9143605db55679ae64a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2a5e60f11bce7f57480e94520593b1518d4951b1252ca989703eda79c2f5566a55ea0b199611dd0daf0a10d80a7818b0fecaff57e5d688b7dede57b23126340", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85ce14ddfd8526ddba1108b2de476d9e37f5fcda571b5fa7051d0a3f188f7a1256a4d69845800624202e1529cef7e1959e7c9cd49fcdf95e638e61beb9f7315a"} 09:26:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:15 INFO - Copying logs to upload dir... 09:26:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.359277 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-09 09:26:15.002309) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:15.006027) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881 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/fe6d02cf2845458a30b7ef021ba1d8f54d9b4102dfd280f8e2fd4d33e9ea5de1e35401122459ae7a6cf251715f4a5c3aed4e59b18b2f9143605db55679ae64a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2a5e60f11bce7f57480e94520593b1518d4951b1252ca989703eda79c2f5566a55ea0b199611dd0daf0a10d80a7818b0fecaff57e5d688b7dede57b23126340", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85ce14ddfd8526ddba1108b2de476d9e37f5fcda571b5fa7051d0a3f188f7a1256a4d69845800624202e1529cef7e1959e7c9cd49fcdf95e638e61beb9f7315a"} build_url:https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011141 build_url: 'https://queue.taskcluster.net/v1/task/DVakswhjR2WtCuI7Kw8wVg/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/fe6d02cf2845458a30b7ef021ba1d8f54d9b4102dfd280f8e2fd4d33e9ea5de1e35401122459ae7a6cf251715f4a5c3aed4e59b18b2f9143605db55679ae64a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2a5e60f11bce7f57480e94520593b1518d4951b1252ca989703eda79c2f5566a55ea0b199611dd0daf0a10d80a7818b0fecaff57e5d688b7dede57b23126340", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/85ce14ddfd8526ddba1108b2de476d9e37f5fcda571b5fa7051d0a3f188f7a1256a4d69845800624202e1529cef7e1959e7c9cd49fcdf95e638e61beb9f7315a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:15.031299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:15.031655) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465488077.711091-1410063881 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:26:15.116535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:26:15.116859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:26:15.117177) ========= ========= Total master_lag: 0.17 =========