builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1466757873.79 results: success (0) buildid: 20160624011358 builduid: d4b31aa6fc1942da84303150936f394d revision: 9d3e753faf2b337ddbe63ee92b5202c39b3c995e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:33.794378) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:33.794795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:33.795073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:33.847640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:33.847889) ========= 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=fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 01:44:35-- 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% 26.1M=0s 2016-06-24 01:44:35 (26.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116576 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:33.978532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:33.978810) ========= 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=fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015451 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:34.027388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 01:44:34.027694) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d3e753faf2b337ddbe63ee92b5202c39b3c995e --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 9d3e753faf2b337ddbe63ee92b5202c39b3c995e --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=fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 01:44:35,282 truncating revision to first 12 chars 2016-06-24 01:44:35,282 Setting DEBUG logging. 2016-06-24 01:44:35,282 attempt 1/10 2016-06-24 01:44:35,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d3e753faf2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 01:44:36,522 unpacking tar archive at: fx-team-9d3e753faf2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.593792 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 01:44:35.634808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:35.635170) ========= script_repo_revision: 9d3e753faf2b337ddbe63ee92b5202c39b3c995e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:35.635575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:35.635867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 01:44:35.645945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-24 01:44:35.646228) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:44:36 INFO - MultiFileLogger online at 20160624 01:44:36 in /builds/slave/test 01:44:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 01:44:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:44:36 INFO - {'append_to_log': False, 01:44:36 INFO - 'base_work_dir': '/builds/slave/test', 01:44:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:44:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:44:36 INFO - 'branch': 'Fx-Team-Non-PGO', 01:44:36 INFO - 'buildbot_json_path': 'buildprops.json', 01:44:36 INFO - 'config_files': ('talos/linux_config.py',), 01:44:36 INFO - 'default_actions': ('clobber', 01:44:36 INFO - 'read-buildbot-config', 01:44:36 INFO - 'download-and-extract', 01:44:36 INFO - 'populate-webroot', 01:44:36 INFO - 'create-virtualenv', 01:44:36 INFO - 'install', 01:44:36 INFO - 'run-tests'), 01:44:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:44:36 INFO - 'download_minidump_stackwalk': True, 01:44:36 INFO - 'download_symbols': 'ondemand', 01:44:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:44:36 INFO - 'tooltool.py': '/tools/tooltool.py', 01:44:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:44:36 INFO - '/tools/misc-python/virtualenv.py')}, 01:44:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:44:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:44:36 INFO - 'installer_path': 'installer.exe', 01:44:36 INFO - 'log_level': 'info', 01:44:36 INFO - 'log_name': 'talos', 01:44:36 INFO - 'log_to_console': True, 01:44:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:44:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:44:36 INFO - 'opt_config_files': (), 01:44:36 INFO - 'pip_index': False, 01:44:36 INFO - 'sps_profile': False, 01:44:36 INFO - 'sps_profile_interval': 0, 01:44:36 INFO - 'suite': 'dromaeojs-e10s', 01:44:36 INFO - 'system_bits': '32', 01:44:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:44:36 INFO - 'title': 'talos-linux64-ix-048', 01:44:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:44:36 INFO - 'use_talos_json': True, 01:44:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:44:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:44:36 INFO - 'work_dir': 'build'} 01:44:36 INFO - ##### 01:44:36 INFO - ##### Running clobber step. 01:44:36 INFO - ##### 01:44:36 INFO - Running pre-action listener: _resource_record_pre_action 01:44:36 INFO - Running main action method: clobber 01:44:36 INFO - rmtree: /builds/slave/test/build 01:44:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:44:37 INFO - Running post-action listener: _resource_record_post_action 01:44:37 INFO - ##### 01:44:37 INFO - ##### Finished clobber step (success) 01:44:37 INFO - ##### 01:44:37 INFO - ##### 01:44:37 INFO - ##### Running read-buildbot-config step. 01:44:37 INFO - ##### 01:44:37 INFO - Running pre-action listener: _resource_record_pre_action 01:44:37 INFO - Running main action method: read_buildbot_config 01:44:37 INFO - Using buildbot properties: 01:44:37 INFO - { 01:44:37 INFO - "project": "", 01:44:37 INFO - "product": "firefox", 01:44:37 INFO - "script_repo_revision": "production", 01:44:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:44:37 INFO - "repository": "", 01:44:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:44:37 INFO - "buildid": "20160624011358", 01:44:37 INFO - "pgo_build": "False", 01:44:37 INFO - "basedir": "/builds/slave/test", 01:44:37 INFO - "buildnumber": 1609, 01:44:37 INFO - "slavename": "talos-linux64-ix-048", 01:44:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:44:37 INFO - "platform": "ubuntu64_hw", 01:44:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:44:37 INFO - "branch": "fx-team", 01:44:37 INFO - "repo_path": "integration/fx-team", 01:44:37 INFO - "revision": "9d3e753faf2b337ddbe63ee92b5202c39b3c995e", 01:44:37 INFO - "stage_platform": "linux64", 01:44:37 INFO - "builduid": "d4b31aa6fc1942da84303150936f394d", 01:44:37 INFO - "slavebuilddir": "test" 01:44:37 INFO - } 01:44:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:44:37 INFO - Running post-action listener: _resource_record_post_action 01:44:37 INFO - ##### 01:44:37 INFO - ##### Finished read-buildbot-config step (success) 01:44:37 INFO - ##### 01:44:37 INFO - ##### 01:44:37 INFO - ##### Running download-and-extract step. 01:44:37 INFO - ##### 01:44:37 INFO - Running pre-action listener: _resource_record_pre_action 01:44:37 INFO - Running main action method: download_and_extract 01:44:37 INFO - mkdir: /builds/slave/test/build/tests 01:44:37 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')]} 01:44:37 INFO - https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:44:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:44:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:44:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:39 INFO - Downloaded 1361 bytes. 01:44:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:44:39 INFO - Using the following test package requirements: 01:44:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:44:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:44:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:44:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'jsshell-linux-x86_64.zip'], 01:44:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:44:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:44:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:44:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:44:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:44:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:44:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:44:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:44: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')]} 01:44:39 INFO - https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:44:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:44:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:44:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:44 INFO - Downloaded 22709646 bytes. 01:44:44 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'] 01:44:44 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 01:44:45 INFO - Return code: 0 01:44:45 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 01:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:45 INFO - https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:44:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:44:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:44:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:46 INFO - Downloaded 22709646 bytes. 01:44:46 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'] 01:44:46 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 01:44:47 INFO - Return code: 0 01:44: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')]} 01:44:47 INFO - https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:48 INFO - Downloaded 14405384 bytes. 01:44:48 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'] 01:44:48 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 01:44:49 INFO - Return code: 0 01:44: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')]} 01:44:49 INFO - https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CaLVjul-QiGt6k0X206EWg/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 01:44:50 INFO - Downloaded 56262801 bytes. 01:44:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:44:50 INFO - mkdir: /builds/slave/test/properties 01:44:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:44:50 INFO - Writing to file /builds/slave/test/properties/build_url 01:44:50 INFO - Contents: 01:44:50 INFO - build_url:https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:44:51 INFO - Running post-action listener: _resource_record_post_action 01:44:51 INFO - Running post-action listener: set_extra_try_arguments 01:44:51 INFO - ##### 01:44:51 INFO - ##### Finished download-and-extract step (success) 01:44:51 INFO - ##### 01:44:51 INFO - ##### 01:44:51 INFO - ##### Running populate-webroot step. 01:44:51 INFO - ##### 01:44:51 INFO - Running pre-action listener: _resource_record_pre_action 01:44:51 INFO - Running main action method: populate_webroot 01:44:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:44:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:44:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:44:51 INFO - '--tppagecycles', 01:44:51 INFO - '7'], 01:44:51 INFO - 'tests': ['tsvgm']}}, 01:44:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:44:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:44:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:44:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:44:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:44:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:44:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['damp', 'tps']}, 01:44:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'tests': ['damp', 'tps']}, 01:44:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['dromaeo_dom']}, 01:44:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:44:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['basic_compositor_video']}, 01:44:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:44:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['a11yr', 01:44:51 INFO - 'ts_paint', 01:44:51 INFO - 'tpaint', 01:44:51 INFO - 'sessionrestore', 01:44:51 INFO - 'sessionrestore_no_auto_restore', 01:44:51 INFO - 'tabpaint']}, 01:44:51 INFO - 'other-e10s': {'tests': ['a11yr', 01:44:51 INFO - 'ts_paint', 01:44:51 INFO - 'tpaint', 01:44:51 INFO - 'sessionrestore', 01:44:51 INFO - 'sessionrestore_no_auto_restore', 01:44:51 INFO - 'tabpaint']}, 01:44:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:44:51 INFO - 'ts_paint', 01:44:51 INFO - 'tpaint', 01:44:51 INFO - 'sessionrestore', 01:44:51 INFO - 'sessionrestore_no_auto_restore', 01:44:51 INFO - 'tabpaint']}, 01:44:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:44:51 INFO - 'ts_paint', 01:44:51 INFO - 'tpaint', 01:44:51 INFO - 'sessionrestore', 01:44:51 INFO - 'sessionrestore_no_auto_restore', 01:44:51 INFO - 'tabpaint']}, 01:44:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['a11yr', 01:44:51 INFO - 'ts_paint', 01:44:51 INFO - 'tpaint', 01:44:51 INFO - 'sessionrestore', 01:44:51 INFO - 'sessionrestore_no_auto_restore', 01:44:51 INFO - 'tabpaint']}, 01:44:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['a11yr', 01:44:51 INFO - 'ts_paint', 01:44:51 INFO - 'tpaint', 01:44:51 INFO - 'sessionrestore', 01:44:51 INFO - 'sessionrestore_no_auto_restore', 01:44:51 INFO - 'tabpaint']}, 01:44:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['tsvgx', 01:44:51 INFO - 'tsvgr_opacity', 01:44:51 INFO - 'tart', 01:44:51 INFO - 'tscrollx', 01:44:51 INFO - 'cart']}, 01:44:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:44:51 INFO - 'tsvgr_opacity', 01:44:51 INFO - 'tart', 01:44:51 INFO - 'tscrollx', 01:44:51 INFO - 'cart']}, 01:44:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'talos_options': ['--disable-e10s'], 01:44:51 INFO - 'tests': ['tp5o']}, 01:44:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'tests': ['tp5o']}, 01:44:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'talos_options': ['--disable-e10s', 01:44:51 INFO - '--xperf_path', 01:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:44:51 INFO - 'tests': ['tp5n']}, 01:44:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:51 INFO - 'talos_options': ['--xperf_path', 01:44:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:44:51 INFO - 'tests': ['tp5n']}}, 01:44:51 INFO - 'talos.zip': {'path': '', 01:44:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:44:51 INFO - Running post-action listener: _resource_record_post_action 01:44:51 INFO - ##### 01:44:51 INFO - ##### Finished populate-webroot step (success) 01:44:51 INFO - ##### 01:44:51 INFO - ##### 01:44:51 INFO - ##### Running create-virtualenv step. 01:44:51 INFO - ##### 01:44:51 INFO - Running pre-action listener: _resource_record_pre_action 01:44:51 INFO - Running main action method: create_virtualenv 01:44:51 INFO - Creating virtualenv /builds/slave/test/build/venv 01:44:51 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 01:44:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:44:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:44:51 INFO - Using real prefix '/usr' 01:44:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:44:51 INFO - Installing distribute.............................................................................................................................................................................................done. 01:44:53 INFO - Installing pip.................done. 01:44:53 INFO - Return code: 0 01:44:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:53 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:44:53 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 01:44:53 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 01:44:53 INFO - Using env: {'DISPLAY': ':0', 01:44:53 INFO - 'HOME': '/home/cltbld', 01:44:53 INFO - 'LANG': 'en_US.UTF-8', 01:44:53 INFO - 'LANGUAGE': 'en_US:en', 01:44:53 INFO - 'LOGNAME': 'cltbld', 01:44:53 INFO - 'MAIL': '/var/mail/cltbld', 01:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:53 INFO - 'MOZ_NO_REMOTE': '1', 01:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:53 INFO - 'NO_EM_RESTART': '1', 01:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:53 INFO - 'PWD': '/builds/slave/test', 01:44:53 INFO - 'SHELL': '/bin/bash', 01:44:53 INFO - 'SHLVL': '1', 01:44:53 INFO - 'TERM': 'linux', 01:44:53 INFO - 'TMOUT': '86400', 01:44:53 INFO - 'USER': 'cltbld', 01:44:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:53 INFO - '_': '/tools/buildbot/bin/python'} 01:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:53 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 01:44:53 INFO - Cleaning up... 01:44:54 INFO - Return code: 0 01:44:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:44:54 INFO - Using env: {'DISPLAY': ':0', 01:44:54 INFO - 'HOME': '/home/cltbld', 01:44:54 INFO - 'LANG': 'en_US.UTF-8', 01:44:54 INFO - 'LANGUAGE': 'en_US:en', 01:44:54 INFO - 'LOGNAME': 'cltbld', 01:44:54 INFO - 'MAIL': '/var/mail/cltbld', 01:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:54 INFO - 'MOZ_NO_REMOTE': '1', 01:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:54 INFO - 'NO_EM_RESTART': '1', 01:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:54 INFO - 'PWD': '/builds/slave/test', 01:44:54 INFO - 'SHELL': '/bin/bash', 01:44:54 INFO - 'SHLVL': '1', 01:44:54 INFO - 'TERM': 'linux', 01:44:54 INFO - 'TMOUT': '86400', 01:44:54 INFO - 'USER': 'cltbld', 01:44:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:54 INFO - '_': '/tools/buildbot/bin/python'} 01:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:54 INFO - Downloading/unpacking psutil>=3.1.1 01:44: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 01:44: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 01:44: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 01:44: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 01:44: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 01:44: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 01:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:44:56 INFO - Installing collected packages: psutil 01:44:56 INFO - Running setup.py install for psutil 01:44:56 INFO - building 'psutil._psutil_linux' extension 01:44:56 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 01:44:56 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 01:44:56 INFO - building 'psutil._psutil_posix' extension 01:44:56 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 01:44:56 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 01:44:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:44:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:44:56 INFO - Successfully installed psutil 01:44:56 INFO - Cleaning up... 01:44:56 INFO - Return code: 0 01:44:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:44:56 INFO - Using env: {'DISPLAY': ':0', 01:44:56 INFO - 'HOME': '/home/cltbld', 01:44:56 INFO - 'LANG': 'en_US.UTF-8', 01:44:56 INFO - 'LANGUAGE': 'en_US:en', 01:44:56 INFO - 'LOGNAME': 'cltbld', 01:44:56 INFO - 'MAIL': '/var/mail/cltbld', 01:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:56 INFO - 'MOZ_NO_REMOTE': '1', 01:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:56 INFO - 'NO_EM_RESTART': '1', 01:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:56 INFO - 'PWD': '/builds/slave/test', 01:44:56 INFO - 'SHELL': '/bin/bash', 01:44:56 INFO - 'SHLVL': '1', 01:44:56 INFO - 'TERM': 'linux', 01:44:56 INFO - 'TMOUT': '86400', 01:44:56 INFO - 'USER': 'cltbld', 01:44:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:56 INFO - '_': '/tools/buildbot/bin/python'} 01:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:44:58 INFO - Installing collected packages: mozsystemmonitor 01:44:58 INFO - Running setup.py install for mozsystemmonitor 01:44:59 INFO - Successfully installed mozsystemmonitor 01:44:59 INFO - Cleaning up... 01:44:59 INFO - Return code: 0 01:44:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:44: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')]} 01:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44: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')]} 01:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:59 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:44:59 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 01:44:59 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 01:44:59 INFO - Using env: {'DISPLAY': ':0', 01:44:59 INFO - 'HOME': '/home/cltbld', 01:44:59 INFO - 'LANG': 'en_US.UTF-8', 01:44:59 INFO - 'LANGUAGE': 'en_US:en', 01:44:59 INFO - 'LOGNAME': 'cltbld', 01:44:59 INFO - 'MAIL': '/var/mail/cltbld', 01:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:59 INFO - 'MOZ_NO_REMOTE': '1', 01:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:59 INFO - 'NO_EM_RESTART': '1', 01:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:59 INFO - 'PWD': '/builds/slave/test', 01:44:59 INFO - 'SHELL': '/bin/bash', 01:44:59 INFO - 'SHLVL': '1', 01:44:59 INFO - 'TERM': 'linux', 01:44:59 INFO - 'TMOUT': '86400', 01:44:59 INFO - 'USER': 'cltbld', 01:44:59 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:59 INFO - '_': '/tools/buildbot/bin/python'} 01:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:59 INFO - Downloading/unpacking jsonschema==2.5.1 01:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:45:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:01 INFO - Downloading functools32-3.2.3-2.tar.gz 01:45:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:45:01 INFO - warning: no files found matching '*.txt' 01:45:01 INFO - no previously-included directories found matching 'build' 01:45:01 INFO - no previously-included directories found matching 'dist' 01:45:01 INFO - no previously-included directories found matching '.git*' 01:45:01 INFO - Installing collected packages: jsonschema, functools32 01:45:01 INFO - Running setup.py install for functools32 01:45:01 INFO - warning: no files found matching '*.txt' 01:45:01 INFO - no previously-included directories found matching 'build' 01:45:01 INFO - no previously-included directories found matching 'dist' 01:45:01 INFO - no previously-included directories found matching '.git*' 01:45:01 INFO - Successfully installed jsonschema functools32 01:45:01 INFO - Cleaning up... 01:45:01 INFO - Return code: 0 01:45:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:45:01 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')]} 01:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:01 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')]} 01:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:01 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:45:01 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 01:45:01 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 01:45:01 INFO - Using env: {'DISPLAY': ':0', 01:45:01 INFO - 'HOME': '/home/cltbld', 01:45:01 INFO - 'LANG': 'en_US.UTF-8', 01:45:01 INFO - 'LANGUAGE': 'en_US:en', 01:45:01 INFO - 'LOGNAME': 'cltbld', 01:45:01 INFO - 'MAIL': '/var/mail/cltbld', 01:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:01 INFO - 'MOZ_NO_REMOTE': '1', 01:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:01 INFO - 'NO_EM_RESTART': '1', 01:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:01 INFO - 'PWD': '/builds/slave/test', 01:45:01 INFO - 'SHELL': '/bin/bash', 01:45:01 INFO - 'SHLVL': '1', 01:45:01 INFO - 'TERM': 'linux', 01:45:01 INFO - 'TMOUT': '86400', 01:45:01 INFO - 'USER': 'cltbld', 01:45:01 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:01 INFO - '_': '/tools/buildbot/bin/python'} 01:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:01 INFO - Downloading/unpacking blobuploader==1.2.4 01:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:03 INFO - Downloading blobuploader-1.2.4.tar.gz 01:45:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:45:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:45:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 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 01:45:04 INFO - Downloading docopt-0.6.1.tar.gz 01:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:45:04 INFO - Installing collected packages: blobuploader, requests, docopt 01:45:04 INFO - Running setup.py install for blobuploader 01:45:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:45:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:45:04 INFO - Running setup.py install for requests 01:45:05 INFO - Running setup.py install for docopt 01:45:05 INFO - Successfully installed blobuploader requests docopt 01:45:05 INFO - Cleaning up... 01:45:05 INFO - Return code: 0 01:45:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:05 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:45:05 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 01:45:05 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 01:45:05 INFO - Using env: {'DISPLAY': ':0', 01:45:05 INFO - 'HOME': '/home/cltbld', 01:45:05 INFO - 'LANG': 'en_US.UTF-8', 01:45:05 INFO - 'LANGUAGE': 'en_US:en', 01:45:05 INFO - 'LOGNAME': 'cltbld', 01:45:05 INFO - 'MAIL': '/var/mail/cltbld', 01:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:05 INFO - 'MOZ_NO_REMOTE': '1', 01:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:05 INFO - 'NO_EM_RESTART': '1', 01:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:05 INFO - 'PWD': '/builds/slave/test', 01:45:05 INFO - 'SHELL': '/bin/bash', 01:45:05 INFO - 'SHLVL': '1', 01:45:05 INFO - 'TERM': 'linux', 01:45:05 INFO - 'TMOUT': '86400', 01:45:05 INFO - 'USER': 'cltbld', 01:45:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:05 INFO - '_': '/tools/buildbot/bin/python'} 01:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:05 INFO - Running setup.py (path:/tmp/pip-r3CTPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:05 INFO - Running setup.py (path:/tmp/pip-CSskgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:05 INFO - Running setup.py (path:/tmp/pip-RaHHL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:05 INFO - Running setup.py (path:/tmp/pip-443ge_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:05 INFO - Running setup.py (path:/tmp/pip-VuzKSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:05 INFO - Running setup.py (path:/tmp/pip-9gxgIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:05 INFO - Running setup.py (path:/tmp/pip-GcS9tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:06 INFO - Running setup.py (path:/tmp/pip-w_P8Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:06 INFO - Running setup.py (path:/tmp/pip-tWYE2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:06 INFO - Running setup.py (path:/tmp/pip-28D7Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:06 INFO - Running setup.py (path:/tmp/pip-L260W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:06 INFO - Running setup.py (path:/tmp/pip-YFF7Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:06 INFO - Running setup.py (path:/tmp/pip-uB0TxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:06 INFO - Running setup.py (path:/tmp/pip-KHhJzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:06 INFO - Running setup.py (path:/tmp/pip-JbAAWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:06 INFO - Running setup.py (path:/tmp/pip-4c3AML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:06 INFO - Running setup.py (path:/tmp/pip-esWm8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:45:06 INFO - Running setup.py install for manifestparser 01:45:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:45:06 INFO - Running setup.py install for mozcrash 01:45:06 INFO - Running setup.py install for mozdebug 01:45:07 INFO - Running setup.py install for mozdevice 01:45:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Running setup.py install for mozfile 01:45:07 INFO - Running setup.py install for mozhttpd 01:45:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Running setup.py install for mozinfo 01:45:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Running setup.py install for mozInstall 01:45:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Running setup.py install for mozleak 01:45:07 INFO - Running setup.py install for mozlog 01:45:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Running setup.py install for moznetwork 01:45:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:45:07 INFO - Running setup.py install for mozprocess 01:45:08 INFO - Running setup.py install for mozprofile 01:45:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:45:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:45:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:45:08 INFO - Running setup.py install for mozrunner 01:45:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:45:08 INFO - Running setup.py install for mozscreenshot 01:45:08 INFO - Running setup.py install for moztest 01:45:08 INFO - Running setup.py install for mozversion 01:45:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:45:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:45:08 INFO - Cleaning up... 01:45:08 INFO - Return code: 0 01:45:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:08 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:45:08 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 01:45:08 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 01:45:08 INFO - Using env: {'DISPLAY': ':0', 01:45:08 INFO - 'HOME': '/home/cltbld', 01:45:08 INFO - 'LANG': 'en_US.UTF-8', 01:45:08 INFO - 'LANGUAGE': 'en_US:en', 01:45:08 INFO - 'LOGNAME': 'cltbld', 01:45:08 INFO - 'MAIL': '/var/mail/cltbld', 01:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:08 INFO - 'MOZ_NO_REMOTE': '1', 01:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:08 INFO - 'NO_EM_RESTART': '1', 01:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:08 INFO - 'PWD': '/builds/slave/test', 01:45:08 INFO - 'SHELL': '/bin/bash', 01:45:08 INFO - 'SHLVL': '1', 01:45:08 INFO - 'TERM': 'linux', 01:45:08 INFO - 'TMOUT': '86400', 01:45:08 INFO - 'USER': 'cltbld', 01:45:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:08 INFO - '_': '/tools/buildbot/bin/python'} 01:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:45:08 INFO - Running setup.py (path:/tmp/pip-nbq6XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:45:08 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)) 01:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:45:08 INFO - Running setup.py (path:/tmp/pip-97SciX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:45:08 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)) 01:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:45:08 INFO - Running setup.py (path:/tmp/pip-F71a2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:45:09 INFO - Running setup.py (path:/tmp/pip-tRUWWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:45:09 INFO - Running setup.py (path:/tmp/pip-DXVlnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:45:09 INFO - Running setup.py (path:/tmp/pip-J2Xh1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:45:09 INFO - Running setup.py (path:/tmp/pip-wqiacS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:45:09 INFO - Running setup.py (path:/tmp/pip-iKc5Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:45:09 INFO - Running setup.py (path:/tmp/pip-TepK37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:45:09 INFO - Running setup.py (path:/tmp/pip-yRQoHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:45:09 INFO - Running setup.py (path:/tmp/pip-AbDCDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:45:09 INFO - Running setup.py (path:/tmp/pip-n313Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:45:09 INFO - Running setup.py (path:/tmp/pip-5viQcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:45:09 INFO - Running setup.py (path:/tmp/pip-qRA78W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:09 INFO - Running setup.py (path:/tmp/pip-cdej2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:45:09 INFO - Running setup.py (path:/tmp/pip-8YJ2Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:45:09 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)) 01:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:45:09 INFO - Running setup.py (path:/tmp/pip-jeWnfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:45:10 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)) 01:45:10 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)) 01:45:10 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)) 01:45:10 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)) 01:45:10 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)) 01:45:10 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)) 01:45:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:45:10 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 01:45:10 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 01:45:10 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 01:45:10 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 01:45:10 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 01:45:10 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 01:45:11 INFO - Downloading blessings-1.6.tar.gz 01:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:45:12 INFO - Installing collected packages: blessings 01:45:12 INFO - Running setup.py install for blessings 01:45:12 INFO - Successfully installed blessings 01:45:12 INFO - Cleaning up... 01:45:12 INFO - Return code: 0 01:45:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:12 INFO - Reading from file tmpfile_stdout 01:45:12 INFO - Current package versions: 01:45:12 INFO - argparse == 1.2.1 01:45:12 INFO - blessings == 1.6 01:45:12 INFO - blobuploader == 1.2.4 01:45:12 INFO - docopt == 0.6.1 01:45:12 INFO - functools32 == 3.2.3-2 01:45:12 INFO - jsonschema == 2.5.1 01:45:12 INFO - manifestparser == 1.1 01:45:12 INFO - mozInstall == 1.12 01:45:12 INFO - mozcrash == 0.17 01:45:12 INFO - mozdebug == 0.1 01:45:12 INFO - mozdevice == 0.48 01:45:12 INFO - mozfile == 1.2 01:45:12 INFO - mozhttpd == 0.7 01:45:12 INFO - mozinfo == 0.9 01:45:12 INFO - mozleak == 0.1 01:45:12 INFO - mozlog == 3.2 01:45:12 INFO - moznetwork == 0.27 01:45:12 INFO - mozprocess == 0.22 01:45:12 INFO - mozprofile == 0.28 01:45:12 INFO - mozrunner == 6.11 01:45:12 INFO - mozscreenshot == 0.1 01:45:12 INFO - mozsystemmonitor == 0.3 01:45:12 INFO - moztest == 0.7 01:45:12 INFO - mozversion == 1.4 01:45:12 INFO - psutil == 3.1.1 01:45:12 INFO - requests == 1.2.3 01:45:12 INFO - wsgiref == 0.1.2 01:45:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:45:12 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 01:45:12 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 01:45:12 INFO - Using env: {'DISPLAY': ':0', 01:45:12 INFO - 'HOME': '/home/cltbld', 01:45:12 INFO - 'LANG': 'en_US.UTF-8', 01:45:12 INFO - 'LANGUAGE': 'en_US:en', 01:45:12 INFO - 'LOGNAME': 'cltbld', 01:45:12 INFO - 'MAIL': '/var/mail/cltbld', 01:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:12 INFO - 'MOZ_NO_REMOTE': '1', 01:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:12 INFO - 'NO_EM_RESTART': '1', 01:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:12 INFO - 'PWD': '/builds/slave/test', 01:45:12 INFO - 'SHELL': '/bin/bash', 01:45:12 INFO - 'SHLVL': '1', 01:45:12 INFO - 'TERM': 'linux', 01:45:12 INFO - 'TMOUT': '86400', 01:45:12 INFO - 'USER': 'cltbld', 01:45:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:12 INFO - '_': '/tools/buildbot/bin/python'} 01:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 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)) 01:45:12 INFO - Cleaning up... 01:45:12 INFO - Return code: 0 01:45:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:45:12 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 01:45:12 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 01:45:12 INFO - Using env: {'DISPLAY': ':0', 01:45:12 INFO - 'HOME': '/home/cltbld', 01:45:12 INFO - 'LANG': 'en_US.UTF-8', 01:45:12 INFO - 'LANGUAGE': 'en_US:en', 01:45:12 INFO - 'LOGNAME': 'cltbld', 01:45:12 INFO - 'MAIL': '/var/mail/cltbld', 01:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:12 INFO - 'MOZ_NO_REMOTE': '1', 01:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:12 INFO - 'NO_EM_RESTART': '1', 01:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:12 INFO - 'PWD': '/builds/slave/test', 01:45:12 INFO - 'SHELL': '/bin/bash', 01:45:12 INFO - 'SHLVL': '1', 01:45:12 INFO - 'TERM': 'linux', 01:45:12 INFO - 'TMOUT': '86400', 01:45:12 INFO - 'USER': 'cltbld', 01:45:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:12 INFO - '_': '/tools/buildbot/bin/python'} 01:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:45:12 INFO - Cleaning up... 01:45:12 INFO - Return code: 0 01:45:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:45:12 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 0x7f527b058f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, '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': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', '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 01:45:12 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 01:45:12 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 01:45:12 INFO - Using env: {'DISPLAY': ':0', 01:45:12 INFO - 'HOME': '/home/cltbld', 01:45:12 INFO - 'LANG': 'en_US.UTF-8', 01:45:12 INFO - 'LANGUAGE': 'en_US:en', 01:45:12 INFO - 'LOGNAME': 'cltbld', 01:45:12 INFO - 'MAIL': '/var/mail/cltbld', 01:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:12 INFO - 'MOZ_NO_REMOTE': '1', 01:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:12 INFO - 'NO_EM_RESTART': '1', 01:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:12 INFO - 'PWD': '/builds/slave/test', 01:45:12 INFO - 'SHELL': '/bin/bash', 01:45:12 INFO - 'SHLVL': '1', 01:45:12 INFO - 'TERM': 'linux', 01:45:12 INFO - 'TMOUT': '86400', 01:45:12 INFO - 'USER': 'cltbld', 01:45:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:12 INFO - '_': '/tools/buildbot/bin/python'} 01:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:45:13 INFO - Downloading/unpacking flake8 01:45:13 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 01:45:13 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 01:45:13 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 01:45:13 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 01:45:13 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 01:45:13 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 01:45:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:45:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:45:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:45:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 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 01:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:15 INFO - no previously-included directories found matching 'docs/_build' 01:45:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:45:15 INFO - Running setup.py install for pep8 01:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:45:15 INFO - no previously-included directories found matching 'docs/_build' 01:45:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:45:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:45:15 INFO - Cleaning up... 01:45:15 INFO - Return code: 0 01:45:15 INFO - Running post-action listener: _resource_record_post_action 01:45:15 INFO - Running post-action listener: _start_resource_monitoring 01:45:15 INFO - Starting resource monitoring. 01:45:15 INFO - ##### 01:45:15 INFO - ##### Finished create-virtualenv step (success) 01:45:15 INFO - ##### 01:45:15 INFO - ##### 01:45:15 INFO - ##### Running install step. 01:45:15 INFO - ##### 01:45:15 INFO - Running pre-action listener: _resource_record_pre_action 01:45:15 INFO - Running main action method: install 01:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:45:16 INFO - Reading from file tmpfile_stdout 01:45:16 INFO - Detecting whether we're running mozinstall >=1.0... 01:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:45:16 INFO - Reading from file tmpfile_stdout 01:45:16 INFO - Output received: 01:45:16 INFO - Usage: mozinstall [options] installer 01:45:16 INFO - Options: 01:45:16 INFO - -h, --help show this help message and exit 01:45:16 INFO - -d DEST, --destination=DEST 01:45:16 INFO - Directory to install application into. [default: 01:45:16 INFO - "/builds/slave/test"] 01:45:16 INFO - --app=APP Application being installed. [default: firefox] 01:45:16 INFO - mkdir: /builds/slave/test/build/application 01:45:16 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'] 01:45:16 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 01:45:32 INFO - Reading from file tmpfile_stdout 01:45:32 INFO - Output received: 01:45:32 INFO - /builds/slave/test/build/application/firefox/firefox 01:45:32 INFO - Running post-action listener: _resource_record_post_action 01:45:32 INFO - ##### 01:45:32 INFO - ##### Finished install step (success) 01:45:32 INFO - ##### 01:45:32 INFO - ##### 01:45:32 INFO - ##### Running run-tests step. 01:45:32 INFO - ##### 01:45:32 INFO - Running pre-action listener: _resource_record_pre_action 01:45:32 INFO - Running main action method: run_tests 01:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:45:32 INFO - Python 2.7.3 01:45:32 INFO - Return code: 0 01:45:32 INFO - grabbing minidump binary from tooltool 01:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:32 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 0x2c9e1c0>, '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 0x2c9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:45:32 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 01:45:32 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 01:45:32 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 01:45:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:45:32 INFO - Return code: 0 01:45:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:45:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:45:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:45:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:45:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:45:33 INFO - Return code: 0 01:45:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:45:33 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:45:33 INFO - Using env: {'DISPLAY': ':0', 01:45:33 INFO - 'HOME': '/home/cltbld', 01:45:33 INFO - 'LANG': 'en_US.UTF-8', 01:45:33 INFO - 'LANGUAGE': 'en_US:en', 01:45:33 INFO - 'LOGNAME': 'cltbld', 01:45:33 INFO - 'MAIL': '/var/mail/cltbld', 01:45:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:45:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:45:33 INFO - 'MOZ_NO_REMOTE': '1', 01:45:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:45:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:45:33 INFO - 'NO_EM_RESTART': '1', 01:45:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:45:33 INFO - 'PWD': '/builds/slave/test', 01:45:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:45:33 INFO - 'SHELL': '/bin/bash', 01:45:33 INFO - 'SHLVL': '1', 01:45:33 INFO - 'TERM': 'linux', 01:45:33 INFO - 'TMOUT': '86400', 01:45:33 INFO - 'USER': 'cltbld', 01:45:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855', 01:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:45:33 INFO - '_': '/tools/buildbot/bin/python'} 01:45:33 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:45:33 INFO - mozversion application_buildid: 20160624011358 01:45:33 INFO - mozversion application_changeset: 9d3e753faf2b337ddbe63ee92b5202c39b3c995e 01:45:33 INFO - mozversion application_display_name: Nightly 01:45:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:45:33 INFO - mozversion application_name: Firefox 01:45:33 INFO - mozversion application_remotingname: firefox 01:45:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:45:33 INFO - mozversion application_vendor: Mozilla 01:45:33 INFO - mozversion application_version: 50.0a1 01:45:33 INFO - mozversion platform_buildid: 20160624011358 01:45:33 INFO - mozversion platform_changeset: 9d3e753faf2b337ddbe63ee92b5202c39b3c995e 01:45:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:45:33 INFO - mozversion platform_version: 50.0a1 01:45:33 INFO - using testdate: 1466757933 01:45:33 INFO - actual date: 1466757933 01:45:33 INFO - starting webserver on 'localhost:34586' 01:45:33 INFO - SUITE-START | Running 2 tests 01:45:33 INFO - TEST-START | dromaeo_css 01:45:33 INFO - operating with platform_type : linux_ 01:45:33 INFO - Initialising browser for dromaeo_css test... 01:45:33 INFO - TEST-INFO | started process 12602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZY69y/profile http://localhost:34586/getInfo.html) 01:45:39 INFO - PROCESS | 12602 | __metrics Screen width/height:1600/1200 01:45:39 INFO - PROCESS | 12602 | colorDepth:24 01:45:39 INFO - PROCESS | 12602 | Browser inner width/height: 1024/697 01:45:39 INFO - PROCESS | 12602 | __metrics 01:45:39 ERROR - PROCESS | 12602 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:45:40 INFO - TEST-INFO | 12602: exit 0 01:45:40 INFO - Browser initialized. 01:45:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:45:40 INFO - TEST-INFO | started process 12720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZY69y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:52 INFO - PROCESS | 12720 | RSS: Main: 186269696 01:45:52 INFO - PROCESS | 12720 | 01:46:42 INFO - PROCESS | 12720 | 1466758002491 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] 01:48:54 INFO - PROCESS | 12720 | Cycle 1(1): loaded http://localhost:34586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34586/tests/dromaeo/cssquery-ext.html) 01:48:55 INFO - PROCESS | 12720 | RSS: Main: 189403136 01:48:55 INFO - PROCESS | 12720 | 01:51:58 INFO - PROCESS | 12720 | Cycle 1(1): loaded http://localhost:34586/tests/dromaeo/cssquery-ext.html (next: http://localhost:34586/tests/dromaeo/cssquery-jquery.html) 01:51:58 INFO - PROCESS | 12720 | RSS: Main: 188616704 01:51:58 INFO - PROCESS | 12720 | 01:55:00 INFO - PROCESS | 12720 | Cycle 1(1): loaded http://localhost:34586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34586/tests/dromaeo/cssquery-mootools.html) 01:55:01 INFO - PROCESS | 12720 | RSS: Main: 189771776 01:55:01 INFO - PROCESS | 12720 | 01:58:03 INFO - PROCESS | 12720 | Cycle 1(1): loaded http://localhost:34586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34586/tests/dromaeo/cssquery-prototype.html) 01:58:03 INFO - PROCESS | 12720 | RSS: Main: 187551744 01:58:03 INFO - PROCESS | 12720 | 02:01:06 INFO - PROCESS | 12720 | Cycle 1(1): loaded http://localhost:34586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34586/tests/dromaeo/cssquery-yui.html) 02:01:07 INFO - PROCESS | 12720 | RSS: Main: 189444096 02:01:07 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | Cycle 1(1): loaded http://localhost:34586/tests/dromaeo/cssquery-yui.html (next: http://localhost:34586/tests/dromaeo/cssquery-dojo.html) 02:04:09 INFO - PROCESS | 12720 | RSS: Main: 190672896 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | __start_tp_report 02:04:09 INFO - PROCESS | 12720 | _x_x_mozilla_page_load 02:04:09 INFO - PROCESS | 12720 | _x_x_mozilla_page_load_details 02:04:09 INFO - PROCESS | 12720 | |i|pagename|runs| 02:04:09 INFO - PROCESS | 12720 | |0;dojo.html;2633.8288011279265;2670.9465810683773;2683.2889284339653;2693.935895321348;2701.500222458845;4782.856514304572;4823.541763532463;4898.338724272222;4922.310876477296;4923.950760492394;4766.713997160173;4850.854474365766;4876.049170411771;4881.8047278108925;4886.096072226641;4389.297712366014;4407.405000324947;4471.6199123074575;4482.484514280851;4525.208088584501;4171.666266698657;4466.151431228072;4482.372467854487;4556.84051058213;4566.383538222347;4319.0713996490595;4362.520122786523;4384.539623339535;4392.978035109836;4483.910321793563;4348.847790327355;4363.978180109079;4430.667699922518;4441.933935855403;4464.397306363632;4395.912081758379;4403.273459879116;4411.250087485135;4413.889652758707;4459.464864216315;4777.761111944389;4802.951970480285;4843.128236917353;4853.272009198648;4866.391701037371;5205.869853253661;5214.791408343662;5221.477852214786;5222.686638801684;5277.788888444457;5123.487651234884;5194.948050519522;5264.368275806928;5271.472852714736;5294.391145018334;4879.243717223836;4881;4886.413630364379;4907.116718990616;4943.184374578154;5313.362396512366;5339.279197308391;5367.275417818544;5378.892422151614;5379.4351593082165;5012.7994880205115;5081.364829396325;5086.059079070384;5109.540141387293;5158.587313014949;5041.0422019816115;5181.404138524118;5197.376314842243;5217.191335343028;5250.97374513125;5106.336176297132;5173.586113110942;5175.171972484384;5189.896202076013;5205.427402985669;4931.654784165074;5107.642465027412;5156.819511317086;5160.612954028463;5246.658967167122;4426.557344265548;4460.375547423363;4465.0400163964905;4508.481524624644;4519.819207231674;3838.9040273993373;3852.691784657277;3867.5939026401825;3869.2261547690014;3901.96098039016;4341.044970106572;4454.37638730578;4473.731576105379;4475.30632751924;4489.34904438861;5243.370795504564;5291.470852914677;5293.602979776532;5294.232336311214;5329.440408757102;4490.595846373842;4506.324051392252;4507.4365704286965;4549.954500454953;4550.13547425988;4631.305304204397;4684.81260749573;4710.764461776897;4721.881952951135;4747.406574178228;4852.417709874838;4869.488703686062;4871.80512779492;4889.633277504201;4903.901921961469;5217.869553261199;5224.947750522446;5225.216217567243;5226.45122262157;5274.1034024215205;4787.952120478751;4838.975805120952;4896.290037944549;4905.092557876804;4927.28554359623;5170.1986192140275;5200.479952004769;5209.348831396075;5213.843584692465;5269;5069.847904562869;5272.920906186334;5276.841694749163;5292.497212764782;5293.126634105483;4934.506549345037;5016.974915125401;5031.22016087507;5061.291419201241;5064.265681476091;5080.847574572768;5081.618878584195;5083.644144909821;5092.719900405513;5142.717150556755;5025.74871256443;5036.320096787033;5054.241863720471;5077.213031980049;5078.187490001582;5031.094403007347;5056.039352523009;5070.036693028313;5079.111155547838;5091.439941606494;4969.130402179677;4978.726170060681;4981.402231732215;4985.052839960396;5025.095482813129 02:04:09 INFO - PROCESS | 12720 | |1;ext.html;538.7577651390932;575.5050656435466;591.1162811596661;595.3540408656607;604.0576700347456;35143.64856351439;39091.41362879552;39093.60906390939;39127.804360978225;39403.40894886579;39330.21339573207;39759;39841.60158398415;39900.80049599755;40121.39817902734;7756.457048006656;7887.369010479148;7890.0531936167745;7895.289423951843;7896.131425543214;7695.807604809868;7720.227977202263;7725.150233474342;7732.574708391036;7766.728164514243;7749.690012399497;7800.687972481094;7808.843823123534;7813.765587032398;7821.687132514692;7768.145503994556;7795.532268063935;7796.454248202628;7799.5320280783335;7829.41279404047;7716;7788.805279867992;7789.143194248628;7838.882416763753;7839.137694853562;37448;37843.4323485148;37961.81019094887;37967;38168.236635267414;2944.8674809633617;2995.8801647934056;3058.9541156882665;3125.0937228203793;3383.7293016558615;29638.851805741047;29646.40707185844;29769.660365283613;30002.69997300021;30398.54402183969;3249.545063691085;3311.403947289487;3314;3326.800391976489;3339.8831040913697;265992;266599;268760;269275.999999998;271298;55630.443695563335;55760;55871.72064139653;55909.44090559124;56310.43689563134;32511.512327315108;33216.83391583027;33323.16692082669;34190.82904585461;58733.41266587365;15040.774388384183;15239.695206095816;15256.084634921941;15271.38914443432;15301.15843628611;11504.654860354203;11613.825792613117;11615.477303521362;11616.361100139404;11634.53461861516;18068.18693158811;18107.275708971494;18129.18418671163;18142.274309027754;18275.177617007266;6657.33178527116;6878.793636190922;7008.859822803515;7027.61348125858;7031.683574239171;819.38136706786;904.1184844776421;929.5352323837946;967.1537404770826;984.7587341101475;27692;28166.71833281682;28563.57154642682;28614.284642884093;28719;907.1699395053453;973.2992245583168;1003.9849402258972;1017.2167431078176;1043.6138628707427;14385.705286524053;15127.924360378127;15190.164540950354;15385.384584616713;15508.302126404338;425240;426682;427854;429595;429783;50791.23813142806;50805.23792143121;50990;51004.489955099976;51127.48872511302;1144.4220668562323;1156.7744289863565;1185.472464753194;1193.498730533178;1204.5543149034913;26948.32629184286;28132;28425.147245582666;28570.71441783277;30676.539851901794;47747.52252477431;48230.75884620554;48288.758556206994;48725;48737.2689409652;379436;382748;383455;383723;386920;38632.80683596564;39317.41023884701;40630.79684601558;40631.59368406396;40702.59297406988;43387.78306108449;43708;43773;44482.777586111864;44885.775571121936;36601.63398365982;37106;37552.81223593865;37948;38298.617013829506;36224.551017958984;36701;36717.63282367142;37281.81359093187;37392.43911341278;36070.27859442849;36366.27267454689;36428.81785591055;37504;37796.055098621655;31701.20746981344;33907.321853563284;34178;34306.31387372289;34342.48486272758;25459.872700636377;25705.742942571083;26078.34804129912;26181.34546636273;26348.20955371342 02:04:09 INFO - PROCESS | 12720 | |2;jquery.html;371.8103767078791;376.50113599480676;378.445577229359;384.0839597559819;390.37539936102223;15845.920770396146;16330.755038674415;17223.741643875353;17291.22189501472;17319.30722771091;15798.210089495537;15887.920560397211;16826;16856.747148792747;17457.388991385305;4656.045510670313;4810.68730532516;4851.296561998508;4856.174450343432;4857.1742803723455;3440.690337869604;5271.499207575274;5558.305211848519;5583.944160558383;5670.546356291507;5608.327000759915;5622.943770562283;5634.690092044956;5636.351819540744;5659.236003139586;5653.349864765563;5674.347450043257;5680.857978550528;5686.886262274752;5690.800821971253;5208.218767184915;5287.709175995319;5432.402435732066;5442.6462279952075;5553;19977.102175293323;20120.29578964744;20191.495212619655;20489.692654610193;20533;1782.064416181502;1848.9722654160198;1873.7657792775904;2006.7090271910638;2358;8842.955785221033;8889.599968001456;8958.955205223998;9053.50205738684;9114.86327705085;1659.1869983708016;1735.7830271216098;1758.7010208264626;1765.5144835170302;1786.9910650446795;65286.3471365285;67305.61555075583;67910;68157.31842681559;69700;8615.353848461391;8685.39202255836;9850.605975761033;9880.604775808888;9901.108900199017;13774;13799.931000344934;13833.308334583231;13838.861611383758;13886.722265554834;7125.180604230476;7184.748533801292;7231.674574644154;7341.412686985029;7390.889136662954;6848.383645471931;6854.280300568468;6856.142982127234;7021.754238601625;7072.575645461289;4268.2743933530755;4302.591253830881;4361.345798130305;4363.716358436692;4415.624671902924;1709.3846215362707;1714.6227829877407;1848.6487567362158;1856.7679040119986;1937.86434949555;791.525084949026;833.9583020848934;835.9498430094213;864.2826454043129;922.9030951750104;16037.278322475517;16150.192490375433;16163.191840407933;16596.25316860744;16725.330986760637;827.1521690267524;830.9875351869727;869.7999460124207;897.3449381951082;918.9310801689767;7286.562806231537;9322.30082743797;9355.485448300273;9403.153716165441;9438.669646562475;402532;403177;404727;405235;416503;72567.27432725711;73353.6332318335;74492;76971;77714.6114269425;903.5075883643431;932.0539652252969;955.4553904274636;957.8323793336277;961.0677642686722;15582.14298213609;15659;15767.763483547527;16190.514284571482;16226.188690565661;25910.481790364465;27632.86183569069;35474;36953.44569831401;38412.80793596014;50129.74935125301;51424.74287628538;51495.74252128715;52172.217416739535;52497;7536.660850261642;7810.960945195237;7879.369650428067;8003.19968003195;8055.355571554144;10702.678919632424;11937.283762973902;11940.402979850798;12144.878551214375;12218.633440996784;9572.617095316109;9595.253316285805;9597.9040209597;9768.658096966572;10234.232432567438;10490.977759126992;10572.524236409226;10772.245942784244;10926.289791163548;11055.668329950115;10033.1973442123;10520.421376824042;10556.472176391304;10619;10706.197035222234;7491.4006879448425;7639.312461878458;7773.106092799174;7843.607819608883;7854.018247719036;9394.577244023898;9943.25425593069;10330.431826249327;10361.533730981973;10501.89498105009 02:04:09 INFO - PROCESS | 12720 | |3;mootools.html;1333.0868355176708;1373.2104040176898;1421.9928900355496;1670.3169511227743;1673.6318010037803;6792.728290868372;7283.963580182105;7451.6274186290675;7935.2461516155945;7956.761297161087;7523.247675232474;7661.272179142987;7710.845783084335;7747.1090824555195;7830.960845195766;2099.1708275231313;2172.0877231562704;2175.5322605639785;2177.314146043999;2185.267935241696;2131.0836340373635;2152.870827750332;2161.5352699169675;2171.35944896256;2176.9782302177014;2133.3173384516963;2161.7622061573215;2170.522485053286;2170.7612162662094;2171.587398394308;2115.249086574267;2116.714243577113;2130.1798807459086;2130.7656157822626;2134.9325337331334;2134.8185404240658;2144.9892750536146;2149.0651566568595;2169.3817262080233;2171.3051823416513;7722.961385193094;7731.729389471341;7779.7666070017995;7783.143854176036;7829.804254893616;4490.640748740093;4601.148787474294;4619.46876109245;4622.6070783983405;4637.443506779175;2796.9582204990265;2849.6295481587263;2945.2784067903285;2952.4390365830423;2968.3321252718183;901.0808974845686;928.7863791327965;954.9188318992824;958.5925981457922;960.500539719349;10414.947925260401;10722.249442539025;10793.622223222228;10809.783804323948;10822.080123189538;4184.351425529047;4252.914941701149;4273.63674087706;4359.302511598129;4359.495973889003;9269.860952085724;9294.302927280482;9332.58003389849;9343.766405839908;9348.626054957726;4846;4848.80604775805;4851.757412129379;4852.733099679552;4860.027994401134;3585.713142948558;4108.116754897711;4117.56765539614;4165.083681590046;4308.353746937984;3694.538182727159;3717.9070523236596;3804.866829661004;3847.4228865670375;3952.3873799561115;1203.374245392391;1206.372686203187;1206.4872429217548;1208.112037652325;1220.6460126563197;623.3797371615271;706.1984647425106;805.2108933245453;819.1521774962885;820.8768684697224;5105.106606343875;5157.613179011589;5196.792128314901;5227.477252274818;5411.431799660979;868.405142477405;877.9648814047495;882.5366682491743;933.3419938943028;933.6872147830553;3278.606567211902;3438.346714124308;3446.121239084068;3508.0528257370365;3534.2754735279204;9351.39215950961;9526.476043817518;9572.090651388107;9618.326717129874;9673.274504412197;9457.952710236543;9461.621535138655;9478.668246611336;9490.90509094914;9504.049595040578;7253.093363329478;7254.274572542704;7420.369268612229;7432.182459929403;7440.516366436164;5080.390353157644;5125.846224613268;5165.225216217447;5189.377274726906;5228.607854410859;8755.781105472159;8902.198802107841;8933.955330223307;8955;8995.100489950952;9038.276937845088;9039.096090390909;9069.410488318239;9087.182153606207;9281.211097056826;5739.167820666064;6213.285472170758;6365.14070600463;6410.8076757697345;6555.049517819984;7461;7477.364424023801;7523.548587084792;7529.360004399688;7558.622068896423;6423.389777971272;6489.3510648934725;6607.108040414482;6780.762673306411;6827.112475378169;6672.799816005528;6734.56225345351;6800.115984921928;6838.8290292741085;6901.930980690129;5829.213056237523;5874.765009399576;5930.229070220844;5938.257717785277;5945.286565612154;4466.486354069324;4588.197065513455;4633.328167415773;4680.531946805292;4683.555062269079;4400.207962566768;4457.8216871324785;4470.128324976598;4522.5929666330185;4566.840160594364 02:04:09 INFO - PROCESS | 12720 | |4;prototype.html;279.1917399129519;298.47170508200486;298.95665128556345;302.9969700302997;308.96910308969103;4906.9263961040615;4982.302477653122;5085;5164.509371609695;5195.844124676256;5033.471485494026;5037.1688671369275;5056.8482945511605;5059.038782631306;5066.214736715806;3933.075727204112;3942.80285985701;3948.881533553998;3949.407588861665;3975.443437918679;3866.516685414323;3977.2642061218767;3979.5423526294558;3993.241284156016;4011.0373510357595;3864.8260828262796;3904.707146963975;3911.550171730245;3914.451976723261;3925.939996201024;3911.159100793343;3930.410438434229;3955.426463162854;3960.326744453464;3960.7623542587535;3516.9648303517147;3559.110222444389;3564.946525802115;3565.750397472152;3576.3920133577094;4925.7783399747095;4951.207806750903;4955.776990035457;4982.725950072744;5066.670666406671;4529.388532548097;4534.455865296152;4540.6842510319975;4557.863264102082;4561.543845615445;5285.2600635911;5300.330395925271;5325;5327.254184414185;5327.946720532823;3470.056768209811;3688.963110368889;3699.7595156315024;3846.5961074087377;3857.633524815138;5518.641288316247;5552.805651802168;5574.665520068809;5596.062067414599;5600.859978500529;3764.8117594120185;3768.2086761779783;3784.6593806556994;3797.3924172132324;3797.3924172132324;3589.6410358964417;3843.9429156981496;3845.750026248285;3856.614338566177;3859.96140038596;4365.978170109192;4368.956310436918;4385.802638881258;4401.889952751143;4413.271810151353;5219;5245.1345527988215;5280.551153151949;5297.867553311198;5299.125644268653;1208.8851559101872;1271.3071376100047;1299.4477347127433;1305.1190446448609;1305.7649623067748;837.409626213518;845.3913182508584;855.9486430814171;861.2636196052285;865.8138500222483;4023.657989070903;4090.529589097292;4109.671226301948;4113.930378101655;4115.92985823688;4793.400824896888;4834.806607735652;4849.539293767087;4852.805887764521;4879.975600121977;4113.362428823537;4117.75293482392;4186.727862688916;4197.601227883346;4198.6011328923705;2662.6021338797286;2746.6017427472902;2964.1848491664964;2970.0941212930265;2979.6275465566805;5157.948420515821;5173.301604283449;5187.429382767892;5190.792368305301;5203.245529398216;5327.600429967768;5657.6039677223025;5663.904355388532;5694.1458781183155;5704.3154821421695;5095.643304968691;5098.388193416814;5107.668001579886;5120.18077107661;5130.87172820675;5477;5484.451554844483;5497.285352904097;5535.8892822144135;5568.443155684399;5212.827113899342;5395.379531353788;5453.345598528202;5455.972720136374;5458.208559758892;5167.431582525844;5189.974050129726;5202.3497062867145;5225.529702326809;5229.816956406659;3877.4765406670867;3892.182641645173;3902.941455878221;3915.5105611798526;3927.8625248116177;5239;5333.306670132858;5490.396056433869;5550.944490555043;5597.264847897165;5183.896322073613;5324.840254792362;5334.11987022137;5348.1442969124755;5359.27649767292;5318.622674601733;5329.307190065267;5334.359876814807;5364.758585863724;5395.190721391823;5129.256257842667;5169.508896654812;5252.65857719247;5292.655977361459;5311.150215965427;5417.160340147283;5423.396769550559;5441.7551210196425;5443.972780136074;5452;5169.81905633301;5207.843764687065;5213.556847667991;5234.371875374827;5283.89432211346 02:04:09 INFO - PROCESS | 12720 | |5;yui.html;619.7428067352049;659.4757168051399;703.0227983103487;729.4784229276067;738.5974643819117;11984.221025633338;12510.061745369088;12624.242545447269;12626.494940202403;15162.924185379057;14739.705205895876;14823.25883705813;14947.775783363259;14952.775708364383;15004.099754014767;650.2976785072134;651.9478441724674;653.7352372289231;654.1398061549048;660.2901880478481;620.3579295429232;762.5081822224662;776.2354081229984;784.1139512351035;785.199096921143;818.8812622169781;822.144969231998;823.3660081737058;823.3783493462428;828.70580943765;816.6447595296006;819.2012787532138;819.9057108432518;822;822.9670813167496;594.4441946779775;602.9186059881904;605.1316361021948;607;608.9725962331705;11090.112790976702;11280.435978201058;11291.153163512687;11314.208005439623;11366.261193022427;12674.746505069847;13114.348366275153;13235.933820330933;13260.734785304336;13302;10684.465776711133;10792.136629069733;10792.406417647026;10963.287386319944;11014.339139651647;3254.6745325467264;3277.147941535218;3304.653011433789;3342.6824451677053;3362.109041104085;60673.08990365148;60828.69585652088;62291.688541557;62456.375436245966;62574.68712656407;9708.466034368037;10128.291019628703;10249.641262555775;10381.2214083944;10479.21405894561;17278.308867645406;17309.134543272787;17310.221040052977;17423.21595528204;18006.639867202583;6702.396784289437;6742.224644165885;6907.965460172667;6952.5480843745;6985.196702379189;3566.7146628269675;3671.7796932184156;3674.246779410268;3705.09225239818;3797.5442946846;2962.4815657260324;3058.1284333964713;3152.3537674776617;3294.7858389204625;3298.5711857458377;557.289455943667;558.7429782300106;558.7597333146705;561.1834780394516;568.6247076929207;487.99024019519413;579.2730123694736;602.3584882100549;613.3896772711181;639.8720255948829;7795.517577392909;7861.449698521049;7988.880166797503;8090.393220508486;8272.958635206785;559.4559017112798;593.9792107276224;605.2857627998916;608;610.3621715307514;3905.5508616509464;3999;4049.979750101231;4097.733647312915;4118.299889018874;56799.43200567942;59440.70279648574;102293;105970;106674.46662766636;53225.46774532205;53986;64394.35605643884;84174.15825841785;88757.55621221852;56296;78912;80828.59585702034;83052;84261.15738842655;7481.850362992601;7657.731979380695;7832.138464768757;7848.568328741974;7927.207279272026;46423.303650445945;46635.76682116703;46725;47065.52934470611;47462.525374747194;52763;53254;55942.720286398304;58030.709846450496;59234;10940.507677154388;10966.725831854268;11065.557377704801;11117.44412779374;11277.548898043986;12235.571754988532;12557;12759.170653907466;12888.097833151589;12960.222386656831;10374.375749971503;10992.835107473555;11814.94092529532;11874.76250475003;12346.444410001392;11375.715607109889;11551.249168804;11688.655011597013;12062.75874482523;12728.363581820686;11340.829887551858;11836.289822610672;11906.76186476283;12052.75894482123;12152.331621760535;9234.26125909939;9366.812663746823;9378.064362761153;9457.574409151466;9903.603855845686;9857.260705446977;10211.23415743837;10214.387136771817;10527.052495288397;10529.315594486334 02:04:09 INFO - PROCESS | 12720 | __end_tp_report 02:04:09 INFO - PROCESS | 12720 | __start_cc_report 02:04:09 INFO - PROCESS | 12720 | _x_x_mozilla_cycle_collect,381 02:04:09 INFO - PROCESS | 12720 | __end_cc_report 02:04:09 INFO - PROCESS | 12720 | __startTimestamp1466759049956__endTimestamp 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | ------- Summary: start ------- 02:04:09 INFO - PROCESS | 12720 | Number of tests: 6 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | [#0] dojo.html Cycles:165 Average:4805.44 Median:4923.95 stddev:516.96 (10.5%) stddev-sans-first:489.67 02:04:09 INFO - PROCESS | 12720 | Values: 2633.8 2670.9 2683.3 2693.9 2701.5 4782.9 4823.5 4898.3 4922.3 4924.0 4766.7 4850.9 4876.0 4881.8 4886.1 4389.3 4407.4 4471.6 4482.5 4525.2 4171.7 4466.2 4482.4 4556.8 4566.4 4319.1 4362.5 4384.5 4393.0 4483.9 4348.8 4364.0 4430.7 4441.9 4464.4 4395.9 4403.3 4411.3 4413.9 4459.5 4777.8 4803.0 4843.1 4853.3 4866.4 5205.9 5214.8 5221.5 5222.7 5277.8 5123.5 5194.9 5264.4 5271.5 5294.4 4879.2 4881.0 4886.4 4907.1 4943.2 5313.4 5339.3 5367.3 5378.9 5379.4 5012.8 5081.4 5086.1 5109.5 5158.6 5041.0 5181.4 5197.4 5217.2 5251.0 5106.3 5173.6 5175.2 5189.9 5205.4 4931.7 5107.6 5156.8 5160.6 5246.7 4426.6 4460.4 4465.0 4508.5 4519.8 3838.9 3852.7 3867.6 3869.2 3902.0 4341.0 4454.4 4473.7 4475.3 4489.3 5243.4 5291.5 5293.6 5294.2 5329.4 4490.6 4506.3 4507.4 4550.0 4550.1 4631.3 4684.8 4710.8 4721.9 4747.4 4852.4 4869.5 4871.8 4889.6 4903.9 5217.9 5224.9 5225.2 5226.5 5274.1 4788.0 4839.0 4896.3 4905.1 4927.3 5170.2 5200.5 5209.3 5213.8 5269.0 5069.8 5272.9 5276.8 5292.5 5293.1 4934.5 5017.0 5031.2 5061.3 5064.3 5080.8 5081.6 5083.6 5092.7 5142.7 5025.7 5036.3 5054.2 5077.2 5078.2 5031.1 5056.0 5070.0 5079.1 5091.4 4969.1 4978.7 4981.4 4985.1 5025.1 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | [#1] ext.html Cycles:180 Average:51300.63 Median:37964.41 stddev:96682.30 (254.7%) stddev-sans-first:96878.40 02:04:09 INFO - PROCESS | 12720 | Values: 538.8 575.5 591.1 595.4 604.1 35143.6 39091.4 39093.6 39127.8 39403.4 39330.2 39759.0 39841.6 39900.8 40121.4 7756.5 7887.4 7890.1 7895.3 7896.1 7695.8 7720.2 7725.2 7732.6 7766.7 7749.7 7800.7 7808.8 7813.8 7821.7 7768.1 7795.5 7796.5 7799.5 7829.4 7716.0 7788.8 7789.1 7838.9 7839.1 37448.0 37843.4 37961.8 37967.0 38168.2 2944.9 2995.9 3059.0 3125.1 3383.7 29638.9 29646.4 29769.7 30002.7 30398.5 3249.5 3311.4 3314.0 3326.8 3339.9 265992.0 266599.0 268760.0 269276.0 271298.0 55630.4 55760.0 55871.7 55909.4 56310.4 32511.5 33216.8 33323.2 34190.8 58733.4 15040.8 15239.7 15256.1 15271.4 15301.2 11504.7 11613.8 11615.5 11616.4 11634.5 18068.2 18107.3 18129.2 18142.3 18275.2 6657.3 6878.8 7008.9 7027.6 7031.7 819.4 904.1 929.5 967.2 984.8 27692.0 28166.7 28563.6 28614.3 28719.0 907.2 973.3 1004.0 1017.2 1043.6 14385.7 15127.9 15190.2 15385.4 15508.3 425240.0 426682.0 427854.0 429595.0 429783.0 50791.2 50805.2 50990.0 51004.5 51127.5 1144.4 1156.8 1185.5 1193.5 1204.6 26948.3 28132.0 28425.1 28570.7 30676.5 47747.5 48230.8 48288.8 48725.0 48737.3 379436.0 382748.0 383455.0 383723.0 386920.0 38632.8 39317.4 40630.8 40631.6 40702.6 43387.8 43708.0 43773.0 44482.8 44885.8 36601.6 37106.0 37552.8 37948.0 38298.6 36224.6 36701.0 36717.6 37281.8 37392.4 36070.3 36366.3 36428.8 37504.0 37796.1 31701.2 33907.3 34178.0 34306.3 34342.5 25459.9 25705.7 26078.3 26181.3 26348.2 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | [#2] jquery.html Cycles:180 Average:24520.06 Median:50777.25 stddev:66943.82 (131.8%) stddev-sans-first:67107.06 02:04:09 INFO - PROCESS | 12720 | Values: 371.8 376.5 378.4 384.1 390.4 15845.9 16330.8 17223.7 17291.2 17319.3 15798.2 15887.9 16826.0 16856.7 17457.4 4656.0 4810.7 4851.3 4856.2 4857.2 3440.7 5271.5 5558.3 5583.9 5670.5 5608.3 5622.9 5634.7 5636.4 5659.2 5653.3 5674.3 5680.9 5686.9 5690.8 5208.2 5287.7 5432.4 5442.6 5553.0 19977.1 20120.3 20191.5 20489.7 20533.0 1782.1 1849.0 1873.8 2006.7 2358.0 8843.0 8889.6 8959.0 9053.5 9114.9 1659.2 1735.8 1758.7 1765.5 1787.0 65286.3 67305.6 67910.0 68157.3 69700.0 8615.4 8685.4 9850.6 9880.6 9901.1 13774.0 13799.9 13833.3 13838.9 13886.7 7125.2 7184.7 7231.7 7341.4 7390.9 6848.4 6854.3 6856.1 7021.8 7072.6 4268.3 4302.6 4361.3 4363.7 4415.6 1709.4 1714.6 1848.6 1856.8 1937.9 791.5 834.0 835.9 864.3 922.9 16037.3 16150.2 16163.2 16596.3 16725.3 827.2 831.0 869.8 897.3 918.9 7286.6 9322.3 9355.5 9403.2 9438.7 402532.0 403177.0 404727.0 405235.0 416503.0 72567.3 73353.6 74492.0 76971.0 77714.6 903.5 932.1 955.5 957.8 961.1 15582.1 15659.0 15767.8 16190.5 16226.2 25910.5 27632.9 35474.0 36953.4 38412.8 50129.7 51424.7 51495.7 52172.2 52497.0 7536.7 7811.0 7879.4 8003.2 8055.4 10702.7 11937.3 11940.4 12144.9 12218.6 9572.6 9595.3 9597.9 9768.7 10234.2 10491.0 10572.5 10772.2 10926.3 11055.7 10033.2 10520.4 10556.5 10619.0 10706.2 7491.4 7639.3 7773.1 7843.6 7854.0 9394.6 9943.3 10330.4 10361.5 10501.9 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | [#3] mootools.html Cycles:180 Average:5109.17 Median:5193.08 stddev:2867.14 (55.2%) stddev-sans-first:2861.14 02:04:09 INFO - PROCESS | 12720 | Values: 1333.1 1373.2 1422.0 1670.3 1673.6 6792.7 7284.0 7451.6 7935.2 7956.8 7523.2 7661.3 7710.8 7747.1 7831.0 2099.2 2172.1 2175.5 2177.3 2185.3 2131.1 2152.9 2161.5 2171.4 2177.0 2133.3 2161.8 2170.5 2170.8 2171.6 2115.2 2116.7 2130.2 2130.8 2134.9 2134.8 2145.0 2149.1 2169.4 2171.3 7723.0 7731.7 7779.8 7783.1 7829.8 4490.6 4601.1 4619.5 4622.6 4637.4 2797.0 2849.6 2945.3 2952.4 2968.3 901.1 928.8 954.9 958.6 960.5 10414.9 10722.2 10793.6 10809.8 10822.1 4184.4 4252.9 4273.6 4359.3 4359.5 9269.9 9294.3 9332.6 9343.8 9348.6 4846.0 4848.8 4851.8 4852.7 4860.0 3585.7 4108.1 4117.6 4165.1 4308.4 3694.5 3717.9 3804.9 3847.4 3952.4 1203.4 1206.4 1206.5 1208.1 1220.6 623.4 706.2 805.2 819.2 820.9 5105.1 5157.6 5196.8 5227.5 5411.4 868.4 878.0 882.5 933.3 933.7 3278.6 3438.3 3446.1 3508.1 3534.3 9351.4 9526.5 9572.1 9618.3 9673.3 9458.0 9461.6 9478.7 9490.9 9504.0 7253.1 7254.3 7420.4 7432.2 7440.5 5080.4 5125.8 5165.2 5189.4 5228.6 8755.8 8902.2 8934.0 8955.0 8995.1 9038.3 9039.1 9069.4 9087.2 9281.2 5739.2 6213.3 6365.1 6410.8 6555.0 7461.0 7477.4 7523.5 7529.4 7558.6 6423.4 6489.4 6607.1 6780.8 6827.1 6672.8 6734.6 6800.1 6838.8 6901.9 5829.2 5874.8 5930.2 5938.3 5945.3 4466.5 4588.2 4633.3 4680.5 4683.6 4400.2 4457.8 4470.1 4522.6 4566.8 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | [#4] prototype.html Cycles:180 Average:4363.48 Median:5008.10 stddev:1292.94 (25.8%) stddev-sans-first:1259.70 02:04:09 INFO - PROCESS | 12720 | Values: 279.2 298.5 299.0 303.0 309.0 4906.9 4982.3 5085.0 5164.5 5195.8 5033.5 5037.2 5056.8 5059.0 5066.2 3933.1 3942.8 3948.9 3949.4 3975.4 3866.5 3977.3 3979.5 3993.2 4011.0 3864.8 3904.7 3911.6 3914.5 3925.9 3911.2 3930.4 3955.4 3960.3 3960.8 3517.0 3559.1 3564.9 3565.8 3576.4 4925.8 4951.2 4955.8 4982.7 5066.7 4529.4 4534.5 4540.7 4557.9 4561.5 5285.3 5300.3 5325.0 5327.3 5327.9 3470.1 3689.0 3699.8 3846.6 3857.6 5518.6 5552.8 5574.7 5596.1 5600.9 3764.8 3768.2 3784.7 3797.4 3797.4 3589.6 3843.9 3845.8 3856.6 3860.0 4366.0 4369.0 4385.8 4401.9 4413.3 5219.0 5245.1 5280.6 5297.9 5299.1 1208.9 1271.3 1299.4 1305.1 1305.8 837.4 845.4 855.9 861.3 865.8 4023.7 4090.5 4109.7 4113.9 4115.9 4793.4 4834.8 4849.5 4852.8 4880.0 4113.4 4117.8 4186.7 4197.6 4198.6 2662.6 2746.6 2964.2 2970.1 2979.6 5157.9 5173.3 5187.4 5190.8 5203.2 5327.6 5657.6 5663.9 5694.1 5704.3 5095.6 5098.4 5107.7 5120.2 5130.9 5477.0 5484.5 5497.3 5535.9 5568.4 5212.8 5395.4 5453.3 5456.0 5458.2 5167.4 5190.0 5202.3 5225.5 5229.8 3877.5 3892.2 3902.9 3915.5 3927.9 5239.0 5333.3 5490.4 5550.9 5597.3 5183.9 5324.8 5334.1 5348.1 5359.3 5318.6 5329.3 5334.4 5364.8 5395.2 5129.3 5169.5 5252.7 5292.7 5311.2 5417.2 5423.4 5441.8 5444.0 5452.0 5169.8 5207.8 5213.6 5234.4 5283.9 02:04:09 INFO - PROCESS | 12720 | 02:04:09 INFO - PROCESS | 12720 | [#5] yui.html Cycles:180 Average:16906.27 Median:23975.26 stddev:23699.33 (98.8%) stddev-sans-first:23734.26 02:04:09 INFO - PROCESS | 12720 | Values: 619.7 659.5 703.0 729.5 738.6 11984.2 12510.1 12624.2 12626.5 15162.9 14739.7 14823.3 14947.8 14952.8 15004.1 650.3 651.9 653.7 654.1 660.3 620.4 762.5 776.2 784.1 785.2 818.9 822.1 823.4 823.4 828.7 816.6 819.2 819.9 822.0 823.0 594.4 602.9 605.1 607.0 609.0 11090.1 11280.4 11291.2 11314.2 11366.3 12674.7 13114.3 13235.9 13260.7 13302.0 10684.5 10792.1 10792.4 10963.3 11014.3 3254.7 3277.1 3304.7 3342.7 3362.1 60673.1 60828.7 62291.7 62456.4 62574.7 9708.5 10128.3 10249.6 10381.2 10479.2 17278.3 17309.1 17310.2 17423.2 18006.6 6702.4 6742.2 6908.0 6952.5 6985.2 3566.7 3671.8 3674.2 3705.1 3797.5 2962.5 3058.1 3152.4 3294.8 3298.6 557.3 558.7 558.8 561.2 568.6 488.0 579.3 602.4 613.4 639.9 7795.5 7861.4 7988.9 8090.4 8273.0 559.5 594.0 605.3 608.0 610.4 3905.6 3999.0 4050.0 4097.7 4118.3 56799.4 59440.7 102293.0 105970.0 106674.5 53225.5 53986.0 64394.4 84174.2 88757.6 56296.0 78912.0 80828.6 83052.0 84261.2 7481.9 7657.7 7832.1 7848.6 7927.2 46423.3 46635.8 46725.0 47065.5 47462.5 52763.0 53254.0 55942.7 58030.7 59234.0 10940.5 10966.7 11065.6 11117.4 11277.5 12235.6 12557.0 12759.2 12888.1 12960.2 10374.4 10992.8 11814.9 11874.8 12346.4 11375.7 11551.2 11688.7 12062.8 12728.4 11340.8 11836.3 11906.8 12052.8 12152.3 9234.3 9366.8 9378.1 9457.6 9903.6 9857.3 10211.2 10214.4 10527.1 10529.3 02:04:09 INFO - PROCESS | 12720 | -------- Summary: end -------- 02:04:09 INFO - PROCESS | 12720 | 02:04:10 INFO - TEST-INFO | 12720: exit 0 02:04:10 INFO - TEST-OK | dromaeo_css | took 1117136ms 02:04:10 INFO - TEST-START | kraken 02:04:10 INFO - operating with platform_type : linux_ 02:04:10 INFO - Initialising browser for kraken test... 02:04:10 INFO - TEST-INFO | started process 12960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUeXOhn/profile http://localhost:34586/getInfo.html) 02:04:16 INFO - PROCESS | 12960 | __metrics Screen width/height:1600/1200 02:04:16 INFO - PROCESS | 12960 | colorDepth:24 02:04:16 INFO - PROCESS | 12960 | Browser inner width/height: 1024/697 02:04:16 INFO - PROCESS | 12960 | __metrics 02:04:16 ERROR - PROCESS | 12960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:04:17 INFO - TEST-INFO | 12960: exit 0 02:04:17 INFO - Browser initialized. 02:04:17 INFO - Running cycle 1/1 for kraken test... 02:04:17 INFO - TEST-INFO | started process 13077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUeXOhn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:04:29 INFO - PROCESS | 13077 | RSS: Main: 186572800 02:04:29 INFO - PROCESS | 13077 | 02:04:32 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34586/tests/kraken/driver.html?testName=audio-beat-detection) 02:04:33 INFO - PROCESS | 13077 | RSS: Main: 191033344 02:04:33 INFO - PROCESS | 13077 | 02:04:36 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34586/tests/kraken/driver.html?testName=audio-dft) 02:04:37 INFO - PROCESS | 13077 | RSS: Main: 191000576 02:04:37 INFO - PROCESS | 13077 | 02:04:39 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34586/tests/kraken/driver.html?testName=audio-fft) 02:04:40 INFO - PROCESS | 13077 | RSS: Main: 186634240 02:04:40 INFO - PROCESS | 13077 | 02:04:42 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34586/tests/kraken/driver.html?testName=audio-oscillator) 02:04:43 INFO - PROCESS | 13077 | RSS: Main: 187760640 02:04:43 INFO - PROCESS | 13077 | 02:04:45 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:04:46 INFO - PROCESS | 13077 | RSS: Main: 187748352 02:04:46 INFO - PROCESS | 13077 | 02:04:49 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34586/tests/kraken/driver.html?testName=imaging-darkroom) 02:04:50 INFO - PROCESS | 13077 | RSS: Main: 188039168 02:04:50 INFO - PROCESS | 13077 | 02:04:53 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34586/tests/kraken/driver.html?testName=imaging-desaturate) 02:04:54 INFO - PROCESS | 13077 | RSS: Main: 185016320 02:04:54 INFO - PROCESS | 13077 | 02:04:57 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34586/tests/kraken/driver.html?testName=json-parse-financial) 02:04:57 INFO - PROCESS | 13077 | RSS: Main: 186744832 02:04:57 INFO - PROCESS | 13077 | 02:04:59 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:05:00 INFO - PROCESS | 13077 | RSS: Main: 186863616 02:05:00 INFO - PROCESS | 13077 | 02:05:02 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:05:02 INFO - PROCESS | 13077 | RSS: Main: 187146240 02:05:02 INFO - PROCESS | 13077 | 02:05:05 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:05:05 INFO - PROCESS | 13077 | RSS: Main: 187150336 02:05:05 INFO - PROCESS | 13077 | 02:05:08 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:05:09 INFO - PROCESS | 13077 | RSS: Main: 187318272 02:05:09 INFO - PROCESS | 13077 | 02:05:12 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:05:12 INFO - PROCESS | 13077 | RSS: Main: 187408384 02:05:12 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | Cycle 1(1): loaded http://localhost:34586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34586/tests/kraken/driver.html?testName=ai-astar) 02:05:14 INFO - PROCESS | 13077 | RSS: Main: 188649472 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | __start_tp_report 02:05:14 INFO - PROCESS | 13077 | _x_x_mozilla_page_load 02:05:14 INFO - PROCESS | 13077 | _x_x_mozilla_page_load_details 02:05:14 INFO - PROCESS | 13077 | |i|pagename|runs| 02:05:14 INFO - PROCESS | 13077 | |0;ai-astar;104;113;106;114;113;115;116;113;113;114 02:05:14 INFO - PROCESS | 13077 | |1;audio-beat-detection;158;130;158;185;132;154;157;137;194;138 02:05:14 INFO - PROCESS | 13077 | |2;audio-dft;163;165;171;163;165;165;162;176;163;162 02:05:14 INFO - PROCESS | 13077 | |3;audio-fft;75;76;77;172;75;77;76;78;167;75 02:05:14 INFO - PROCESS | 13077 | |4;audio-oscillator;89;86;137;86;86;87;128;85;86;147 02:05:14 INFO - PROCESS | 13077 | |5;imaging-gaussian-blur;118;118;117;119;118;117;117;123;118;117 02:05:14 INFO - PROCESS | 13077 | |6;imaging-darkroom;148;149;146;147;148;148;149;148;147;147 02:05:14 INFO - PROCESS | 13077 | |7;imaging-desaturate;95;96;96;96;95;95;95;95;97;95 02:05:14 INFO - PROCESS | 13077 | |8;json-parse-financial;67;67;69;69;66;67;67;67;68;73 02:05:14 INFO - PROCESS | 13077 | |9;json-stringify-tinderbox;68;66;66;67;66;67;66;67;66;69 02:05:14 INFO - PROCESS | 13077 | |10;stanford-crypto-aes;84;83;84;82;83;83;88;91;108;89 02:05:14 INFO - PROCESS | 13077 | |11;stanford-crypto-ccm;151;149;142;139;131;139;135;150;143;134 02:05:14 INFO - PROCESS | 13077 | |12;stanford-crypto-pbkdf2;170;174;172;172;170;171;175;168;176;173 02:05:14 INFO - PROCESS | 13077 | |13;stanford-crypto-sha256-iterative;67;69;70;70;73;69;66;69;67;71 02:05:14 INFO - PROCESS | 13077 | __end_tp_report 02:05:14 INFO - PROCESS | 13077 | __start_cc_report 02:05:14 INFO - PROCESS | 13077 | _x_x_mozilla_cycle_collect,1004 02:05:14 INFO - PROCESS | 13077 | __end_cc_report 02:05:14 INFO - PROCESS | 13077 | __startTimestamp1466759114953__endTimestamp 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | ------- Summary: start ------- 02:05:14 INFO - PROCESS | 13077 | Number of tests: 14 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.90 (3.4%) stddev-sans-first:2.83 02:05:14 INFO - PROCESS | 13077 | Values: 104.0 113.0 106.0 114.0 113.0 115.0 116.0 113.0 113.0 114.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:157.50 stddev:21.62 (13.7%) stddev-sans-first:22.89 02:05:14 INFO - PROCESS | 13077 | Values: 158.0 130.0 158.0 185.0 132.0 154.0 157.0 137.0 194.0 138.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:4.53 (2.7%) stddev-sans-first:4.71 02:05:14 INFO - PROCESS | 13077 | Values: 163.0 165.0 171.0 163.0 165.0 165.0 162.0 176.0 163.0 162.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.40 (51.8%) stddev-sans-first:41.13 02:05:14 INFO - PROCESS | 13077 | Values: 75.0 76.0 77.0 172.0 75.0 77.0 76.0 78.0 167.0 75.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:86.00 stddev:25.02 (29.1%) stddev-sans-first:26.11 02:05:14 INFO - PROCESS | 13077 | Values: 89.0 86.0 137.0 86.0 86.0 87.0 128.0 85.0 86.0 147.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.81 (1.5%) stddev-sans-first:1.92 02:05:14 INFO - PROCESS | 13077 | Values: 118.0 118.0 117.0 119.0 118.0 117.0 117.0 123.0 118.0 117.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 02:05:14 INFO - PROCESS | 13077 | Values: 148.0 149.0 146.0 147.0 148.0 148.0 149.0 148.0 147.0 147.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 02:05:14 INFO - PROCESS | 13077 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 97.0 95.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:67.50 stddev:2.00 (3.0%) stddev-sans-first:2.09 02:05:14 INFO - PROCESS | 13077 | Values: 67.0 67.0 69.0 69.0 66.0 67.0 67.0 67.0 68.0 73.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 02:05:14 INFO - PROCESS | 13077 | Values: 68.0 66.0 66.0 67.0 66.0 67.0 66.0 67.0 66.0 69.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.00 stddev:7.82 (9.3%) stddev-sans-first:8.19 02:05:14 INFO - PROCESS | 13077 | Values: 84.0 83.0 84.0 82.0 83.0 83.0 88.0 91.0 108.0 89.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:142.50 stddev:7.01 (4.9%) stddev-sans-first:6.50 02:05:14 INFO - PROCESS | 13077 | Values: 151.0 149.0 142.0 139.0 131.0 139.0 135.0 150.0 143.0 134.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:2.47 (1.4%) stddev-sans-first:2.50 02:05:14 INFO - PROCESS | 13077 | Values: 170.0 174.0 172.0 172.0 170.0 171.0 175.0 168.0 176.0 173.0 02:05:14 INFO - PROCESS | 13077 | 02:05:14 INFO - PROCESS | 13077 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:2.08 (3.0%) stddev-sans-first:2.06 02:05:14 INFO - PROCESS | 13077 | Values: 67.0 69.0 70.0 70.0 73.0 69.0 66.0 69.0 67.0 71.0 02:05:14 INFO - PROCESS | 13077 | -------- Summary: end -------- 02:05:14 INFO - PROCESS | 13077 | 02:05:16 INFO - TEST-INFO | 13077: exit 0 02:05:16 INFO - TEST-OK | kraken | took 65262ms 02:05:16 INFO - SUITE-END | took 1182s 02:05:16 INFO - Completed test suite (00:19:42) 02:05:16 INFO - javascript benchmark 02:05:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6475.0295935216745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2633.8288011279265, 2670.9465810683773, 2683.2889284339653, 2693.935895321348, 2701.500222458845, 4782.856514304572, 4823.541763532463, 4898.338724272222, 4922.310876477296, 4923.950760492394, 4766.713997160173, 4850.854474365766, 4876.049170411771, 4881.8047278108925, 4886.096072226641, 4389.297712366014, 4407.405000324947, 4471.6199123074575, 4482.484514280851, 4525.208088584501, 4171.666266698657, 4466.151431228072, 4482.372467854487, 4556.84051058213, 4566.383538222347, 4319.0713996490595, 4362.520122786523, 4384.539623339535, 4392.978035109836, 4483.910321793563, 4348.847790327355, 4363.978180109079, 4430.667699922518, 4441.933935855403, 4464.397306363632, 4395.912081758379, 4403.273459879116, 4411.250087485135, 4413.889652758707, 4459.464864216315, 4777.761111944389, 4802.951970480285, 4843.128236917353, 4853.272009198648, 4866.391701037371, 5205.869853253661, 5214.791408343662, 5221.477852214786, 5222.686638801684, 5277.788888444457, 5123.487651234884, 5194.948050519522, 5264.368275806928, 5271.472852714736, 5294.391145018334, 4879.243717223836, 4881.0, 4886.413630364379, 4907.116718990616, 4943.184374578154, 5313.362396512366, 5339.279197308391, 5367.275417818544, 5378.892422151614, 5379.4351593082165, 5012.7994880205115, 5081.364829396325, 5086.059079070384, 5109.540141387293, 5158.587313014949, 5041.0422019816115, 5181.404138524118, 5197.376314842243, 5217.191335343028, 5250.97374513125, 5106.336176297132, 5173.586113110942, 5175.171972484384, 5189.896202076013, 5205.427402985669, 4931.654784165074, 5107.642465027412, 5156.819511317086, 5160.612954028463, 5246.658967167122, 4426.557344265548, 4460.375547423363, 4465.0400163964905, 4508.481524624644, 4519.819207231674, 3838.9040273993373, 3852.691784657277, 3867.5939026401825, 3869.2261547690014, 3901.96098039016, 4341.044970106572, 4454.37638730578, 4473.731576105379, 4475.30632751924, 4489.34904438861, 5243.370795504564, 5291.470852914677, 5293.602979776532, 5294.232336311214, 5329.440408757102, 4490.595846373842, 4506.324051392252, 4507.4365704286965, 4549.954500454953, 4550.13547425988, 4631.305304204397, 4684.81260749573, 4710.764461776897, 4721.881952951135, 4747.406574178228, 4852.417709874838, 4869.488703686062, 4871.80512779492, 4889.633277504201, 4903.901921961469, 5217.869553261199, 5224.947750522446, 5225.216217567243, 5226.45122262157, 5274.1034024215205, 4787.952120478751, 4838.975805120952, 4896.290037944549, 4905.092557876804, 4927.28554359623, 5170.1986192140275, 5200.479952004769, 5209.348831396075, 5213.843584692465, 5269.0, 5069.847904562869, 5272.920906186334, 5276.841694749163, 5292.497212764782, 5293.126634105483, 4934.506549345037, 5016.974915125401, 5031.22016087507, 5061.291419201241, 5064.265681476091, 5080.847574572768, 5081.618878584195, 5083.644144909821, 5092.719900405513, 5142.717150556755, 5025.74871256443, 5036.320096787033, 5054.241863720471, 5077.213031980049, 5078.187490001582, 5031.094403007347, 5056.039352523009, 5070.036693028313, 5079.111155547838, 5091.439941606494, 4969.130402179677, 4978.726170060681, 4981.402231732215, 4985.052839960396, 5025.095482813129], "value": 4771.540529025114, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7577651390932, 575.5050656435466, 591.1162811596661, 595.3540408656607, 604.0576700347456, 35143.64856351439, 39091.41362879552, 39093.60906390939, 39127.804360978225, 39403.40894886579, 39330.21339573207, 39759.0, 39841.60158398415, 39900.80049599755, 40121.39817902734, 7756.457048006656, 7887.369010479148, 7890.0531936167745, 7895.289423951843, 7896.131425543214, 7695.807604809868, 7720.227977202263, 7725.150233474342, 7732.574708391036, 7766.728164514243, 7749.690012399497, 7800.687972481094, 7808.843823123534, 7813.765587032398, 7821.687132514692, 7768.145503994556, 7795.532268063935, 7796.454248202628, 7799.5320280783335, 7829.41279404047, 7716.0, 7788.805279867992, 7789.143194248628, 7838.882416763753, 7839.137694853562, 37448.0, 37843.4323485148, 37961.81019094887, 37967.0, 38168.236635267414, 2944.8674809633617, 2995.8801647934056, 3058.9541156882665, 3125.0937228203793, 3383.7293016558615, 29638.851805741047, 29646.40707185844, 29769.660365283613, 30002.69997300021, 30398.54402183969, 3249.545063691085, 3311.403947289487, 3314.0, 3326.800391976489, 3339.8831040913697, 265992.0, 266599.0, 268760.0, 269275.999999998, 271298.0, 55630.443695563335, 55760.0, 55871.72064139653, 55909.44090559124, 56310.43689563134, 32511.512327315108, 33216.83391583027, 33323.16692082669, 34190.82904585461, 58733.41266587365, 15040.774388384183, 15239.695206095816, 15256.084634921941, 15271.38914443432, 15301.15843628611, 11504.654860354203, 11613.825792613117, 11615.477303521362, 11616.361100139404, 11634.53461861516, 18068.18693158811, 18107.275708971494, 18129.18418671163, 18142.274309027754, 18275.177617007266, 6657.33178527116, 6878.793636190922, 7008.859822803515, 7027.61348125858, 7031.683574239171, 819.38136706786, 904.1184844776421, 929.5352323837946, 967.1537404770826, 984.7587341101475, 27692.0, 28166.71833281682, 28563.57154642682, 28614.284642884093, 28719.0, 907.1699395053453, 973.2992245583168, 1003.9849402258972, 1017.2167431078176, 1043.6138628707427, 14385.705286524053, 15127.924360378127, 15190.164540950354, 15385.384584616713, 15508.302126404338, 425240.0, 426682.0, 427854.0, 429595.0, 429783.0, 50791.23813142806, 50805.23792143121, 50990.0, 51004.489955099976, 51127.48872511302, 1144.4220668562323, 1156.7744289863565, 1185.472464753194, 1193.498730533178, 1204.5543149034913, 26948.32629184286, 28132.0, 28425.147245582666, 28570.71441783277, 30676.539851901794, 47747.52252477431, 48230.75884620554, 48288.758556206994, 48725.0, 48737.2689409652, 379436.0, 382748.0, 383455.0, 383723.0, 386920.0, 38632.80683596564, 39317.41023884701, 40630.79684601558, 40631.59368406396, 40702.59297406988, 43387.78306108449, 43708.0, 43773.0, 44482.777586111864, 44885.775571121936, 36601.63398365982, 37106.0, 37552.81223593865, 37948.0, 38298.617013829506, 36224.551017958984, 36701.0, 36717.63282367142, 37281.81359093187, 37392.43911341278, 36070.27859442849, 36366.27267454689, 36428.81785591055, 37504.0, 37796.055098621655, 31701.20746981344, 33907.321853563284, 34178.0, 34306.31387372289, 34342.48486272758, 25459.872700636377, 25705.742942571083, 26078.34804129912, 26181.34546636273, 26348.20955371342], "value": 18011.03297152089, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.8103767078791, 376.50113599480676, 378.445577229359, 384.0839597559819, 390.37539936102223, 15845.920770396146, 16330.755038674415, 17223.741643875353, 17291.22189501472, 17319.30722771091, 15798.210089495537, 15887.920560397211, 16826.0, 16856.747148792747, 17457.388991385305, 4656.045510670313, 4810.68730532516, 4851.296561998508, 4856.174450343432, 4857.1742803723455, 3440.690337869604, 5271.499207575274, 5558.305211848519, 5583.944160558383, 5670.546356291507, 5608.327000759915, 5622.943770562283, 5634.690092044956, 5636.351819540744, 5659.236003139586, 5653.349864765563, 5674.347450043257, 5680.857978550528, 5686.886262274752, 5690.800821971253, 5208.218767184915, 5287.709175995319, 5432.402435732066, 5442.6462279952075, 5553.0, 19977.102175293323, 20120.29578964744, 20191.495212619655, 20489.692654610193, 20533.0, 1782.064416181502, 1848.9722654160198, 1873.7657792775904, 2006.7090271910638, 2358.0, 8842.955785221033, 8889.599968001456, 8958.955205223998, 9053.50205738684, 9114.86327705085, 1659.1869983708016, 1735.7830271216098, 1758.7010208264626, 1765.5144835170302, 1786.9910650446795, 65286.3471365285, 67305.61555075583, 67910.0, 68157.31842681559, 69700.0, 8615.353848461391, 8685.39202255836, 9850.605975761033, 9880.604775808888, 9901.108900199017, 13774.0, 13799.931000344934, 13833.308334583231, 13838.861611383758, 13886.722265554834, 7125.180604230476, 7184.748533801292, 7231.674574644154, 7341.412686985029, 7390.889136662954, 6848.383645471931, 6854.280300568468, 6856.142982127234, 7021.754238601625, 7072.575645461289, 4268.2743933530755, 4302.591253830881, 4361.345798130305, 4363.716358436692, 4415.624671902924, 1709.3846215362707, 1714.6227829877407, 1848.6487567362158, 1856.7679040119986, 1937.86434949555, 791.525084949026, 833.9583020848934, 835.9498430094213, 864.2826454043129, 922.9030951750104, 16037.278322475517, 16150.192490375433, 16163.191840407933, 16596.25316860744, 16725.330986760637, 827.1521690267524, 830.9875351869727, 869.7999460124207, 897.3449381951082, 918.9310801689767, 7286.562806231537, 9322.30082743797, 9355.485448300273, 9403.153716165441, 9438.669646562475, 402532.0, 403177.0, 404727.0, 405235.0, 416503.0, 72567.27432725711, 73353.6332318335, 74492.0, 76971.0, 77714.6114269425, 903.5075883643431, 932.0539652252969, 955.4553904274636, 957.8323793336277, 961.0677642686722, 15582.14298213609, 15659.0, 15767.763483547527, 16190.514284571482, 16226.188690565661, 25910.481790364465, 27632.86183569069, 35474.0, 36953.44569831401, 38412.80793596014, 50129.74935125301, 51424.74287628538, 51495.74252128715, 52172.217416739535, 52497.0, 7536.660850261642, 7810.960945195237, 7879.369650428067, 8003.19968003195, 8055.355571554144, 10702.678919632424, 11937.283762973902, 11940.402979850798, 12144.878551214375, 12218.633440996784, 9572.617095316109, 9595.253316285805, 9597.9040209597, 9768.658096966572, 10234.232432567438, 10490.977759126992, 10572.524236409226, 10772.245942784244, 10926.289791163548, 11055.668329950115, 10033.1973442123, 10520.421376824042, 10556.472176391304, 10619.0, 10706.197035222234, 7491.4006879448425, 7639.312461878458, 7773.106092799174, 7843.607819608883, 7854.018247719036, 9394.577244023898, 9943.25425593069, 10330.431826249327, 10361.533730981973, 10501.89498105009], "value": 8155.815524848719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.0868355176708, 1373.2104040176898, 1421.9928900355496, 1670.3169511227743, 1673.6318010037803, 6792.728290868372, 7283.963580182105, 7451.6274186290675, 7935.2461516155945, 7956.761297161087, 7523.247675232474, 7661.272179142987, 7710.845783084335, 7747.1090824555195, 7830.960845195766, 2099.1708275231313, 2172.0877231562704, 2175.5322605639785, 2177.314146043999, 2185.267935241696, 2131.0836340373635, 2152.870827750332, 2161.5352699169675, 2171.35944896256, 2176.9782302177014, 2133.3173384516963, 2161.7622061573215, 2170.522485053286, 2170.7612162662094, 2171.587398394308, 2115.249086574267, 2116.714243577113, 2130.1798807459086, 2130.7656157822626, 2134.9325337331334, 2134.8185404240658, 2144.9892750536146, 2149.0651566568595, 2169.3817262080233, 2171.3051823416513, 7722.961385193094, 7731.729389471341, 7779.7666070017995, 7783.143854176036, 7829.804254893616, 4490.640748740093, 4601.148787474294, 4619.46876109245, 4622.6070783983405, 4637.443506779175, 2796.9582204990265, 2849.6295481587263, 2945.2784067903285, 2952.4390365830423, 2968.3321252718183, 901.0808974845686, 928.7863791327965, 954.9188318992824, 958.5925981457922, 960.500539719349, 10414.947925260401, 10722.249442539025, 10793.622223222228, 10809.783804323948, 10822.080123189538, 4184.351425529047, 4252.914941701149, 4273.63674087706, 4359.302511598129, 4359.495973889003, 9269.860952085724, 9294.302927280482, 9332.58003389849, 9343.766405839908, 9348.626054957726, 4846.0, 4848.80604775805, 4851.757412129379, 4852.733099679552, 4860.027994401134, 3585.713142948558, 4108.116754897711, 4117.56765539614, 4165.083681590046, 4308.353746937984, 3694.538182727159, 3717.9070523236596, 3804.866829661004, 3847.4228865670375, 3952.3873799561115, 1203.374245392391, 1206.372686203187, 1206.4872429217548, 1208.112037652325, 1220.6460126563197, 623.3797371615271, 706.1984647425106, 805.2108933245453, 819.1521774962885, 820.8768684697224, 5105.106606343875, 5157.613179011589, 5196.792128314901, 5227.477252274818, 5411.431799660979, 868.405142477405, 877.9648814047495, 882.5366682491743, 933.3419938943028, 933.6872147830553, 3278.606567211902, 3438.346714124308, 3446.121239084068, 3508.0528257370365, 3534.2754735279204, 9351.39215950961, 9526.476043817518, 9572.090651388107, 9618.326717129874, 9673.274504412197, 9457.952710236543, 9461.621535138655, 9478.668246611336, 9490.90509094914, 9504.049595040578, 7253.093363329478, 7254.274572542704, 7420.369268612229, 7432.182459929403, 7440.516366436164, 5080.390353157644, 5125.846224613268, 5165.225216217447, 5189.377274726906, 5228.607854410859, 8755.781105472159, 8902.198802107841, 8933.955330223307, 8955.0, 8995.100489950952, 9038.276937845088, 9039.096090390909, 9069.410488318239, 9087.182153606207, 9281.211097056826, 5739.167820666064, 6213.285472170758, 6365.14070600463, 6410.8076757697345, 6555.049517819984, 7461.0, 7477.364424023801, 7523.548587084792, 7529.360004399688, 7558.622068896423, 6423.389777971272, 6489.3510648934725, 6607.108040414482, 6780.762673306411, 6827.112475378169, 6672.799816005528, 6734.56225345351, 6800.115984921928, 6838.8290292741085, 6901.930980690129, 5829.213056237523, 5874.765009399576, 5930.229070220844, 5938.257717785277, 5945.286565612154, 4466.486354069324, 4588.197065513455, 4633.328167415773, 4680.531946805292, 4683.555062269079, 4400.207962566768, 4457.8216871324785, 4470.128324976598, 4522.5929666330185, 4566.840160594364], "value": 4115.750103512255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.1917399129519, 298.47170508200486, 298.95665128556345, 302.9969700302997, 308.96910308969103, 4906.9263961040615, 4982.302477653122, 5085.0, 5164.509371609695, 5195.844124676256, 5033.471485494026, 5037.1688671369275, 5056.8482945511605, 5059.038782631306, 5066.214736715806, 3933.075727204112, 3942.80285985701, 3948.881533553998, 3949.407588861665, 3975.443437918679, 3866.516685414323, 3977.2642061218767, 3979.5423526294558, 3993.241284156016, 4011.0373510357595, 3864.8260828262796, 3904.707146963975, 3911.550171730245, 3914.451976723261, 3925.939996201024, 3911.159100793343, 3930.410438434229, 3955.426463162854, 3960.326744453464, 3960.7623542587535, 3516.9648303517147, 3559.110222444389, 3564.946525802115, 3565.750397472152, 3576.3920133577094, 4925.7783399747095, 4951.207806750903, 4955.776990035457, 4982.725950072744, 5066.670666406671, 4529.388532548097, 4534.455865296152, 4540.6842510319975, 4557.863264102082, 4561.543845615445, 5285.2600635911, 5300.330395925271, 5325.0, 5327.254184414185, 5327.946720532823, 3470.056768209811, 3688.963110368889, 3699.7595156315024, 3846.5961074087377, 3857.633524815138, 5518.641288316247, 5552.805651802168, 5574.665520068809, 5596.062067414599, 5600.859978500529, 3764.8117594120185, 3768.2086761779783, 3784.6593806556994, 3797.3924172132324, 3797.3924172132324, 3589.6410358964417, 3843.9429156981496, 3845.750026248285, 3856.614338566177, 3859.96140038596, 4365.978170109192, 4368.956310436918, 4385.802638881258, 4401.889952751143, 4413.271810151353, 5219.0, 5245.1345527988215, 5280.551153151949, 5297.867553311198, 5299.125644268653, 1208.8851559101872, 1271.3071376100047, 1299.4477347127433, 1305.1190446448609, 1305.7649623067748, 837.409626213518, 845.3913182508584, 855.9486430814171, 861.2636196052285, 865.8138500222483, 4023.657989070903, 4090.529589097292, 4109.671226301948, 4113.930378101655, 4115.92985823688, 4793.400824896888, 4834.806607735652, 4849.539293767087, 4852.805887764521, 4879.975600121977, 4113.362428823537, 4117.75293482392, 4186.727862688916, 4197.601227883346, 4198.6011328923705, 2662.6021338797286, 2746.6017427472902, 2964.1848491664964, 2970.0941212930265, 2979.6275465566805, 5157.948420515821, 5173.301604283449, 5187.429382767892, 5190.792368305301, 5203.245529398216, 5327.600429967768, 5657.6039677223025, 5663.904355388532, 5694.1458781183155, 5704.3154821421695, 5095.643304968691, 5098.388193416814, 5107.668001579886, 5120.18077107661, 5130.87172820675, 5477.0, 5484.451554844483, 5497.285352904097, 5535.8892822144135, 5568.443155684399, 5212.827113899342, 5395.379531353788, 5453.345598528202, 5455.972720136374, 5458.208559758892, 5167.431582525844, 5189.974050129726, 5202.3497062867145, 5225.529702326809, 5229.816956406659, 3877.4765406670867, 3892.182641645173, 3902.941455878221, 3915.5105611798526, 3927.8625248116177, 5239.0, 5333.306670132858, 5490.396056433869, 5550.944490555043, 5597.264847897165, 5183.896322073613, 5324.840254792362, 5334.11987022137, 5348.1442969124755, 5359.27649767292, 5318.622674601733, 5329.307190065267, 5334.359876814807, 5364.758585863724, 5395.190721391823, 5129.256257842667, 5169.508896654812, 5252.65857719247, 5292.655977361459, 5311.150215965427, 5417.160340147283, 5423.396769550559, 5441.7551210196425, 5443.972780136074, 5452.0, 5169.81905633301, 5207.843764687065, 5213.556847667991, 5234.371875374827, 5283.89432211346], "value": 3945.0540565650545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.7428067352049, 659.4757168051399, 703.0227983103487, 729.4784229276067, 738.5974643819117, 11984.221025633338, 12510.061745369088, 12624.242545447269, 12626.494940202403, 15162.924185379057, 14739.705205895876, 14823.25883705813, 14947.775783363259, 14952.775708364383, 15004.099754014767, 650.2976785072134, 651.9478441724674, 653.7352372289231, 654.1398061549048, 660.2901880478481, 620.3579295429232, 762.5081822224662, 776.2354081229984, 784.1139512351035, 785.199096921143, 818.8812622169781, 822.144969231998, 823.3660081737058, 823.3783493462428, 828.70580943765, 816.6447595296006, 819.2012787532138, 819.9057108432518, 822.0, 822.9670813167496, 594.4441946779775, 602.9186059881904, 605.1316361021948, 607.0, 608.9725962331705, 11090.112790976702, 11280.435978201058, 11291.153163512687, 11314.208005439623, 11366.261193022427, 12674.746505069847, 13114.348366275153, 13235.933820330933, 13260.734785304336, 13302.0, 10684.465776711133, 10792.136629069733, 10792.406417647026, 10963.287386319944, 11014.339139651647, 3254.6745325467264, 3277.147941535218, 3304.653011433789, 3342.6824451677053, 3362.109041104085, 60673.08990365148, 60828.69585652088, 62291.688541557, 62456.375436245966, 62574.68712656407, 9708.466034368037, 10128.291019628703, 10249.641262555775, 10381.2214083944, 10479.21405894561, 17278.308867645406, 17309.134543272787, 17310.221040052977, 17423.21595528204, 18006.639867202583, 6702.396784289437, 6742.224644165885, 6907.965460172667, 6952.5480843745, 6985.196702379189, 3566.7146628269675, 3671.7796932184156, 3674.246779410268, 3705.09225239818, 3797.5442946846, 2962.4815657260324, 3058.1284333964713, 3152.3537674776617, 3294.7858389204625, 3298.5711857458377, 557.289455943667, 558.7429782300106, 558.7597333146705, 561.1834780394516, 568.6247076929207, 487.99024019519413, 579.2730123694736, 602.3584882100549, 613.3896772711181, 639.8720255948829, 7795.517577392909, 7861.449698521049, 7988.880166797503, 8090.393220508486, 8272.958635206785, 559.4559017112798, 593.9792107276224, 605.2857627998916, 608.0, 610.3621715307514, 3905.5508616509464, 3999.0, 4049.979750101231, 4097.733647312915, 4118.299889018874, 56799.43200567942, 59440.70279648574, 102293.0, 105970.0, 106674.46662766636, 53225.46774532205, 53986.0, 64394.35605643884, 84174.15825841785, 88757.55621221852, 56296.0, 78912.0, 80828.59585702034, 83052.0, 84261.15738842655, 7481.850362992601, 7657.731979380695, 7832.138464768757, 7848.568328741974, 7927.207279272026, 46423.303650445945, 46635.76682116703, 46725.0, 47065.52934470611, 47462.525374747194, 52763.0, 53254.0, 55942.720286398304, 58030.709846450496, 59234.0, 10940.507677154388, 10966.725831854268, 11065.557377704801, 11117.44412779374, 11277.548898043986, 12235.571754988532, 12557.0, 12759.170653907466, 12888.097833151589, 12960.222386656831, 10374.375749971503, 10992.835107473555, 11814.94092529532, 11874.76250475003, 12346.444410001392, 11375.715607109889, 11551.249168804, 11688.655011597013, 12062.75874482523, 12728.363581820686, 11340.829887551858, 11836.289822610672, 11906.76186476283, 12052.75894482123, 12152.331621760535, 9234.26125909939, 9366.812663746823, 9378.064362761153, 9457.574409151466, 9903.603855845686, 9857.260705446977, 10211.23415743837, 10214.387136771817, 10527.052495288397, 10529.315594486334], "value": 6474.933998583203, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 106.0, 114.0, 113.0, 115.0, 116.0, 113.0, 113.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 158.0, 185.0, 132.0, 154.0, 157.0, 137.0, 194.0, 138.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 171.0, 163.0, 165.0, 165.0, 162.0, 176.0, 163.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 172.0, 75.0, 77.0, 76.0, 78.0, 167.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 137.0, 86.0, 86.0, 87.0, 128.0, 85.0, 86.0, 147.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 119.0, 118.0, 117.0, 117.0, 123.0, 118.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 146.0, 147.0, 148.0, 148.0, 149.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 69.0, 66.0, 67.0, 67.0, 67.0, 68.0, 73.0], "value": 68.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 69.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 82.0, 83.0, 83.0, 88.0, 91.0, 108.0, 89.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 142.0, 139.0, 131.0, 139.0, 135.0, 150.0, 143.0, 134.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 172.0, 172.0, 170.0, 171.0, 175.0, 168.0, 176.0, 173.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 70.0, 70.0, 73.0, 69.0, 66.0, 69.0, 67.0, 71.0], "value": 69.1, "unit": "score"}]}]} 02:05:16 INFO - Return code: 0 02:05:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:05:16 ERROR - # TBPL SUCCESS # 02:05:16 INFO - Running post-action listener: _resource_record_post_action 02:05:16 INFO - ##### 02:05:16 INFO - ##### Finished run-tests step (success) 02:05:16 INFO - ##### 02:05:16 INFO - Running post-run listener: _resource_record_post_run 02:05:16 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543793152; Read time: 20; Write time: 610484 02:05:16 INFO - TinderboxPrint: CPU usage
13.5% 02:05:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 02:05:16 INFO - TinderboxPrint: I/O write bytes / time
543,793,152 / 610,484 02:05:16 INFO - TinderboxPrint: CPU idle
8,282.4 (86.5%) 02:05:16 INFO - TinderboxPrint: CPU user
1,233.1 (12.9%) 02:05:16 INFO - TinderboxPrint: Swap in / out
0 / 0 02:05:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245907456; Read time: 0; Write time: 362972 02:05:16 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297299968; Read time: 20; Write time: 247492 02:05:16 INFO - Running post-run listener: _upload_blobber_files 02:05:16 INFO - Blob upload gear active. 02:05:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:05:16 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 02:05:16 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'] 02:05:16 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 02:05:17 INFO - (blobuploader) - INFO - Open directory for files ... 02:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:05:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:17 INFO - (blobuploader) - INFO - Done attempting. 02:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:18 INFO - (blobuploader) - INFO - Done attempting. 02:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:05:22 INFO - (blobuploader) - INFO - Done attempting. 02:05:22 INFO - (blobuploader) - INFO - Iteration through files over. 02:05:22 INFO - Return code: 0 02:05:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:05:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:05:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dc0ef6d63b474e64f7800c3d6312c024a7355901c81370bcb44ca1ae7d70b8cfb0286f6b62978d73b1b952fa98cf9ba02c71bc2b7d80f6e76ad102aa822a831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62138d840a4fca866cb944886c271abd74ff22b3d782fccdc7c280416ca2eb5da63c1916e95e6ab2f2962eb82d0cbd8b48688dcf135015655a26f241f08d59c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/262ffc94ca4d02c92157223b68b46059d72710ab0c0e688104d10d640b9b1a0ca058025c426c34b195210181c0130a768aa259e63ed000c992a68d2bfb9630df"} 02:05:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:05:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:05:22 INFO - Contents: 02:05:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dc0ef6d63b474e64f7800c3d6312c024a7355901c81370bcb44ca1ae7d70b8cfb0286f6b62978d73b1b952fa98cf9ba02c71bc2b7d80f6e76ad102aa822a831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62138d840a4fca866cb944886c271abd74ff22b3d782fccdc7c280416ca2eb5da63c1916e95e6ab2f2962eb82d0cbd8b48688dcf135015655a26f241f08d59c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/262ffc94ca4d02c92157223b68b46059d72710ab0c0e688104d10d640b9b1a0ca058025c426c34b195210181c0130a768aa259e63ed000c992a68d2bfb9630df"} 02:05:22 INFO - Running post-run listener: copy_logs_to_upload_dir 02:05:22 INFO - Copying logs to upload dir... 02:05:22 INFO - mkdir: /builds/slave/test/build/upload/logs 02:05:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.827641 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-24 02:05:21.474569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 02:05:21.478556) ========= 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=fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dc0ef6d63b474e64f7800c3d6312c024a7355901c81370bcb44ca1ae7d70b8cfb0286f6b62978d73b1b952fa98cf9ba02c71bc2b7d80f6e76ad102aa822a831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62138d840a4fca866cb944886c271abd74ff22b3d782fccdc7c280416ca2eb5da63c1916e95e6ab2f2962eb82d0cbd8b48688dcf135015655a26f241f08d59c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/262ffc94ca4d02c92157223b68b46059d72710ab0c0e688104d10d640b9b1a0ca058025c426c34b195210181c0130a768aa259e63ed000c992a68d2bfb9630df"} build_url:https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/CaLVjul-QiGt6k0X206EWg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2dc0ef6d63b474e64f7800c3d6312c024a7355901c81370bcb44ca1ae7d70b8cfb0286f6b62978d73b1b952fa98cf9ba02c71bc2b7d80f6e76ad102aa822a831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/62138d840a4fca866cb944886c271abd74ff22b3d782fccdc7c280416ca2eb5da63c1916e95e6ab2f2962eb82d0cbd8b48688dcf135015655a26f241f08d59c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/262ffc94ca4d02c92157223b68b46059d72710ab0c0e688104d10d640b9b1a0ca058025c426c34b195210181c0130a768aa259e63ed000c992a68d2bfb9630df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 02:05:21.504316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 02:05:21.504636) ========= 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=fa44defc139c4ba8574fe040000001db-1466757295.849564-1926540855 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 02:05:21.588070) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 02:05:21.588383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 02:05:21.588676) ========= ========= Total master_lag: 0.15 =========