builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1465480765.51 results: success (0) buildid: 20160609055229 builduid: 2f286c868aab437f81d3c85a9e698269 revision: d463c1a271c4bd422a5d2b93f7be7c58ea57dcc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.506283) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.506785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.507115) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.523907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.524209) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 06:59:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.7M=0s 2016-06-09 06:59:25 (33.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193887 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.732011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.732351) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:25.782492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 06:59:25.782919) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d463c1a271c4bd422a5d2b93f7be7c58ea57dcc7 --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 d463c1a271c4bd422a5d2b93f7be7c58ea57dcc7 --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=5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 06:59:26,113 truncating revision to first 12 chars 2016-06-09 06:59:26,113 Setting DEBUG logging. 2016-06-09 06:59:26,113 attempt 1/10 2016-06-09 06:59:26,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d463c1a271c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 06:59:26,737 unpacking tar archive at: fx-team-d463c1a271c4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.015824 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 06:59:26.812590) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:26.812968) ========= script_repo_revision: d463c1a271c4bd422a5d2b93f7be7c58ea57dcc7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:26.813468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:26.813804) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 06:59:26.824745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 06:59:26.825051) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:27 INFO - MultiFileLogger online at 20160609 06:59:27 in /builds/slave/test 06:59:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:59:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:27 INFO - {'append_to_log': False, 06:59:27 INFO - 'base_work_dir': '/builds/slave/test', 06:59:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:59:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:27 INFO - 'branch': 'Fx-Team-Non-PGO', 06:59:27 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:27 INFO - 'config_files': ('talos/linux_config.py',), 06:59:27 INFO - 'default_actions': ('clobber', 06:59:27 INFO - 'read-buildbot-config', 06:59:27 INFO - 'download-and-extract', 06:59:27 INFO - 'populate-webroot', 06:59:27 INFO - 'create-virtualenv', 06:59:27 INFO - 'install', 06:59:27 INFO - 'run-tests'), 06:59:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:27 INFO - 'download_minidump_stackwalk': True, 06:59:27 INFO - 'download_symbols': 'ondemand', 06:59:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:27 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:27 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:27 INFO - 'installer_path': 'installer.exe', 06:59:27 INFO - 'log_level': 'info', 06:59:27 INFO - 'log_name': 'talos', 06:59:27 INFO - 'log_to_console': True, 06:59:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:27 INFO - 'opt_config_files': (), 06:59:27 INFO - 'pip_index': False, 06:59:27 INFO - 'sps_profile': False, 06:59:27 INFO - 'sps_profile_interval': 0, 06:59:27 INFO - 'suite': 'dromaeojs', 06:59:27 INFO - 'system_bits': '32', 06:59:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:27 INFO - 'title': 'talos-linux64-ix-051', 06:59:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:27 INFO - 'use_talos_json': True, 06:59:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:27 INFO - 'work_dir': 'build'} 06:59:27 INFO - ##### 06:59:27 INFO - ##### Running clobber step. 06:59:27 INFO - ##### 06:59:27 INFO - Running pre-action listener: _resource_record_pre_action 06:59:27 INFO - Running main action method: clobber 06:59:27 INFO - rmtree: /builds/slave/test/build 06:59:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:27 INFO - Running post-action listener: _resource_record_post_action 06:59:27 INFO - ##### 06:59:27 INFO - ##### Finished clobber step (success) 06:59:27 INFO - ##### 06:59:27 INFO - ##### 06:59:27 INFO - ##### Running read-buildbot-config step. 06:59:27 INFO - ##### 06:59:27 INFO - Running pre-action listener: _resource_record_pre_action 06:59:27 INFO - Running main action method: read_buildbot_config 06:59:27 INFO - Using buildbot properties: 06:59:27 INFO - { 06:59:27 INFO - "project": "", 06:59:27 INFO - "product": "firefox", 06:59:27 INFO - "script_repo_revision": "production", 06:59:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:59:27 INFO - "repository": "", 06:59:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:59:27 INFO - "buildid": "20160609055229", 06:59:27 INFO - "pgo_build": "False", 06:59:27 INFO - "basedir": "/builds/slave/test", 06:59:27 INFO - "buildnumber": 1834, 06:59:27 INFO - "slavename": "talos-linux64-ix-051", 06:59:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:59:27 INFO - "platform": "ubuntu64_hw", 06:59:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:59:27 INFO - "branch": "fx-team", 06:59:27 INFO - "repo_path": "integration/fx-team", 06:59:27 INFO - "revision": "d463c1a271c4bd422a5d2b93f7be7c58ea57dcc7", 06:59:27 INFO - "stage_platform": "linux64", 06:59:27 INFO - "builduid": "2f286c868aab437f81d3c85a9e698269", 06:59:27 INFO - "slavebuilddir": "test" 06:59:27 INFO - } 06:59:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:59:27 INFO - Running post-action listener: _resource_record_post_action 06:59:27 INFO - ##### 06:59:27 INFO - ##### Finished read-buildbot-config step (success) 06:59:27 INFO - ##### 06:59:27 INFO - ##### 06:59:27 INFO - ##### Running download-and-extract step. 06:59:27 INFO - ##### 06:59:27 INFO - Running pre-action listener: _resource_record_pre_action 06:59:27 INFO - Running main action method: download_and_extract 06:59:27 INFO - mkdir: /builds/slave/test/build/tests 06:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:27 INFO - https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:28 INFO - Downloaded 1361 bytes. 06:59:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:59:28 INFO - Using the following test package requirements: 06:59:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:59:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:59:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'jsshell-linux-x86_64.zip'], 06:59:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:59:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:59:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:59:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:59:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:59:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:59:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:59:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:28 INFO - https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:29 INFO - Downloaded 22879604 bytes. 06:59:29 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'] 06:59:29 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 06:59:30 INFO - Return code: 0 06:59:30 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 06:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:30 INFO - https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:32 INFO - Downloaded 22879604 bytes. 06:59:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:59:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:59:33 INFO - Return code: 0 06:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:33 INFO - https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:35 INFO - Downloaded 10833377 bytes. 06:59:35 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'] 06:59:35 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 06:59:35 INFO - Return code: 0 06:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:35 INFO - https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LtlJjtdOTmi-S6d3qNyRrg/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 06:59:36 INFO - Downloaded 55373251 bytes. 06:59:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:36 INFO - mkdir: /builds/slave/test/properties 06:59:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:59:36 INFO - Writing to file /builds/slave/test/properties/build_url 06:59:36 INFO - Contents: 06:59:36 INFO - build_url:https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:59:37 INFO - Running post-action listener: _resource_record_post_action 06:59:37 INFO - Running post-action listener: set_extra_try_arguments 06:59:37 INFO - ##### 06:59:37 INFO - ##### Finished download-and-extract step (success) 06:59:37 INFO - ##### 06:59:37 INFO - ##### 06:59:37 INFO - ##### Running populate-webroot step. 06:59:37 INFO - ##### 06:59:37 INFO - Running pre-action listener: _resource_record_pre_action 06:59:37 INFO - Running main action method: populate_webroot 06:59:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:37 INFO - '--tppagecycles', 06:59:37 INFO - '7'], 06:59:37 INFO - 'tests': ['tsvgm']}}, 06:59:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:59:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:59:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:59:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['damp', 'tps']}, 06:59:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'tests': ['damp', 'tps']}, 06:59:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['dromaeo_dom']}, 06:59:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['a11yr', 06:59:37 INFO - 'ts_paint', 06:59:37 INFO - 'tpaint', 06:59:37 INFO - 'sessionrestore', 06:59:37 INFO - 'sessionrestore_no_auto_restore', 06:59:37 INFO - 'tabpaint']}, 06:59:37 INFO - 'other-e10s': {'tests': ['a11yr', 06:59:37 INFO - 'ts_paint', 06:59:37 INFO - 'tpaint', 06:59:37 INFO - 'sessionrestore', 06:59:37 INFO - 'sessionrestore_no_auto_restore', 06:59:37 INFO - 'tabpaint']}, 06:59:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:59:37 INFO - 'ts_paint', 06:59:37 INFO - 'tpaint', 06:59:37 INFO - 'sessionrestore', 06:59:37 INFO - 'sessionrestore_no_auto_restore', 06:59:37 INFO - 'tabpaint']}, 06:59:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:59:37 INFO - 'ts_paint', 06:59:37 INFO - 'tpaint', 06:59:37 INFO - 'sessionrestore', 06:59:37 INFO - 'sessionrestore_no_auto_restore', 06:59:37 INFO - 'tabpaint']}, 06:59:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['a11yr', 06:59:37 INFO - 'ts_paint', 06:59:37 INFO - 'tpaint', 06:59:37 INFO - 'sessionrestore', 06:59:37 INFO - 'sessionrestore_no_auto_restore', 06:59:37 INFO - 'tabpaint']}, 06:59:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['a11yr', 06:59:37 INFO - 'ts_paint', 06:59:37 INFO - 'tpaint', 06:59:37 INFO - 'sessionrestore', 06:59:37 INFO - 'sessionrestore_no_auto_restore', 06:59:37 INFO - 'tabpaint']}, 06:59:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['tsvgx', 06:59:37 INFO - 'tsvgr_opacity', 06:59:37 INFO - 'tart', 06:59:37 INFO - 'tscrollx', 06:59:37 INFO - 'cart']}, 06:59:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:59:37 INFO - 'tsvgr_opacity', 06:59:37 INFO - 'tart', 06:59:37 INFO - 'tscrollx', 06:59:37 INFO - 'cart']}, 06:59:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'talos_options': ['--disable-e10s'], 06:59:37 INFO - 'tests': ['tp5o']}, 06:59:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'tests': ['tp5o']}, 06:59:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'talos_options': ['--disable-e10s', 06:59:37 INFO - '--xperf_path', 06:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:37 INFO - 'tests': ['tp5n']}, 06:59:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:37 INFO - 'talos_options': ['--xperf_path', 06:59:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:37 INFO - 'tests': ['tp5n']}}, 06:59:37 INFO - 'talos.zip': {'path': '', 06:59:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:37 INFO - Running post-action listener: _resource_record_post_action 06:59:37 INFO - ##### 06:59:37 INFO - ##### Finished populate-webroot step (success) 06:59:37 INFO - ##### 06:59:37 INFO - ##### 06:59:37 INFO - ##### Running create-virtualenv step. 06:59:37 INFO - ##### 06:59:37 INFO - Running pre-action listener: _resource_record_pre_action 06:59:37 INFO - Running main action method: create_virtualenv 06:59:37 INFO - Creating virtualenv /builds/slave/test/build/venv 06:59:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:59:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:59:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:37 INFO - Using real prefix '/usr' 06:59:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:40 INFO - Installing pip.................done. 06:59:40 INFO - Return code: 0 06:59:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:59:40 INFO - Using env: {'DISPLAY': ':0', 06:59:40 INFO - 'HOME': '/home/cltbld', 06:59:40 INFO - 'LANG': 'en_US.UTF-8', 06:59:40 INFO - 'LANGUAGE': 'en_US:en', 06:59:40 INFO - 'LOGNAME': 'cltbld', 06:59:40 INFO - 'MAIL': '/var/mail/cltbld', 06:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:40 INFO - 'MOZ_NO_REMOTE': '1', 06:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:40 INFO - 'NO_EM_RESTART': '1', 06:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:40 INFO - 'PWD': '/builds/slave/test', 06:59:40 INFO - 'SHELL': '/bin/bash', 06:59:40 INFO - 'SHLVL': '1', 06:59:40 INFO - 'TERM': 'linux', 06:59:40 INFO - 'TMOUT': '86400', 06:59:40 INFO - 'USER': 'cltbld', 06:59:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:40 INFO - '_': '/tools/buildbot/bin/python'} 06:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:59:40 INFO - Cleaning up... 06:59:40 INFO - Return code: 0 06:59:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:59:40 INFO - Using env: {'DISPLAY': ':0', 06:59:40 INFO - 'HOME': '/home/cltbld', 06:59:40 INFO - 'LANG': 'en_US.UTF-8', 06:59:40 INFO - 'LANGUAGE': 'en_US:en', 06:59:40 INFO - 'LOGNAME': 'cltbld', 06:59:40 INFO - 'MAIL': '/var/mail/cltbld', 06:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:40 INFO - 'MOZ_NO_REMOTE': '1', 06:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:40 INFO - 'NO_EM_RESTART': '1', 06:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:40 INFO - 'PWD': '/builds/slave/test', 06:59:40 INFO - 'SHELL': '/bin/bash', 06:59:40 INFO - 'SHLVL': '1', 06:59:40 INFO - 'TERM': 'linux', 06:59:40 INFO - 'TMOUT': '86400', 06:59:40 INFO - 'USER': 'cltbld', 06:59:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:40 INFO - '_': '/tools/buildbot/bin/python'} 06:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:40 INFO - Downloading/unpacking psutil>=3.1.1 06:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:42 INFO - Installing collected packages: psutil 06:59:42 INFO - Running setup.py install for psutil 06:59:42 INFO - building 'psutil._psutil_linux' extension 06:59:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:59:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:59:42 INFO - building 'psutil._psutil_posix' extension 06:59:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:59:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:43 INFO - Successfully installed psutil 06:59:43 INFO - Cleaning up... 06:59:43 INFO - Return code: 0 06:59:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:59:43 INFO - Using env: {'DISPLAY': ':0', 06:59:43 INFO - 'HOME': '/home/cltbld', 06:59:43 INFO - 'LANG': 'en_US.UTF-8', 06:59:43 INFO - 'LANGUAGE': 'en_US:en', 06:59:43 INFO - 'LOGNAME': 'cltbld', 06:59:43 INFO - 'MAIL': '/var/mail/cltbld', 06:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:43 INFO - 'MOZ_NO_REMOTE': '1', 06:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:43 INFO - 'NO_EM_RESTART': '1', 06:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:43 INFO - 'PWD': '/builds/slave/test', 06:59:43 INFO - 'SHELL': '/bin/bash', 06:59:43 INFO - 'SHLVL': '1', 06:59:43 INFO - 'TERM': 'linux', 06:59:43 INFO - 'TMOUT': '86400', 06:59:43 INFO - 'USER': 'cltbld', 06:59:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:43 INFO - '_': '/tools/buildbot/bin/python'} 06:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:59:45 INFO - Installing collected packages: mozsystemmonitor 06:59:45 INFO - Running setup.py install for mozsystemmonitor 06:59:45 INFO - Successfully installed mozsystemmonitor 06:59:45 INFO - Cleaning up... 06:59:45 INFO - Return code: 0 06:59:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:59: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')]} 06:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59: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')]} 06:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:59:45 INFO - Using env: {'DISPLAY': ':0', 06:59:45 INFO - 'HOME': '/home/cltbld', 06:59:45 INFO - 'LANG': 'en_US.UTF-8', 06:59:45 INFO - 'LANGUAGE': 'en_US:en', 06:59:45 INFO - 'LOGNAME': 'cltbld', 06:59:45 INFO - 'MAIL': '/var/mail/cltbld', 06:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:45 INFO - 'MOZ_NO_REMOTE': '1', 06:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:45 INFO - 'NO_EM_RESTART': '1', 06:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:45 INFO - 'PWD': '/builds/slave/test', 06:59:45 INFO - 'SHELL': '/bin/bash', 06:59:45 INFO - 'SHLVL': '1', 06:59:45 INFO - 'TERM': 'linux', 06:59:45 INFO - 'TMOUT': '86400', 06:59:45 INFO - 'USER': 'cltbld', 06:59:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:45 INFO - '_': '/tools/buildbot/bin/python'} 06:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:45 INFO - Downloading/unpacking jsonschema==2.5.1 06:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:59:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:47 INFO - Downloading functools32-3.2.3-2.tar.gz 06:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:59:47 INFO - warning: no files found matching '*.txt' 06:59:47 INFO - no previously-included directories found matching 'build' 06:59:47 INFO - no previously-included directories found matching 'dist' 06:59:47 INFO - no previously-included directories found matching '.git*' 06:59:47 INFO - Installing collected packages: jsonschema, functools32 06:59:47 INFO - Running setup.py install for functools32 06:59:47 INFO - warning: no files found matching '*.txt' 06:59:47 INFO - no previously-included directories found matching 'build' 06:59:47 INFO - no previously-included directories found matching 'dist' 06:59:47 INFO - no previously-included directories found matching '.git*' 06:59:47 INFO - Successfully installed jsonschema functools32 06:59:47 INFO - Cleaning up... 06:59:47 INFO - Return code: 0 06:59:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:59: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')]} 06:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59: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')]} 06:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:59:47 INFO - Using env: {'DISPLAY': ':0', 06:59:47 INFO - 'HOME': '/home/cltbld', 06:59:47 INFO - 'LANG': 'en_US.UTF-8', 06:59:47 INFO - 'LANGUAGE': 'en_US:en', 06:59:47 INFO - 'LOGNAME': 'cltbld', 06:59:47 INFO - 'MAIL': '/var/mail/cltbld', 06:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:47 INFO - 'MOZ_NO_REMOTE': '1', 06:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:47 INFO - 'NO_EM_RESTART': '1', 06:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:47 INFO - 'PWD': '/builds/slave/test', 06:59:47 INFO - 'SHELL': '/bin/bash', 06:59:47 INFO - 'SHLVL': '1', 06:59:47 INFO - 'TERM': 'linux', 06:59:47 INFO - 'TMOUT': '86400', 06:59:47 INFO - 'USER': 'cltbld', 06:59:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:47 INFO - '_': '/tools/buildbot/bin/python'} 06:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:50 INFO - Downloading blobuploader-1.2.4.tar.gz 06:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:59:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:59:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:50 INFO - Downloading docopt-0.6.1.tar.gz 06:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:59:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:59:50 INFO - Running setup.py install for blobuploader 06:59:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:59:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:59:50 INFO - Running setup.py install for requests 06:59:51 INFO - Running setup.py install for docopt 06:59:51 INFO - Successfully installed blobuploader requests docopt 06:59:51 INFO - Cleaning up... 06:59:51 INFO - Return code: 0 06:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:51 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 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:51 INFO - Using env: {'DISPLAY': ':0', 06:59:51 INFO - 'HOME': '/home/cltbld', 06:59:51 INFO - 'LANG': 'en_US.UTF-8', 06:59:51 INFO - 'LANGUAGE': 'en_US:en', 06:59:51 INFO - 'LOGNAME': 'cltbld', 06:59:51 INFO - 'MAIL': '/var/mail/cltbld', 06:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:51 INFO - 'MOZ_NO_REMOTE': '1', 06:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:51 INFO - 'NO_EM_RESTART': '1', 06:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:51 INFO - 'PWD': '/builds/slave/test', 06:59:51 INFO - 'SHELL': '/bin/bash', 06:59:51 INFO - 'SHLVL': '1', 06:59:51 INFO - 'TERM': 'linux', 06:59:51 INFO - 'TMOUT': '86400', 06:59:51 INFO - 'USER': 'cltbld', 06:59:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:51 INFO - '_': '/tools/buildbot/bin/python'} 06:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:51 INFO - Running setup.py (path:/tmp/pip-Uc0Lv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:51 INFO - Running setup.py (path:/tmp/pip-A_fTGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:51 INFO - Running setup.py (path:/tmp/pip-UhbSZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:51 INFO - Running setup.py (path:/tmp/pip-9V_OjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:51 INFO - Running setup.py (path:/tmp/pip-dY3ikP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:51 INFO - Running setup.py (path:/tmp/pip-BNAFAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:52 INFO - Running setup.py (path:/tmp/pip-nRBOgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:52 INFO - Running setup.py (path:/tmp/pip-iH5zv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:52 INFO - Running setup.py (path:/tmp/pip-2fn207-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:52 INFO - Running setup.py (path:/tmp/pip-7g7kwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:52 INFO - Running setup.py (path:/tmp/pip-9uXkfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:52 INFO - Running setup.py (path:/tmp/pip-bz0z03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:52 INFO - Running setup.py (path:/tmp/pip-Ue6tB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:52 INFO - Running setup.py (path:/tmp/pip-RnKyAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:52 INFO - Running setup.py (path:/tmp/pip-dTCmGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:52 INFO - Running setup.py (path:/tmp/pip-Y5ubae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:52 INFO - Running setup.py (path:/tmp/pip-ruRW79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:59:52 INFO - Running setup.py install for manifestparser 06:59:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for mozcrash 06:59:53 INFO - Running setup.py install for mozdebug 06:59:53 INFO - Running setup.py install for mozdevice 06:59:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozfile 06:59:53 INFO - Running setup.py install for mozhttpd 06:59:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozinfo 06:59:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozInstall 06:59:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozleak 06:59:53 INFO - Running setup.py install for mozlog 06:59:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for moznetwork 06:59:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozprocess 06:59:54 INFO - Running setup.py install for mozprofile 06:59:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Running setup.py install for mozrunner 06:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Running setup.py install for mozscreenshot 06:59:54 INFO - Running setup.py install for moztest 06:59:54 INFO - Running setup.py install for mozversion 06:59:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:59:54 INFO - Cleaning up... 06:59:54 INFO - Return code: 0 06:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59: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')]} 06:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59: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')]} 06:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:54 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 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:54 INFO - Using env: {'DISPLAY': ':0', 06:59:54 INFO - 'HOME': '/home/cltbld', 06:59:54 INFO - 'LANG': 'en_US.UTF-8', 06:59:54 INFO - 'LANGUAGE': 'en_US:en', 06:59:54 INFO - 'LOGNAME': 'cltbld', 06:59:54 INFO - 'MAIL': '/var/mail/cltbld', 06:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:54 INFO - 'MOZ_NO_REMOTE': '1', 06:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:54 INFO - 'NO_EM_RESTART': '1', 06:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:54 INFO - 'PWD': '/builds/slave/test', 06:59:54 INFO - 'SHELL': '/bin/bash', 06:59:54 INFO - 'SHLVL': '1', 06:59:54 INFO - 'TERM': 'linux', 06:59:54 INFO - 'TMOUT': '86400', 06:59:54 INFO - 'USER': 'cltbld', 06:59:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:54 INFO - '_': '/tools/buildbot/bin/python'} 06:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:54 INFO - Running setup.py (path:/tmp/pip-uI83lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:54 INFO - Running setup.py (path:/tmp/pip-2e8sjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:55 INFO - Running setup.py (path:/tmp/pip-JYqjp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:55 INFO - Running setup.py (path:/tmp/pip-1yZl4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:55 INFO - Running setup.py (path:/tmp/pip-2bH9o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:55 INFO - Running setup.py (path:/tmp/pip-HasX7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:55 INFO - Running setup.py (path:/tmp/pip-MOXpqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:55 INFO - Running setup.py (path:/tmp/pip-0HyDAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:55 INFO - Running setup.py (path:/tmp/pip-Q2iAcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:55 INFO - Running setup.py (path:/tmp/pip-O06fj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:55 INFO - Running setup.py (path:/tmp/pip-1wbwO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:55 INFO - Running setup.py (path:/tmp/pip-CpQq7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:55 INFO - Running setup.py (path:/tmp/pip-VWK2Ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:55 INFO - Running setup.py (path:/tmp/pip-lczwgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:55 INFO - Running setup.py (path:/tmp/pip-fLjj7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:55 INFO - Running setup.py (path:/tmp/pip-uqj5pR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:56 INFO - Running setup.py (path:/tmp/pip-3JrYcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:57 INFO - Downloading blessings-1.6.tar.gz 06:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:59:58 INFO - Installing collected packages: blessings 06:59:58 INFO - Running setup.py install for blessings 06:59:58 INFO - Successfully installed blessings 06:59:58 INFO - Cleaning up... 06:59:58 INFO - Return code: 0 06:59:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:58 INFO - Reading from file tmpfile_stdout 06:59:58 INFO - Current package versions: 06:59:58 INFO - argparse == 1.2.1 06:59:58 INFO - blessings == 1.6 06:59:58 INFO - blobuploader == 1.2.4 06:59:58 INFO - docopt == 0.6.1 06:59:58 INFO - functools32 == 3.2.3-2 06:59:58 INFO - jsonschema == 2.5.1 06:59:58 INFO - manifestparser == 1.1 06:59:58 INFO - mozInstall == 1.12 06:59:58 INFO - mozcrash == 0.17 06:59:58 INFO - mozdebug == 0.1 06:59:58 INFO - mozdevice == 0.48 06:59:58 INFO - mozfile == 1.2 06:59:58 INFO - mozhttpd == 0.7 06:59:58 INFO - mozinfo == 0.9 06:59:58 INFO - mozleak == 0.1 06:59:58 INFO - mozlog == 3.2 06:59:58 INFO - moznetwork == 0.27 06:59:58 INFO - mozprocess == 0.22 06:59:58 INFO - mozprofile == 0.28 06:59:58 INFO - mozrunner == 6.11 06:59:58 INFO - mozscreenshot == 0.1 06:59:58 INFO - mozsystemmonitor == 0.3 06:59:58 INFO - moztest == 0.7 06:59:58 INFO - mozversion == 1.4 06:59:58 INFO - psutil == 3.1.1 06:59:58 INFO - requests == 1.2.3 06:59:58 INFO - wsgiref == 0.1.2 06:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 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 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:58 INFO - Using env: {'DISPLAY': ':0', 06:59:58 INFO - 'HOME': '/home/cltbld', 06:59:58 INFO - 'LANG': 'en_US.UTF-8', 06:59:58 INFO - 'LANGUAGE': 'en_US:en', 06:59:58 INFO - 'LOGNAME': 'cltbld', 06:59:58 INFO - 'MAIL': '/var/mail/cltbld', 06:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:58 INFO - 'MOZ_NO_REMOTE': '1', 06:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:58 INFO - 'NO_EM_RESTART': '1', 06:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:58 INFO - 'PWD': '/builds/slave/test', 06:59:58 INFO - 'SHELL': '/bin/bash', 06:59:58 INFO - 'SHLVL': '1', 06:59:58 INFO - 'TERM': 'linux', 06:59:58 INFO - 'TMOUT': '86400', 06:59:58 INFO - 'USER': 'cltbld', 06:59:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:58 INFO - '_': '/tools/buildbot/bin/python'} 06:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:59:58 INFO - Cleaning up... 06:59:58 INFO - Return code: 0 06:59:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:59:58 INFO - Using env: {'DISPLAY': ':0', 06:59:58 INFO - 'HOME': '/home/cltbld', 06:59:58 INFO - 'LANG': 'en_US.UTF-8', 06:59:58 INFO - 'LANGUAGE': 'en_US:en', 06:59:58 INFO - 'LOGNAME': 'cltbld', 06:59:58 INFO - 'MAIL': '/var/mail/cltbld', 06:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:58 INFO - 'MOZ_NO_REMOTE': '1', 06:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:58 INFO - 'NO_EM_RESTART': '1', 06:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:58 INFO - 'PWD': '/builds/slave/test', 06:59:58 INFO - 'SHELL': '/bin/bash', 06:59:58 INFO - 'SHLVL': '1', 06:59:58 INFO - 'TERM': 'linux', 06:59:58 INFO - 'TMOUT': '86400', 06:59:58 INFO - 'USER': 'cltbld', 06:59:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:58 INFO - '_': '/tools/buildbot/bin/python'} 06:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:59:58 INFO - Cleaning up... 06:59:58 INFO - Return code: 0 06:59:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57f6da5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2166350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:59:58 INFO - Using env: {'DISPLAY': ':0', 06:59:58 INFO - 'HOME': '/home/cltbld', 06:59:58 INFO - 'LANG': 'en_US.UTF-8', 06:59:58 INFO - 'LANGUAGE': 'en_US:en', 06:59:58 INFO - 'LOGNAME': 'cltbld', 06:59:58 INFO - 'MAIL': '/var/mail/cltbld', 06:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:58 INFO - 'MOZ_NO_REMOTE': '1', 06:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:59:58 INFO - 'NO_EM_RESTART': '1', 06:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:58 INFO - 'PWD': '/builds/slave/test', 06:59:58 INFO - 'SHELL': '/bin/bash', 06:59:58 INFO - 'SHLVL': '1', 06:59:58 INFO - 'TERM': 'linux', 06:59:58 INFO - 'TMOUT': '86400', 06:59:58 INFO - 'USER': 'cltbld', 06:59:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 06:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:58 INFO - '_': '/tools/buildbot/bin/python'} 06:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:59 INFO - Downloading/unpacking flake8 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 07:00:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:00:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:00:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:01 INFO - no previously-included directories found matching 'docs/_build' 07:00:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:00:01 INFO - Running setup.py install for pep8 07:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:01 INFO - no previously-included directories found matching 'docs/_build' 07:00:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:00:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:00:01 INFO - Cleaning up... 07:00:01 INFO - Return code: 0 07:00:01 INFO - Running post-action listener: _resource_record_post_action 07:00:01 INFO - Running post-action listener: _start_resource_monitoring 07:00:01 INFO - Starting resource monitoring. 07:00:01 INFO - ##### 07:00:01 INFO - ##### Finished create-virtualenv step (success) 07:00:01 INFO - ##### 07:00:01 INFO - ##### 07:00:01 INFO - ##### Running install step. 07:00:01 INFO - ##### 07:00:01 INFO - Running pre-action listener: _resource_record_pre_action 07:00:01 INFO - Running main action method: install 07:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:02 INFO - Reading from file tmpfile_stdout 07:00:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:02 INFO - Reading from file tmpfile_stdout 07:00:02 INFO - Output received: 07:00:02 INFO - Usage: mozinstall [options] installer 07:00:02 INFO - Options: 07:00:02 INFO - -h, --help show this help message and exit 07:00:02 INFO - -d DEST, --destination=DEST 07:00:02 INFO - Directory to install application into. [default: 07:00:02 INFO - "/builds/slave/test"] 07:00:02 INFO - --app=APP Application being installed. [default: firefox] 07:00:02 INFO - mkdir: /builds/slave/test/build/application 07:00:02 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'] 07:00:02 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 07:00:18 INFO - Reading from file tmpfile_stdout 07:00:18 INFO - Output received: 07:00:18 INFO - /builds/slave/test/build/application/firefox/firefox 07:00:18 INFO - Running post-action listener: _resource_record_post_action 07:00:18 INFO - ##### 07:00:18 INFO - ##### Finished install step (success) 07:00:18 INFO - ##### 07:00:18 INFO - ##### 07:00:18 INFO - ##### Running run-tests step. 07:00:18 INFO - ##### 07:00:18 INFO - Running pre-action listener: _resource_record_pre_action 07:00:18 INFO - Running main action method: run_tests 07:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:18 INFO - Python 2.7.3 07:00:18 INFO - Return code: 0 07:00:18 INFO - grabbing minidump binary from tooltool 07:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:18 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 0x21f51c0>, '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 0x21f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:18 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 07:00:18 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 07:00:18 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 07:00:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:18 INFO - Return code: 0 07:00:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:00:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:00:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:00:19 INFO - Return code: 0 07:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:00:19 INFO - Using env: {'DISPLAY': ':0', 07:00:19 INFO - 'HOME': '/home/cltbld', 07:00:19 INFO - 'LANG': 'en_US.UTF-8', 07:00:19 INFO - 'LANGUAGE': 'en_US:en', 07:00:19 INFO - 'LOGNAME': 'cltbld', 07:00:19 INFO - 'MAIL': '/var/mail/cltbld', 07:00:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:19 INFO - 'MOZ_NO_REMOTE': '1', 07:00:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:19 INFO - 'NO_EM_RESTART': '1', 07:00:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:19 INFO - 'PWD': '/builds/slave/test', 07:00:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:19 INFO - 'SHELL': '/bin/bash', 07:00:19 INFO - 'SHLVL': '1', 07:00:19 INFO - 'TERM': 'linux', 07:00:19 INFO - 'TMOUT': '86400', 07:00:19 INFO - 'USER': 'cltbld', 07:00:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866', 07:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:19 INFO - '_': '/tools/buildbot/bin/python'} 07:00:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:00:19 INFO - mozversion application_buildid: 20160609055229 07:00:19 INFO - mozversion application_changeset: d463c1a271c4bd422a5d2b93f7be7c58ea57dcc7 07:00:19 INFO - mozversion application_display_name: Nightly 07:00:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:19 INFO - mozversion application_name: Firefox 07:00:19 INFO - mozversion application_remotingname: firefox 07:00:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:00:19 INFO - mozversion application_vendor: Mozilla 07:00:19 INFO - mozversion application_version: 50.0a1 07:00:19 INFO - mozversion platform_buildid: 20160609055229 07:00:19 INFO - mozversion platform_changeset: d463c1a271c4bd422a5d2b93f7be7c58ea57dcc7 07:00:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:00:19 INFO - mozversion platform_version: 50.0a1 07:00:19 INFO - using testdate: 1465480819 07:00:19 INFO - actual date: 1465480819 07:00:19 INFO - starting webserver on 'localhost:42190' 07:00:19 INFO - SUITE-START | Running 2 tests 07:00:19 INFO - TEST-START | dromaeo_css 07:00:19 INFO - operating with platform_type : linux_ 07:00:19 INFO - Initialising browser for dromaeo_css test... 07:00:19 INFO - TEST-INFO | started process 2468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6uBIp/profile http://localhost:42190/getInfo.html) 07:00:23 INFO - PROCESS | 2468 | __metrics Screen width/height:1600/1200 07:00:23 INFO - PROCESS | 2468 | colorDepth:24 07:00:23 INFO - PROCESS | 2468 | Browser inner width/height: 1024/697 07:00:23 INFO - PROCESS | 2468 | __metrics 07:00:24 ERROR - PROCESS | 2468 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:00:25 INFO - PROCESS | 2468 | console.error: PushService: 07:00:25 INFO - PROCESS | 2468 | stateChangeProcessEnqueue: Error transitioning state 07:00:25 INFO - PROCESS | 2468 | UnknownError 07:00:25 INFO - TEST-INFO | 2468: exit 0 07:00:25 INFO - Browser initialized. 07:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:25 INFO - TEST-INFO | started process 2567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6uBIp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:38 INFO - PROCESS | 2567 | RSS: Main: 175095808 07:00:38 INFO - PROCESS | 2567 | 07:01:29 INFO - PROCESS | 2567 | 1465480889597 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] 07:03:41 INFO - PROCESS | 2567 | Cycle 1(1): loaded http://localhost:42190/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42190/tests/dromaeo/cssquery-ext.html) 07:03:42 INFO - PROCESS | 2567 | RSS: Main: 270626816 07:03:42 INFO - PROCESS | 2567 | 07:06:44 INFO - PROCESS | 2567 | Cycle 1(1): loaded http://localhost:42190/tests/dromaeo/cssquery-ext.html (next: http://localhost:42190/tests/dromaeo/cssquery-jquery.html) 07:06:45 INFO - PROCESS | 2567 | RSS: Main: 254271488 07:06:45 INFO - PROCESS | 2567 | 07:09:47 INFO - PROCESS | 2567 | Cycle 1(1): loaded http://localhost:42190/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42190/tests/dromaeo/cssquery-mootools.html) 07:09:48 INFO - PROCESS | 2567 | RSS: Main: 254775296 07:09:48 INFO - PROCESS | 2567 | 07:12:50 INFO - PROCESS | 2567 | Cycle 1(1): loaded http://localhost:42190/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42190/tests/dromaeo/cssquery-prototype.html) 07:12:51 INFO - PROCESS | 2567 | RSS: Main: 252858368 07:12:51 INFO - PROCESS | 2567 | 07:15:54 INFO - PROCESS | 2567 | Cycle 1(1): loaded http://localhost:42190/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42190/tests/dromaeo/cssquery-yui.html) 07:15:54 INFO - PROCESS | 2567 | RSS: Main: 248492032 07:15:54 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | Cycle 1(1): loaded http://localhost:42190/tests/dromaeo/cssquery-yui.html (next: http://localhost:42190/tests/dromaeo/cssquery-dojo.html) 07:18:57 INFO - PROCESS | 2567 | RSS: Main: 294936576 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | __start_tp_report 07:18:57 INFO - PROCESS | 2567 | _x_x_mozilla_page_load 07:18:57 INFO - PROCESS | 2567 | _x_x_mozilla_page_load_details 07:18:57 INFO - PROCESS | 2567 | |i|pagename|runs| 07:18:57 INFO - PROCESS | 2567 | |0;dojo.html;2562.2057162279693;2586.1594981630974;2613.9215823525296;2621.6460777795005;2626.356542647053;4510.548945105488;4600.585947264745;4658.557437043484;4680.25115981443;4708.929366059508;4599.241125214344;4624.237000894848;4637.37395451614;4654.04592058628;4668.019715859674;4089.1821635672836;4236.894077648052;4320.848770293041;4350.717203381786;4409;4320.740755554661;4340.088581397895;4350.608445239928;4361.171377438292;4406.052698669785;4186.91626167475;4226.535081141072;4238.364245363189;4266.871993840159;4298.484181898161;4239.512456067561;4249.7237679551035;4252.383404406375;4283.336082907154;4293.0769884474985;4267.4025636410615;4282.057947251599;4287.549807270223;4323.3947247385395;4332.350147477872;4500.5274446183;4588.977055114703;4654.0924519718665;4655.767211639439;4659.79030943605;5031.823886163967;5034.3455350804525;5036.874078148039;5038.974805125951;5041.269015992661;5004.474530174316;5013.448520662724;5027.120253955543;5069.949300507022;5073.771680274396;4548.658850586219;4596.4254468191475;4627.8843028923875;4642.3500709900645;4701.412323459567;5096.821611243663;5101.8724531887;5111.386633603917;5116.309298244763;5133.486651334837;4897;4905;4907.730074845917;4908.092002979389;4923.8276660316715;4854.514548545188;4907.2393778964315;4914.189158788759;4958.727270000185;4977.253411988158;4901.264810278487;4919;4920.6555541111775;4923.704577725276;4975.328330675313;4908.092002979461;4909.901801963941;4920.040592084509;4921.630877684188;4990.201567749143;4085.632293093636;4122.7732474713575;4123.97938010308;4171.0615111599645;4173.6661067114555;3639.727020473475;3663.8351274192723;3678.8830715532285;3700.8149592520267;3713.6843368313994;4335.523092459827;4341.826326946887;4349.195398851222;4376.9124617508105;4387.780610969438;4933.580645645088;4969.801207951641;4981.6014718823135;4990.6506544541535;5030.974845125751;4226.852060177879;4299.441072660534;4302.9569704303185;4348.173846969129;4349.325854492558;4479.70881892676;4483.3947417098925;4484.0583477469445;4487;4509;4694.0611877624615;4701.177293973609;4713.528647135327;4715.764211789466;4755.476897541268;4816.060868130821;4866.197077482318;4894.241392584155;4900.166971614763;4981.875453113701;4636.93044604338;4646.535346465462;4651.767411629473;4687.851476388307;4694.460137084143;4847.515248475124;4853.95146048535;4859.829905953275;4875.585575226146;4910.533499317559;4894.167991441393;4953.603711703127;4965.081459929925;5002.024605202097;5004.099262132705;4888.90222195547;4896.804127834989;4897.363342765418;4900.044491324157;4945.752712364296;4887.731174785421;4894.339264199288;4896;4904.435989861212;4949.554540091409;4689.460712018162;4754.405699287589;4781.569658730731;4806.47128815837;4859.465458799458;4898.681585696918;4899.559039686445;4899.877503062452;4935.950640493549;4938.111139994836;4623.722576645412;4810.6151507878585;4812;4817.084753896888;4842.83050093245 07:18:57 INFO - PROCESS | 2567 | |1;ext.html;567.6991194666826;578.5660754434177;585.6339787632729;586.4751047812208;587.8295294364633;29265.122046338616;29982.400351992947;40318.59681403185;41122.58877411225;41152.79423602878;41145.17709645805;41621;41664.58335416645;41680.16639667205;41682.37476437856;7824.6087695615415;7947.403944704141;7969.123396426388;7971.60141992898;7983.12185659577;7766.106897706752;7854.4894581851995;7866.488678235925;7869.567173805438;7873.25204105609;7847.882281765778;7877.487963282397;7883.605819709021;7883.645235964395;7885.211478852098;7853.960730196341;7896.842063158762;7903.762887113338;7907.762767116996;7908.841823163533;7839.608019598997;7901.130875603679;7901.446898717092;7902.091259505173;7903.881441778378;39033.219335613416;39297.017574560865;39402;39419;39511.60488395108;3146.8583913723937;3149.685031496855;3586.5158203642436;3786.924261514782;3846.192299617084;31052.37895242105;31160;31876.362472750647;34959.82520087409;35008.29983400343;3470.201853573692;3592.946105808415;3631;3651.1419816343137;3672.926541469156;269269;273395;273816;274528;274618.6269068662;33875;59041.704791475764;60867.69566152141;60884.30272670003;61089.694551526954;33479.330413391595;35418;35557;35588.64411355905;35642.821785890905;14392.35234414454;14497;14564.126152430888;14566.781498277534;14579.125252484884;12039.458224379923;12126.333051682243;12140.089493288038;12151.027917766558;12158.088143389281;8234.958825205835;8244.093149753522;8269.669213231524;8319.708810191614;8346.040205376337;3195.185227766951;3211.935761284808;3228.1445416964525;3248.512723091555;3284.687954644305;851.4465597361641;861.9353548483764;875.8423483772982;889.3996552327283;942.8350038743192;27201.727982720317;27528.58707119395;27691.723082769317;28025.859870700515;28074.2981425466;903.3676426501476;935.3779736475303;983.2379905573238;1035.316690983947;1050.5010120192846;14625.24483673423;14776.187309698069;14852.405903763729;15063;15096.849031509764;406439;463745;469569;473691;731850;51307;51438;51741.2238816418;51848.48151518512;51896.740516297934;1127.1433710380334;1196.7905616517248;1220.6521141474636;1241.503398640551;1243.8258643789877;25149.622755658314;28434.28914277077;28712.712872871838;28755.5686664696;28952;42008;42514.36228456638;42653;42707.14585708206;42724.35913461363;333281;335965;336396;336640;337972;22572.097116115172;24996.750032499443;25517.87241063783;25703;25832.741672583787;40383;40694.79652601718;41190.79404602958;41230.79384603058;41573;35573.466398004566;35580.64419355773;36273;36291;36483.63516364909;35400.291994160485;35930.46104308385;36001.099972500895;36097.81951090228;36213.09467263339;34290;35281.82359088188;35300.646993529735;35466.46800297946;35543.82228088843;30245.546316804826;31279.218019549695;32237.194070148435;32268.19329516781;32275.35449291048;23756.131395238262;24358.634620480352;24522.75477245276;24705.50588988174;24896.37759056038 07:18:57 INFO - PROCESS | 2567 | |2;jquery.html;349.9405101132808;349.96675315844993;358.26198032053986;365.6343656343656;372.71487312206165;15611.609709757262;16286;17331.04679242644;17338.13309334533;17344.47966561002;16527.66944661109;16666.333346666117;16845.66308673826;17130.400435984742;17146.57133571658;4981.900361992767;5221.608379371543;5243.501867322599;5247.711375874325;5255.868603284929;3718.776873387592;3910.8240129194114;5076.340075790142;5639.774409023634;5966.79116230932;5934.228550288456;5972.79095231667;5994.250718660168;6007.038873780196;6011.489023433013;5850.6489610623075;5853.268341457318;6000.159977603139;6015.849603759897;6025.969870150621;3339.666033396665;4799.064182484417;5123.795048198105;5132.769025393866;5160.690358578498;19880.60238795216;20042;20051.097700603506;20333.593328133502;20426.897865510728;1915.636029154456;1918.4915997260737;1933.8839669619867;1947.8831270123837;2044.8466365022534;8862;9068.954655226682;9303.813923721555;9493.335466517347;9621;1740;1822.362173239369;1871.2608519634805;1881.9341323053764;1911.2546107018275;66425.99999999952;68710.31289687089;68784.49724022066;69403.3059669407;70824.62787280185;9936.701898943043;10044.849327260097;10099.343542669703;10135.239857010754;10185.439800810878;13780.65548361299;13852.09961352529;13859.653508662162;13860.584182474542;13863.792043119362;7284.089488813898;7369.410447164214;7424.220456852061;7529.962350188214;7576.696932122653;7138.643067846587;7204.351608355273;7226;7342.48602597813;7390.187079421259;4250.06498570314;4252.277112890816;4273.594008569181;4347.934780978288;4387.100644367897;1593.2033983008496;1664.2261348472775;1704.4460550320948;1782.3583509936414;1812.5378028602622;740.2720973213725;762.7864198024562;868.8132051608808;906.46027263536;915.9633614655472;15740.291686874118;16461.25924333384;16530.917345413436;16836.494905152864;17233.741493877602;847.013229587536;848.893888263967;852.9786755331043;875.6103533927342;885.0529932971658;7070.681819318143;9337.112974267433;9587.520623968774;9640.325177237666;9715.979822118576;294313;297434;298538;389462;402928;79059;81038;81885;82700.17299827046;86117;905.1175104273412;908.404994728454;931.1991687149047;936.9906300936904;965.1554889471712;15527.689446211238;15542.84457155414;15592.688146237238;15845.445409410615;16098.597535061717;36031.856336520585;36956.81521592375;36999.8150009259;37558.6244137566;37683;49601.25598116103;50413.747931260106;50853.74573127259;51881;51934.480655192965;7338;7409.222031686595;7411.592362419903;7450.627468626655;7667.731629392944;10662.786744264917;10918.290311129751;11263.7747245053;11456.828147577626;11495.942520287344;9184.311176661644;9359.110884465965;9438.103380178873;9442.905570944478;9556.665516706882;9505.904940950502;9883.555240014073;9893.604255829687;10132.493375331056;10381.63664271777;9278.675246366345;9394.530273486162;9406.717798466058;9417.434953902788;9833.803323933624;6779.2542820288745;7080.433565314659;7226.89159662616;7326.560406375635;7622;7243.348098671145;9221.907780922105;9228.123328283802;10021;10056.446895420822 07:18:57 INFO - PROCESS | 2567 | |3;mootools.html;1240.4727990603992;1331.3077199856075;1379.5102738527823;1412.6468382904275;1672.8076271228804;6425.51808614354;7259.673314700838;7493.213212612679;7500.212477689839;7687.19284475129;7467.551946883177;7577;7595.848083038336;7599.848003039936;7606.429517786174;1806.7018941874576;1870.8971006594631;1872.5973915608142;2129.669901165322;2160.8595441296266;1920.4334721257194;2110.8522403431766;2211.380813372258;2211.756706762263;2217.8891055447243;2122.968155477669;2144.3138195777356;2152.3435352217566;2158.838087143463;2159.57888211798;1780.5014595913165;2140.1439424230275;2140.967885481719;2151.0320355839935;2152.860064095829;2093.6231478333893;2173.913043478259;2174.07601769249;2181.2256648889734;2183.235867446397;7588.696452141908;7631.885521717123;7639.236076392316;7654.8469030619635;7655.693772249103;4413.867583972486;4540.795664195086;4545.659075569312;4547.431571053618;4550.021745324738;2664.773494252991;2738.794590405708;2782.8052036357462;2876.0796545105572;2892.132360291925;839.8278352937633;877.4779006491127;887.3699673232013;892.3218354050903;896.9596368163383;9988.200943924468;10034.59861605535;10045.799084018352;10047.899521004769;10049.849252261221;4059;4086.468759061303;4137.296659567881;4147.52303485097;4153.335466325373;8662.696805611899;8680.956595216983;8685.174908383693;8697.739067827975;8700.216980471789;4435.046465009974;4485.955140448554;4489.775511224426;4490.977545112319;4499.482559505634;3567.839447224881;3785.8107094645156;4046.433499310099;4104.179164167179;4131.9173616528105;3535.575730912307;3606.8376923038527;3680.9263814723554;3683.5395575553057;3688.133288677159;1128.5598616539555;1129.0346753525782;1140.3272069479046;1149.5228631208856;1163.8079716846626;672.5527524196452;709.9680514376865;816.7631386897851;832.0847068224904;838.5974732128491;5057.570106540912;5305.920411193835;5324.281222035053;5375.892482150335;5637.069883469182;866.5277423804042;898.869663898731;903.5121034641352;912.2519533982204;926.8146370725882;3520.313538859949;3606.6934310583893;3624.3476174288353;3647.2158485925124;3663.413853783382;8909.064548222474;9173.174414302744;9191.95404022989;9251.953740231256;9257.67598134062;8921.286297096216;9081.409708368936;9150.40522366044;9171.082891710776;9185.173334399937;6975.686094125776;7037.964810176019;7101.218865924744;7140.393066589294;7148.285171482914;4915.164422048332;5098.566621837185;5106;5225.973870130777;5305.495977882095;8549.358798090292;8559.14408559164;8654.394192406471;8656.350773692124;8659.437136586102;8439.395830732743;8537.103604121727;8567.657293708182;8698.739037828875;8805.251553618014;5499.092649712913;5961.165436838759;6144.262688477412;6322.209723784527;6432.09950606906;7310.342069213796;7310.707571697072;7376.7418140364825;7376.9262307378385;7377.3360397564475;6138.693065346804;6404.199475065617;6462.450691691259;6543.312952139957;6561.671916404256;6325.335839736761;6369.585976911486;6431.356864313531;6442.194725659293;6667.233268174222;6171.259448866164;6194.566380353332;6222.844428889314;6225.906611400923;6234.470070044097;4157.931863568133;4335.458067741532;4374.781260937004;4427.69006169565;4427.712198707074;4345.695801293879;4370.868873933787;4458.866234012985;4460.3532487789735;4463.2635615123145 07:18:57 INFO - PROCESS | 2567 | |4;prototype.html;286.39284716401227;287.0384212886828;292.55239483590117;293.40585314737655;294.4170542326194;4759.286656803548;4770.18732881505;4790.305405716178;4802.399700037496;4802.759862006898;4691.882702932428;4708.199606066968;4744.217204161309;4746.7863946122425;4758.619310455164;3713.7214708896804;3752.5309336332957;3754.5494540655022;3760.3607386744184;3768.679662228714;3545.592256890465;3667.624640759715;3774.811259437031;3775.112848480605;3776.753671288468;3226.0160001598965;3571.178628915351;3610.620884807097;3618.8371523281385;3620.71034317254;3635.4365073413665;3637.5998640149564;3680.1535646801117;3686.373316536182;3699.7780133192095;3270.60752709674;3276.19733165376;3280.310145680543;3295.670432956709;3303.520989456539;4425.933610995838;4482.265817851108;4581.748003859786;4604.470485894098;4621.630269578425;4177.707560470768;4181.540030596632;4183;4186.979065104655;4218.831246750126;4943.4809345018975;4963.900721985576;4976.631426357744;4979.680384698058;4991.604030065589;3396.3886500429912;3580.3913334733156;3582.441637887527;3585.709144707903;3598.874039408608;5198.454162312978;5203.6877787332505;5213.113770658959;5213.452587478336;5215.322008138955;3624.836882340301;3638.3450978823535;3641.1807343347537;3645.9453108203397;3657.7805331680183;3666.7249956253386;3691.224842782992;3693.132113953219;3704.0924973381157;3720.925581488355;4031.1736094101225;4178.582141785797;4183.288840897055;4195.811188496525;4214.136102099063;4912.336834527293;4919.409670839522;4921.7785199666105;4936.111499930047;4960.454350021495;1267.1193520503161;1279.2899940533093;1291.4446787881302;1299.5776372678918;1300.921944683303;794.4002278279977;827.3422629009951;829.1584042197175;836.0510820219096;849.9150084991575;3885.562341933446;3933.5869733678123;3988.2850374339314;3988.6210809973004;4024.2293390907907;4462.464504259445;4527.207738645724;4549.249373853278;4564.246899261585;4581.633469322446;3972.82122304497;4016.578259282733;4024.9798751006642;4025.396190571379;4037.656799172103;2284.303287497329;2401.4956859059444;2412.3969007748065;2433.381801102247;2444.960891621054;4294.012377153273;4305.461817272841;4355.607995280377;4357.934630980474;4370.2352088384405;4990.451050384455;5053.267276244924;5214.392803598201;5240.9475905241225;5255.211718242294;4860.465348811698;4885.877853053702;4897.41231052276;4908.803647854046;4926.655134140576;4881.463039065771;5098.821541246187;5105.310783044241;5122.948770512247;5129.666571672829;5007.271037284616;5018.673786203885;5032.3206367139965;5037.974810125926;5058.595312375075;4867.8094857313645;4887.706737595756;4908.828191013297;4934.432540257772;4934.55588996992;3667.8532858685353;3674.8713795017047;3674.9081272968388;3690.723195760275;3700.5004324416936;4913.77887995034;5103.18349064148;5133.717645529532;5138.640295179451;5146.279520867007;4940.9505904941925;4970.8757281068265;4972.950270497248;4978.8257410990445;5004.999000199902;4973.5523802857915;4985.675931064469;4995.025969935828;4998.87525306803;5003.299538064746;4670.299455081765;4856.441509226484;4858.975705121452;4914.803407863646;4916.3362946001835;4968.751562421792;5001.24981252815;5003.799848006039;5030.270610761346;5057.115004874206;4791.305260737243;4869.561739443467;4938.43208031081;4946.282788995647;4971.577415919687 07:18:57 INFO - PROCESS | 2567 | |5;yui.html;619.4053708439898;624.3226099681845;643.4434214404541;717.300631883913;755.3994574313421;12208.938955305233;13088.541901033466;13135.474581016748;13162.407691653874;13229.603111906657;12328.938355308212;13725.725485490284;13741.793873091912;13748.037637365389;13749.175049497037;621.5121129913019;768.0552919908516;778.2412148155546;782.3701919954434;787.8542469643106;782.2646712090645;784.5096814490943;786.6420778545777;787.0751866556801;790.3479629305817;832.4505826154739;837.2841220756227;837.9497230166179;838.9412741108125;839.1189251286156;644.7646608987709;803.8191406933452;818.5457071325412;825.9504429734235;827.5241736001763;608.1546650156287;608.2123649873424;608.4615115622706;608.4706305514187;608.8812681527104;13278.402471888789;13293.20240785556;13293.667658308523;13308;13310.134841235289;12665.620031398981;13018.479260829556;13023.86976130236;13260.138091024053;13407.937928976386;11391.430428478625;11462.770744585061;11463.484143213493;11493.540258389654;11719.648410547697;3069.570260163579;3150.6534281229046;3157.763167762427;3191.2500562367827;4278.807453664593;53106.46893531054;57998.7100064497;59406.40593594052;59407;59575;10440.321379110334;10604.57581696739;10637.361758294526;10661.413622250695;10811.83782243267;18523.90738046301;18554.628907421775;18576.53558661017;18644.627107458047;18677.15952782128;6864.553804002724;6881.346272104142;6887.449004079662;6937.7224911004005;7109.857802843914;3524.4360902255517;3603.9279214415565;3616.457531370263;3626.4197728363333;3646.5441819772527;2910.1415082550698;2999.79001469895;3013.141254742388;3015.321552650636;3019.139545229643;496.6374546581016;512.6052939236766;526.3000209721062;527.2828952624428;528.3052785586941;440.55944055944053;501.6588719670586;504.7097918696764;547.7754120810448;552.5711422945099;7708.267714567107;8201.466904651179;8256.8348633027;8289.253967142866;8453.154684531497;537.0180114451377;556.1018954388633;567.9091345384719;602.7769725201704;613.2028363127915;3981.5023122109737;4012.137390461065;4023;4023.597640235953;4024.8390064397095;94095.52952235195;102140.48929755304;103456.48271758592;105162;106903.46548267365;57302.7134864323;75037;80941;81211.59394202991;92675;50020.74989625029;61732.38267617267;62709;63428.36571634225;80480.19519804844;8350.83298334042;8530.957345213483;8574.528400938008;8597.828043439222;8728.258098061737;38185.80907095447;38626.6137338623;41615.7919210402;43366.132677346905;43581.564184357754;39629.2074158521;48406;51833.481665182866;55729.16406253991;59234;11458.369789661649;11677.532898684298;11771.411429428666;11816.527338906348;11955;12685.492580296685;12784.74430511403;13078;13418.530351437652;13993.300334983007;10630.25588208818;10870.293430926964;11016.182329915795;11170.329780213213;11299.717507062389;12251;12585.181963172365;12631.368431578201;12834.614961551168;12838.807417888553;11131.888681113409;11364.715882102682;11378.203525753448;11798.351090690094;11805.881941180478;9706.70879873605;9924.900750992687;9939.247500829424;10258.12805911476;10529.42088185157;9350.812983740423;9512.286578506779;9926;9976.20190384753;9994.900050999397 07:18:57 INFO - PROCESS | 2567 | __end_tp_report 07:18:57 INFO - PROCESS | 2567 | __start_cc_report 07:18:57 INFO - PROCESS | 2567 | _x_x_mozilla_cycle_collect,866 07:18:57 INFO - PROCESS | 2567 | __end_cc_report 07:18:57 INFO - PROCESS | 2567 | __startTimestamp1465481937766__endTimestamp 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | ------- Summary: start ------- 07:18:57 INFO - PROCESS | 2567 | Number of tests: 6 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | [#0] dojo.html Cycles:165 Average:4598.86 Median:4701.41 stddev:482.20 (10.3%) stddev-sans-first:456.44 07:18:57 INFO - PROCESS | 2567 | Values: 2562.2 2586.2 2613.9 2621.6 2626.4 4510.5 4600.6 4658.6 4680.3 4708.9 4599.2 4624.2 4637.4 4654.0 4668.0 4089.2 4236.9 4320.8 4350.7 4409.0 4320.7 4340.1 4350.6 4361.2 4406.1 4186.9 4226.5 4238.4 4266.9 4298.5 4239.5 4249.7 4252.4 4283.3 4293.1 4267.4 4282.1 4287.5 4323.4 4332.4 4500.5 4589.0 4654.1 4655.8 4659.8 5031.8 5034.3 5036.9 5039.0 5041.3 5004.5 5013.4 5027.1 5069.9 5073.8 4548.7 4596.4 4627.9 4642.4 4701.4 5096.8 5101.9 5111.4 5116.3 5133.5 4897.0 4905.0 4907.7 4908.1 4923.8 4854.5 4907.2 4914.2 4958.7 4977.3 4901.3 4919.0 4920.7 4923.7 4975.3 4908.1 4909.9 4920.0 4921.6 4990.2 4085.6 4122.8 4124.0 4171.1 4173.7 3639.7 3663.8 3678.9 3700.8 3713.7 4335.5 4341.8 4349.2 4376.9 4387.8 4933.6 4969.8 4981.6 4990.7 5031.0 4226.9 4299.4 4303.0 4348.2 4349.3 4479.7 4483.4 4484.1 4487.0 4509.0 4694.1 4701.2 4713.5 4715.8 4755.5 4816.1 4866.2 4894.2 4900.2 4981.9 4636.9 4646.5 4651.8 4687.9 4694.5 4847.5 4854.0 4859.8 4875.6 4910.5 4894.2 4953.6 4965.1 5002.0 5004.1 4888.9 4896.8 4897.4 4900.0 4945.8 4887.7 4894.3 4896.0 4904.4 4949.6 4689.5 4754.4 4781.6 4806.5 4859.5 4898.7 4899.6 4899.9 4936.0 4938.1 4623.7 4810.6 4812.0 4817.1 4842.8 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | [#1] ext.html Cycles:180 Average:51136.33 Median:36155.46 stddev:104427.52 (288.8%) stddev-sans-first:104651.44 07:18:57 INFO - PROCESS | 2567 | Values: 567.7 578.6 585.6 586.5 587.8 29265.1 29982.4 40318.6 41122.6 41152.8 41145.2 41621.0 41664.6 41680.2 41682.4 7824.6 7947.4 7969.1 7971.6 7983.1 7766.1 7854.5 7866.5 7869.6 7873.3 7847.9 7877.5 7883.6 7883.6 7885.2 7854.0 7896.8 7903.8 7907.8 7908.8 7839.6 7901.1 7901.4 7902.1 7903.9 39033.2 39297.0 39402.0 39419.0 39511.6 3146.9 3149.7 3586.5 3786.9 3846.2 31052.4 31160.0 31876.4 34959.8 35008.3 3470.2 3592.9 3631.0 3651.1 3672.9 269269.0 273395.0 273816.0 274528.0 274618.6 33875.0 59041.7 60867.7 60884.3 61089.7 33479.3 35418.0 35557.0 35588.6 35642.8 14392.4 14497.0 14564.1 14566.8 14579.1 12039.5 12126.3 12140.1 12151.0 12158.1 8235.0 8244.1 8269.7 8319.7 8346.0 3195.2 3211.9 3228.1 3248.5 3284.7 851.4 861.9 875.8 889.4 942.8 27201.7 27528.6 27691.7 28025.9 28074.3 903.4 935.4 983.2 1035.3 1050.5 14625.2 14776.2 14852.4 15063.0 15096.8 406439.0 463745.0 469569.0 473691.0 731850.0 51307.0 51438.0 51741.2 51848.5 51896.7 1127.1 1196.8 1220.7 1241.5 1243.8 25149.6 28434.3 28712.7 28755.6 28952.0 42008.0 42514.4 42653.0 42707.1 42724.4 333281.0 335965.0 336396.0 336640.0 337972.0 22572.1 24996.8 25517.9 25703.0 25832.7 40383.0 40694.8 41190.8 41230.8 41573.0 35573.5 35580.6 36273.0 36291.0 36483.6 35400.3 35930.5 36001.1 36097.8 36213.1 34290.0 35281.8 35300.6 35466.5 35543.8 30245.5 31279.2 32237.2 32268.2 32275.4 23756.1 24358.6 24522.8 24705.5 24896.4 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | [#2] jquery.html Cycles:180 Average:22828.84 Median:51907.74 stddev:56722.88 (109.3%) stddev-sans-first:56856.89 07:18:57 INFO - PROCESS | 2567 | Values: 349.9 350.0 358.3 365.6 372.7 15611.6 16286.0 17331.0 17338.1 17344.5 16527.7 16666.3 16845.7 17130.4 17146.6 4981.9 5221.6 5243.5 5247.7 5255.9 3718.8 3910.8 5076.3 5639.8 5966.8 5934.2 5972.8 5994.3 6007.0 6011.5 5850.6 5853.3 6000.2 6015.8 6026.0 3339.7 4799.1 5123.8 5132.8 5160.7 19880.6 20042.0 20051.1 20333.6 20426.9 1915.6 1918.5 1933.9 1947.9 2044.8 8862.0 9069.0 9303.8 9493.3 9621.0 1740.0 1822.4 1871.3 1881.9 1911.3 66426.0 68710.3 68784.5 69403.3 70824.6 9936.7 10044.8 10099.3 10135.2 10185.4 13780.7 13852.1 13859.7 13860.6 13863.8 7284.1 7369.4 7424.2 7530.0 7576.7 7138.6 7204.4 7226.0 7342.5 7390.2 4250.1 4252.3 4273.6 4347.9 4387.1 1593.2 1664.2 1704.4 1782.4 1812.5 740.3 762.8 868.8 906.5 916.0 15740.3 16461.3 16530.9 16836.5 17233.7 847.0 848.9 853.0 875.6 885.1 7070.7 9337.1 9587.5 9640.3 9716.0 294313.0 297434.0 298538.0 389462.0 402928.0 79059.0 81038.0 81885.0 82700.2 86117.0 905.1 908.4 931.2 937.0 965.2 15527.7 15542.8 15592.7 15845.4 16098.6 36031.9 36956.8 36999.8 37558.6 37683.0 49601.3 50413.7 50853.7 51881.0 51934.5 7338.0 7409.2 7411.6 7450.6 7667.7 10662.8 10918.3 11263.8 11456.8 11495.9 9184.3 9359.1 9438.1 9442.9 9556.7 9505.9 9883.6 9893.6 10132.5 10381.6 9278.7 9394.5 9406.7 9417.4 9833.8 6779.3 7080.4 7226.9 7326.6 7622.0 7243.3 9221.9 9228.1 10021.0 10056.4 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | [#3] mootools.html Cycles:180 Average:4949.18 Median:5315.10 stddev:2738.68 (51.5%) stddev-sans-first:2732.18 07:18:57 INFO - PROCESS | 2567 | Values: 1240.5 1331.3 1379.5 1412.6 1672.8 6425.5 7259.7 7493.2 7500.2 7687.2 7467.6 7577.0 7595.8 7599.8 7606.4 1806.7 1870.9 1872.6 2129.7 2160.9 1920.4 2110.9 2211.4 2211.8 2217.9 2123.0 2144.3 2152.3 2158.8 2159.6 1780.5 2140.1 2141.0 2151.0 2152.9 2093.6 2173.9 2174.1 2181.2 2183.2 7588.7 7631.9 7639.2 7654.8 7655.7 4413.9 4540.8 4545.7 4547.4 4550.0 2664.8 2738.8 2782.8 2876.1 2892.1 839.8 877.5 887.4 892.3 897.0 9988.2 10034.6 10045.8 10047.9 10049.8 4059.0 4086.5 4137.3 4147.5 4153.3 8662.7 8681.0 8685.2 8697.7 8700.2 4435.0 4486.0 4489.8 4491.0 4499.5 3567.8 3785.8 4046.4 4104.2 4131.9 3535.6 3606.8 3680.9 3683.5 3688.1 1128.6 1129.0 1140.3 1149.5 1163.8 672.6 710.0 816.8 832.1 838.6 5057.6 5305.9 5324.3 5375.9 5637.1 866.5 898.9 903.5 912.3 926.8 3520.3 3606.7 3624.3 3647.2 3663.4 8909.1 9173.2 9192.0 9252.0 9257.7 8921.3 9081.4 9150.4 9171.1 9185.2 6975.7 7038.0 7101.2 7140.4 7148.3 4915.2 5098.6 5106.0 5226.0 5305.5 8549.4 8559.1 8654.4 8656.4 8659.4 8439.4 8537.1 8567.7 8698.7 8805.3 5499.1 5961.2 6144.3 6322.2 6432.1 7310.3 7310.7 7376.7 7376.9 7377.3 6138.7 6404.2 6462.5 6543.3 6561.7 6325.3 6369.6 6431.4 6442.2 6667.2 6171.3 6194.6 6222.8 6225.9 6234.5 4157.9 4335.5 4374.8 4427.7 4427.7 4345.7 4370.9 4458.9 4460.4 4463.3 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | [#4] prototype.html Cycles:180 Average:4070.65 Median:4572.94 stddev:1195.79 (26.1%) stddev-sans-first:1164.93 07:18:57 INFO - PROCESS | 2567 | Values: 286.4 287.0 292.6 293.4 294.4 4759.3 4770.2 4790.3 4802.4 4802.8 4691.9 4708.2 4744.2 4746.8 4758.6 3713.7 3752.5 3754.5 3760.4 3768.7 3545.6 3667.6 3774.8 3775.1 3776.8 3226.0 3571.2 3610.6 3618.8 3620.7 3635.4 3637.6 3680.2 3686.4 3699.8 3270.6 3276.2 3280.3 3295.7 3303.5 4425.9 4482.3 4581.7 4604.5 4621.6 4177.7 4181.5 4183.0 4187.0 4218.8 4943.5 4963.9 4976.6 4979.7 4991.6 3396.4 3580.4 3582.4 3585.7 3598.9 5198.5 5203.7 5213.1 5213.5 5215.3 3624.8 3638.3 3641.2 3645.9 3657.8 3666.7 3691.2 3693.1 3704.1 3720.9 4031.2 4178.6 4183.3 4195.8 4214.1 4912.3 4919.4 4921.8 4936.1 4960.5 1267.1 1279.3 1291.4 1299.6 1300.9 794.4 827.3 829.2 836.1 849.9 3885.6 3933.6 3988.3 3988.6 4024.2 4462.5 4527.2 4549.2 4564.2 4581.6 3972.8 4016.6 4025.0 4025.4 4037.7 2284.3 2401.5 2412.4 2433.4 2445.0 4294.0 4305.5 4355.6 4357.9 4370.2 4990.5 5053.3 5214.4 5240.9 5255.2 4860.5 4885.9 4897.4 4908.8 4926.7 4881.5 5098.8 5105.3 5122.9 5129.7 5007.3 5018.7 5032.3 5038.0 5058.6 4867.8 4887.7 4908.8 4934.4 4934.6 3667.9 3674.9 3674.9 3690.7 3700.5 4913.8 5103.2 5133.7 5138.6 5146.3 4941.0 4970.9 4973.0 4978.8 5005.0 4973.6 4985.7 4995.0 4998.9 5003.3 4670.3 4856.4 4859.0 4914.8 4916.3 4968.8 5001.2 5003.8 5030.3 5057.1 4791.3 4869.6 4938.4 4946.3 4971.6 07:18:57 INFO - PROCESS | 2567 | 07:18:57 INFO - PROCESS | 2567 | [#5] yui.html Cycles:180 Average:16958.09 Median:43473.85 stddev:23969.10 (55.1%) stddev-sans-first:24004.95 07:18:57 INFO - PROCESS | 2567 | Values: 619.4 624.3 643.4 717.3 755.4 12208.9 13088.5 13135.5 13162.4 13229.6 12328.9 13725.7 13741.8 13748.0 13749.2 621.5 768.1 778.2 782.4 787.9 782.3 784.5 786.6 787.1 790.3 832.5 837.3 837.9 838.9 839.1 644.8 803.8 818.5 826.0 827.5 608.2 608.2 608.5 608.5 608.9 13278.4 13293.2 13293.7 13308.0 13310.1 12665.6 13018.5 13023.9 13260.1 13407.9 11391.4 11462.8 11463.5 11493.5 11719.6 3069.6 3150.7 3157.8 3191.3 4278.8 53106.5 57998.7 59406.4 59407.0 59575.0 10440.3 10604.6 10637.4 10661.4 10811.8 18523.9 18554.6 18576.5 18644.6 18677.2 6864.6 6881.3 6887.4 6937.7 7109.9 3524.4 3603.9 3616.5 3626.4 3646.5 2910.1 2999.8 3013.1 3015.3 3019.1 496.6 512.6 526.3 527.3 528.3 440.6 501.7 504.7 547.8 552.6 7708.3 8201.5 8256.8 8289.3 8453.2 537.0 556.1 567.9 602.8 613.2 3981.5 4012.1 4023.0 4023.6 4024.8 94095.5 102140.5 103456.5 105162.0 106903.5 57302.7 75037.0 80941.0 81211.6 92675.0 50020.7 61732.4 62709.0 63428.4 80480.2 8350.8 8531.0 8574.5 8597.8 8728.3 38185.8 38626.6 41615.8 43366.1 43581.6 39629.2 48406.0 51833.5 55729.2 59234.0 11458.4 11677.5 11771.4 11816.5 11955.0 12685.5 12784.7 13078.0 13418.5 13993.3 10630.3 10870.3 11016.2 11170.3 11299.7 12251.0 12585.2 12631.4 12834.6 12838.8 11131.9 11364.7 11378.2 11798.4 11805.9 9706.7 9924.9 9939.2 10258.1 10529.4 9350.8 9512.3 9926.0 9976.2 9994.9 07:18:57 INFO - PROCESS | 2567 | -------- Summary: end -------- 07:18:57 INFO - PROCESS | 2567 | 07:18:58 INFO - TEST-INFO | 2567: exit 0 07:18:58 INFO - TEST-OK | dromaeo_css | took 1119010ms 07:18:58 INFO - TEST-START | kraken 07:18:58 INFO - operating with platform_type : linux_ 07:18:58 INFO - Initialising browser for kraken test... 07:18:58 INFO - TEST-INFO | started process 2821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwsuRW/profile http://localhost:42190/getInfo.html) 07:19:02 INFO - PROCESS | 2821 | __metrics Screen width/height:1600/1200 07:19:02 INFO - PROCESS | 2821 | colorDepth:24 07:19:02 INFO - PROCESS | 2821 | Browser inner width/height: 1024/697 07:19:02 INFO - PROCESS | 2821 | __metrics 07:19:03 ERROR - PROCESS | 2821 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:19:03 INFO - PROCESS | 2821 | console.error: PushService: 07:19:03 INFO - PROCESS | 2821 | stateChangeProcessEnqueue: Error transitioning state 07:19:03 INFO - PROCESS | 2821 | UnknownError 07:19:04 INFO - TEST-INFO | 2821: exit 0 07:19:04 INFO - Browser initialized. 07:19:04 INFO - Running cycle 1/1 for kraken test... 07:19:04 INFO - TEST-INFO | started process 2932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcwsuRW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:16 INFO - PROCESS | 2932 | RSS: Main: 175034368 07:19:16 INFO - PROCESS | 2932 | 07:19:19 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42190/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:20 INFO - PROCESS | 2932 | RSS: Main: 231718912 07:19:20 INFO - PROCESS | 2932 | 07:19:23 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42190/tests/kraken/driver.html?testName=audio-dft) 07:19:23 INFO - PROCESS | 2932 | RSS: Main: 219463680 07:19:23 INFO - PROCESS | 2932 | 07:19:27 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42190/tests/kraken/driver.html?testName=audio-fft) 07:19:27 INFO - PROCESS | 2932 | RSS: Main: 287649792 07:19:27 INFO - PROCESS | 2932 | 07:19:29 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42190/tests/kraken/driver.html?testName=audio-oscillator) 07:19:30 INFO - PROCESS | 2932 | RSS: Main: 197701632 07:19:30 INFO - PROCESS | 2932 | 07:19:32 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42190/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:33 INFO - PROCESS | 2932 | RSS: Main: 201359360 07:19:33 INFO - PROCESS | 2932 | 07:19:36 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42190/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:37 INFO - PROCESS | 2932 | RSS: Main: 238624768 07:19:37 INFO - PROCESS | 2932 | 07:19:40 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42190/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:41 INFO - PROCESS | 2932 | RSS: Main: 233111552 07:19:41 INFO - PROCESS | 2932 | 07:19:44 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42190/tests/kraken/driver.html?testName=json-parse-financial) 07:19:44 INFO - PROCESS | 2932 | RSS: Main: 236036096 07:19:44 INFO - PROCESS | 2932 | 07:19:46 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42190/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:47 INFO - PROCESS | 2932 | RSS: Main: 222253056 07:19:47 INFO - PROCESS | 2932 | 07:19:48 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:49 INFO - PROCESS | 2932 | RSS: Main: 225087488 07:19:49 INFO - PROCESS | 2932 | 07:19:51 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:19:52 INFO - PROCESS | 2932 | RSS: Main: 233082880 07:19:52 INFO - PROCESS | 2932 | 07:19:55 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:19:55 INFO - PROCESS | 2932 | RSS: Main: 238567424 07:19:55 INFO - PROCESS | 2932 | 07:19:58 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:19:59 INFO - PROCESS | 2932 | RSS: Main: 238108672 07:19:59 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | Cycle 1(1): loaded http://localhost:42190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42190/tests/kraken/driver.html?testName=ai-astar) 07:20:01 INFO - PROCESS | 2932 | RSS: Main: 280248320 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | __start_tp_report 07:20:01 INFO - PROCESS | 2932 | _x_x_mozilla_page_load 07:20:01 INFO - PROCESS | 2932 | _x_x_mozilla_page_load_details 07:20:01 INFO - PROCESS | 2932 | |i|pagename|runs| 07:20:01 INFO - PROCESS | 2932 | |0;ai-astar;114;108;115;115;115;114;113;114;115;114 07:20:01 INFO - PROCESS | 2932 | |1;audio-beat-detection;159;131;136;198;129;132;151;143;196;132 07:20:01 INFO - PROCESS | 2932 | |2;audio-dft;161;161;162;161;162;163;162;163;163;161 07:20:01 INFO - PROCESS | 2932 | |3;audio-fft;76;76;75;120;78;77;75;76;98;77 07:20:01 INFO - PROCESS | 2932 | |4;audio-oscillator;87;92;114;87;87;86;115;85;86;127 07:20:01 INFO - PROCESS | 2932 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;117 07:20:01 INFO - PROCESS | 2932 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;145 07:20:01 INFO - PROCESS | 2932 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 07:20:01 INFO - PROCESS | 2932 | |8;json-parse-financial;63;62;63;63;63;64;67;63;63;65 07:20:01 INFO - PROCESS | 2932 | |9;json-stringify-tinderbox;65;64;66;65;65;65;64;65;65;66 07:20:01 INFO - PROCESS | 2932 | |10;stanford-crypto-aes;85;89;88;84;86;84;85;85;118;86 07:20:01 INFO - PROCESS | 2932 | |11;stanford-crypto-ccm;134;136;135;132;144;136;134;129;151;135 07:20:01 INFO - PROCESS | 2932 | |12;stanford-crypto-pbkdf2;173;170;173;169;173;169;169;173;170;168 07:20:01 INFO - PROCESS | 2932 | |13;stanford-crypto-sha256-iterative;69;66;67;66;67;67;70;68;68;65 07:20:01 INFO - PROCESS | 2932 | __end_tp_report 07:20:01 INFO - PROCESS | 2932 | __start_cc_report 07:20:01 INFO - PROCESS | 2932 | _x_x_mozilla_cycle_collect,1933 07:20:01 INFO - PROCESS | 2932 | __end_cc_report 07:20:01 INFO - PROCESS | 2932 | __startTimestamp1465482001456__endTimestamp 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | ------- Summary: start ------- 07:20:01 INFO - PROCESS | 2932 | Number of tests: 14 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.11 (1.8%) stddev-sans-first:2.24 07:20:01 INFO - PROCESS | 2932 | Values: 114.0 108.0 115.0 115.0 115.0 114.0 113.0 114.0 115.0 114.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:147.00 stddev:26.23 (17.8%) stddev-sans-first:27.65 07:20:01 INFO - PROCESS | 2932 | Values: 159.0 131.0 136.0 198.0 129.0 132.0 151.0 143.0 196.0 132.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 07:20:01 INFO - PROCESS | 2932 | Values: 161.0 161.0 162.0 161.0 162.0 163.0 162.0 163.0 163.0 161.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.50 stddev:14.78 (19.3%) stddev-sans-first:15.47 07:20:01 INFO - PROCESS | 2932 | Values: 76.0 76.0 75.0 120.0 78.0 77.0 75.0 76.0 98.0 77.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:86.50 stddev:15.71 (18.2%) stddev-sans-first:16.28 07:20:01 INFO - PROCESS | 2932 | Values: 87.0 92.0 114.0 87.0 87.0 86.0 115.0 85.0 86.0 127.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:20:01 INFO - PROCESS | 2932 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:20:01 INFO - PROCESS | 2932 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:20:01 INFO - PROCESS | 2932 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.50 07:20:01 INFO - PROCESS | 2932 | Values: 63.0 62.0 63.0 63.0 63.0 64.0 67.0 63.0 63.0 65.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 07:20:01 INFO - PROCESS | 2932 | Values: 65.0 64.0 66.0 65.0 65.0 65.0 64.0 65.0 65.0 66.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:85.50 stddev:10.32 (12.1%) stddev-sans-first:10.84 07:20:01 INFO - PROCESS | 2932 | Values: 85.0 89.0 88.0 84.0 86.0 84.0 85.0 85.0 118.0 86.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:135.50 stddev:6.33 (4.7%) stddev-sans-first:6.64 07:20:01 INFO - PROCESS | 2932 | Values: 134.0 136.0 135.0 132.0 144.0 136.0 134.0 129.0 151.0 135.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.50 stddev:2.06 (1.2%) stddev-sans-first:2.01 07:20:01 INFO - PROCESS | 2932 | Values: 173.0 170.0 173.0 169.0 173.0 169.0 169.0 173.0 170.0 168.0 07:20:01 INFO - PROCESS | 2932 | 07:20:01 INFO - PROCESS | 2932 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.45 07:20:01 INFO - PROCESS | 2932 | Values: 69.0 66.0 67.0 66.0 67.0 67.0 70.0 68.0 68.0 65.0 07:20:01 INFO - PROCESS | 2932 | -------- Summary: end -------- 07:20:01 INFO - PROCESS | 2932 | 07:20:02 INFO - TEST-INFO | 2932: exit 0 07:20:02 INFO - TEST-OK | kraken | took 64146ms 07:20:02 INFO - SUITE-END | took 1183s 07:20:02 INFO - Completed test suite (00:19:43) 07:20:02 INFO - javascript benchmark 07:20:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2562.2057162279693, 2586.1594981630974, 2613.9215823525296, 2621.6460777795005, 2626.356542647053, 4510.548945105488, 4600.585947264745, 4658.557437043484, 4680.25115981443, 4708.929366059508, 4599.241125214344, 4624.237000894848, 4637.37395451614, 4654.04592058628, 4668.019715859674, 4089.1821635672836, 4236.894077648052, 4320.848770293041, 4350.717203381786, 4409.0, 4320.740755554661, 4340.088581397895, 4350.608445239928, 4361.171377438292, 4406.052698669785, 4186.91626167475, 4226.535081141072, 4238.364245363189, 4266.871993840159, 4298.484181898161, 4239.512456067561, 4249.7237679551035, 4252.383404406375, 4283.336082907154, 4293.0769884474985, 4267.4025636410615, 4282.057947251599, 4287.549807270223, 4323.3947247385395, 4332.350147477872, 4500.5274446183, 4588.977055114703, 4654.0924519718665, 4655.767211639439, 4659.79030943605, 5031.823886163967, 5034.3455350804525, 5036.874078148039, 5038.974805125951, 5041.269015992661, 5004.474530174316, 5013.448520662724, 5027.120253955543, 5069.949300507022, 5073.771680274396, 4548.658850586219, 4596.4254468191475, 4627.8843028923875, 4642.3500709900645, 4701.412323459567, 5096.821611243663, 5101.8724531887, 5111.386633603917, 5116.309298244763, 5133.486651334837, 4897.0, 4905.0, 4907.730074845917, 4908.092002979389, 4923.8276660316715, 4854.514548545188, 4907.2393778964315, 4914.189158788759, 4958.727270000185, 4977.253411988158, 4901.264810278487, 4919.0, 4920.6555541111775, 4923.704577725276, 4975.328330675313, 4908.092002979461, 4909.901801963941, 4920.040592084509, 4921.630877684188, 4990.201567749143, 4085.632293093636, 4122.7732474713575, 4123.97938010308, 4171.0615111599645, 4173.6661067114555, 3639.727020473475, 3663.8351274192723, 3678.8830715532285, 3700.8149592520267, 3713.6843368313994, 4335.523092459827, 4341.826326946887, 4349.195398851222, 4376.9124617508105, 4387.780610969438, 4933.580645645088, 4969.801207951641, 4981.6014718823135, 4990.6506544541535, 5030.974845125751, 4226.852060177879, 4299.441072660534, 4302.9569704303185, 4348.173846969129, 4349.325854492558, 4479.70881892676, 4483.3947417098925, 4484.0583477469445, 4487.0, 4509.0, 4694.0611877624615, 4701.177293973609, 4713.528647135327, 4715.764211789466, 4755.476897541268, 4816.060868130821, 4866.197077482318, 4894.241392584155, 4900.166971614763, 4981.875453113701, 4636.93044604338, 4646.535346465462, 4651.767411629473, 4687.851476388307, 4694.460137084143, 4847.515248475124, 4853.95146048535, 4859.829905953275, 4875.585575226146, 4910.533499317559, 4894.167991441393, 4953.603711703127, 4965.081459929925, 5002.024605202097, 5004.099262132705, 4888.90222195547, 4896.804127834989, 4897.363342765418, 4900.044491324157, 4945.752712364296, 4887.731174785421, 4894.339264199288, 4896.0, 4904.435989861212, 4949.554540091409, 4689.460712018162, 4754.405699287589, 4781.569658730731, 4806.47128815837, 4859.465458799458, 4898.681585696918, 4899.559039686445, 4899.877503062452, 4935.950640493549, 4938.111139994836, 4623.722576645412, 4810.6151507878585, 4812.0, 4817.084753896888, 4842.83050093245], "value": 4568.02639267833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.6991194666826, 578.5660754434177, 585.6339787632729, 586.4751047812208, 587.8295294364633, 29265.122046338616, 29982.400351992947, 40318.59681403185, 41122.58877411225, 41152.79423602878, 41145.17709645805, 41621.0, 41664.58335416645, 41680.16639667205, 41682.37476437856, 7824.6087695615415, 7947.403944704141, 7969.123396426388, 7971.60141992898, 7983.12185659577, 7766.106897706752, 7854.4894581851995, 7866.488678235925, 7869.567173805438, 7873.25204105609, 7847.882281765778, 7877.487963282397, 7883.605819709021, 7883.645235964395, 7885.211478852098, 7853.960730196341, 7896.842063158762, 7903.762887113338, 7907.762767116996, 7908.841823163533, 7839.608019598997, 7901.130875603679, 7901.446898717092, 7902.091259505173, 7903.881441778378, 39033.219335613416, 39297.017574560865, 39402.0, 39419.0, 39511.60488395108, 3146.8583913723937, 3149.685031496855, 3586.5158203642436, 3786.924261514782, 3846.192299617084, 31052.37895242105, 31160.0, 31876.362472750647, 34959.82520087409, 35008.29983400343, 3470.201853573692, 3592.946105808415, 3631.0, 3651.1419816343137, 3672.926541469156, 269269.0, 273395.0, 273816.0, 274528.0, 274618.6269068662, 33875.0, 59041.704791475764, 60867.69566152141, 60884.30272670003, 61089.694551526954, 33479.330413391595, 35418.0, 35557.0, 35588.64411355905, 35642.821785890905, 14392.35234414454, 14497.0, 14564.126152430888, 14566.781498277534, 14579.125252484884, 12039.458224379923, 12126.333051682243, 12140.089493288038, 12151.027917766558, 12158.088143389281, 8234.958825205835, 8244.093149753522, 8269.669213231524, 8319.708810191614, 8346.040205376337, 3195.185227766951, 3211.935761284808, 3228.1445416964525, 3248.512723091555, 3284.687954644305, 851.4465597361641, 861.9353548483764, 875.8423483772982, 889.3996552327283, 942.8350038743192, 27201.727982720317, 27528.58707119395, 27691.723082769317, 28025.859870700515, 28074.2981425466, 903.3676426501476, 935.3779736475303, 983.2379905573238, 1035.316690983947, 1050.5010120192846, 14625.24483673423, 14776.187309698069, 14852.405903763729, 15063.0, 15096.849031509764, 406439.0, 463745.0, 469569.0, 473691.0, 731850.0, 51307.0, 51438.0, 51741.2238816418, 51848.48151518512, 51896.740516297934, 1127.1433710380334, 1196.7905616517248, 1220.6521141474636, 1241.503398640551, 1243.8258643789877, 25149.622755658314, 28434.28914277077, 28712.712872871838, 28755.5686664696, 28952.0, 42008.0, 42514.36228456638, 42653.0, 42707.14585708206, 42724.35913461363, 333281.0, 335965.0, 336396.0, 336640.0, 337972.0, 22572.097116115172, 24996.750032499443, 25517.87241063783, 25703.0, 25832.741672583787, 40383.0, 40694.79652601718, 41190.79404602958, 41230.79384603058, 41573.0, 35573.466398004566, 35580.64419355773, 36273.0, 36291.0, 36483.63516364909, 35400.291994160485, 35930.46104308385, 36001.099972500895, 36097.81951090228, 36213.09467263339, 34290.0, 35281.82359088188, 35300.646993529735, 35466.46800297946, 35543.82228088843, 30245.546316804826, 31279.218019549695, 32237.194070148435, 32268.19329516781, 32275.35449291048, 23756.131395238262, 24358.634620480352, 24522.75477245276, 24705.50588988174, 24896.37759056038], "value": 16954.180495036904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9405101132808, 349.96675315844993, 358.26198032053986, 365.6343656343656, 372.71487312206165, 15611.609709757262, 16286.0, 17331.04679242644, 17338.13309334533, 17344.47966561002, 16527.66944661109, 16666.333346666117, 16845.66308673826, 17130.400435984742, 17146.57133571658, 4981.900361992767, 5221.608379371543, 5243.501867322599, 5247.711375874325, 5255.868603284929, 3718.776873387592, 3910.8240129194114, 5076.340075790142, 5639.774409023634, 5966.79116230932, 5934.228550288456, 5972.79095231667, 5994.250718660168, 6007.038873780196, 6011.489023433013, 5850.6489610623075, 5853.268341457318, 6000.159977603139, 6015.849603759897, 6025.969870150621, 3339.666033396665, 4799.064182484417, 5123.795048198105, 5132.769025393866, 5160.690358578498, 19880.60238795216, 20042.0, 20051.097700603506, 20333.593328133502, 20426.897865510728, 1915.636029154456, 1918.4915997260737, 1933.8839669619867, 1947.8831270123837, 2044.8466365022534, 8862.0, 9068.954655226682, 9303.813923721555, 9493.335466517347, 9621.0, 1740.0, 1822.362173239369, 1871.2608519634805, 1881.9341323053764, 1911.2546107018275, 66425.99999999952, 68710.31289687089, 68784.49724022066, 69403.3059669407, 70824.62787280185, 9936.701898943043, 10044.849327260097, 10099.343542669703, 10135.239857010754, 10185.439800810878, 13780.65548361299, 13852.09961352529, 13859.653508662162, 13860.584182474542, 13863.792043119362, 7284.089488813898, 7369.410447164214, 7424.220456852061, 7529.962350188214, 7576.696932122653, 7138.643067846587, 7204.351608355273, 7226.0, 7342.48602597813, 7390.187079421259, 4250.06498570314, 4252.277112890816, 4273.594008569181, 4347.934780978288, 4387.100644367897, 1593.2033983008496, 1664.2261348472775, 1704.4460550320948, 1782.3583509936414, 1812.5378028602622, 740.2720973213725, 762.7864198024562, 868.8132051608808, 906.46027263536, 915.9633614655472, 15740.291686874118, 16461.25924333384, 16530.917345413436, 16836.494905152864, 17233.741493877602, 847.013229587536, 848.893888263967, 852.9786755331043, 875.6103533927342, 885.0529932971658, 7070.681819318143, 9337.112974267433, 9587.520623968774, 9640.325177237666, 9715.979822118576, 294313.0, 297434.0, 298538.0, 389462.0, 402928.0, 79059.0, 81038.0, 81885.0, 82700.17299827046, 86117.0, 905.1175104273412, 908.404994728454, 931.1991687149047, 936.9906300936904, 965.1554889471712, 15527.689446211238, 15542.84457155414, 15592.688146237238, 15845.445409410615, 16098.597535061717, 36031.856336520585, 36956.81521592375, 36999.8150009259, 37558.6244137566, 37683.0, 49601.25598116103, 50413.747931260106, 50853.74573127259, 51881.0, 51934.480655192965, 7338.0, 7409.222031686595, 7411.592362419903, 7450.627468626655, 7667.731629392944, 10662.786744264917, 10918.290311129751, 11263.7747245053, 11456.828147577626, 11495.942520287344, 9184.311176661644, 9359.110884465965, 9438.103380178873, 9442.905570944478, 9556.665516706882, 9505.904940950502, 9883.555240014073, 9893.604255829687, 10132.493375331056, 10381.63664271777, 9278.675246366345, 9394.530273486162, 9406.717798466058, 9417.434953902788, 9833.803323933624, 6779.2542820288745, 7080.433565314659, 7226.89159662616, 7326.560406375635, 7622.0, 7243.348098671145, 9221.907780922105, 9228.123328283802, 10021.0, 10056.446895420822], "value": 8071.9545465792435, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.4727990603992, 1331.3077199856075, 1379.5102738527823, 1412.6468382904275, 1672.8076271228804, 6425.51808614354, 7259.673314700838, 7493.213212612679, 7500.212477689839, 7687.19284475129, 7467.551946883177, 7577.0, 7595.848083038336, 7599.848003039936, 7606.429517786174, 1806.7018941874576, 1870.8971006594631, 1872.5973915608142, 2129.669901165322, 2160.8595441296266, 1920.4334721257194, 2110.8522403431766, 2211.380813372258, 2211.756706762263, 2217.8891055447243, 2122.968155477669, 2144.3138195777356, 2152.3435352217566, 2158.838087143463, 2159.57888211798, 1780.5014595913165, 2140.1439424230275, 2140.967885481719, 2151.0320355839935, 2152.860064095829, 2093.6231478333893, 2173.913043478259, 2174.07601769249, 2181.2256648889734, 2183.235867446397, 7588.696452141908, 7631.885521717123, 7639.236076392316, 7654.8469030619635, 7655.693772249103, 4413.867583972486, 4540.795664195086, 4545.659075569312, 4547.431571053618, 4550.021745324738, 2664.773494252991, 2738.794590405708, 2782.8052036357462, 2876.0796545105572, 2892.132360291925, 839.8278352937633, 877.4779006491127, 887.3699673232013, 892.3218354050903, 896.9596368163383, 9988.200943924468, 10034.59861605535, 10045.799084018352, 10047.899521004769, 10049.849252261221, 4059.0, 4086.468759061303, 4137.296659567881, 4147.52303485097, 4153.335466325373, 8662.696805611899, 8680.956595216983, 8685.174908383693, 8697.739067827975, 8700.216980471789, 4435.046465009974, 4485.955140448554, 4489.775511224426, 4490.977545112319, 4499.482559505634, 3567.839447224881, 3785.8107094645156, 4046.433499310099, 4104.179164167179, 4131.9173616528105, 3535.575730912307, 3606.8376923038527, 3680.9263814723554, 3683.5395575553057, 3688.133288677159, 1128.5598616539555, 1129.0346753525782, 1140.3272069479046, 1149.5228631208856, 1163.8079716846626, 672.5527524196452, 709.9680514376865, 816.7631386897851, 832.0847068224904, 838.5974732128491, 5057.570106540912, 5305.920411193835, 5324.281222035053, 5375.892482150335, 5637.069883469182, 866.5277423804042, 898.869663898731, 903.5121034641352, 912.2519533982204, 926.8146370725882, 3520.313538859949, 3606.6934310583893, 3624.3476174288353, 3647.2158485925124, 3663.413853783382, 8909.064548222474, 9173.174414302744, 9191.95404022989, 9251.953740231256, 9257.67598134062, 8921.286297096216, 9081.409708368936, 9150.40522366044, 9171.082891710776, 9185.173334399937, 6975.686094125776, 7037.964810176019, 7101.218865924744, 7140.393066589294, 7148.285171482914, 4915.164422048332, 5098.566621837185, 5106.0, 5225.973870130777, 5305.495977882095, 8549.358798090292, 8559.14408559164, 8654.394192406471, 8656.350773692124, 8659.437136586102, 8439.395830732743, 8537.103604121727, 8567.657293708182, 8698.739037828875, 8805.251553618014, 5499.092649712913, 5961.165436838759, 6144.262688477412, 6322.209723784527, 6432.09950606906, 7310.342069213796, 7310.707571697072, 7376.7418140364825, 7376.9262307378385, 7377.3360397564475, 6138.693065346804, 6404.199475065617, 6462.450691691259, 6543.312952139957, 6561.671916404256, 6325.335839736761, 6369.585976911486, 6431.356864313531, 6442.194725659293, 6667.233268174222, 6171.259448866164, 6194.566380353332, 6222.844428889314, 6225.906611400923, 6234.470070044097, 4157.931863568133, 4335.458067741532, 4374.781260937004, 4427.69006169565, 4427.712198707074, 4345.695801293879, 4370.868873933787, 4458.866234012985, 4460.3532487789735, 4463.2635615123145], "value": 3998.2081030386694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.39284716401227, 287.0384212886828, 292.55239483590117, 293.40585314737655, 294.4170542326194, 4759.286656803548, 4770.18732881505, 4790.305405716178, 4802.399700037496, 4802.759862006898, 4691.882702932428, 4708.199606066968, 4744.217204161309, 4746.7863946122425, 4758.619310455164, 3713.7214708896804, 3752.5309336332957, 3754.5494540655022, 3760.3607386744184, 3768.679662228714, 3545.592256890465, 3667.624640759715, 3774.811259437031, 3775.112848480605, 3776.753671288468, 3226.0160001598965, 3571.178628915351, 3610.620884807097, 3618.8371523281385, 3620.71034317254, 3635.4365073413665, 3637.5998640149564, 3680.1535646801117, 3686.373316536182, 3699.7780133192095, 3270.60752709674, 3276.19733165376, 3280.310145680543, 3295.670432956709, 3303.520989456539, 4425.933610995838, 4482.265817851108, 4581.748003859786, 4604.470485894098, 4621.630269578425, 4177.707560470768, 4181.540030596632, 4183.0, 4186.979065104655, 4218.831246750126, 4943.4809345018975, 4963.900721985576, 4976.631426357744, 4979.680384698058, 4991.604030065589, 3396.3886500429912, 3580.3913334733156, 3582.441637887527, 3585.709144707903, 3598.874039408608, 5198.454162312978, 5203.6877787332505, 5213.113770658959, 5213.452587478336, 5215.322008138955, 3624.836882340301, 3638.3450978823535, 3641.1807343347537, 3645.9453108203397, 3657.7805331680183, 3666.7249956253386, 3691.224842782992, 3693.132113953219, 3704.0924973381157, 3720.925581488355, 4031.1736094101225, 4178.582141785797, 4183.288840897055, 4195.811188496525, 4214.136102099063, 4912.336834527293, 4919.409670839522, 4921.7785199666105, 4936.111499930047, 4960.454350021495, 1267.1193520503161, 1279.2899940533093, 1291.4446787881302, 1299.5776372678918, 1300.921944683303, 794.4002278279977, 827.3422629009951, 829.1584042197175, 836.0510820219096, 849.9150084991575, 3885.562341933446, 3933.5869733678123, 3988.2850374339314, 3988.6210809973004, 4024.2293390907907, 4462.464504259445, 4527.207738645724, 4549.249373853278, 4564.246899261585, 4581.633469322446, 3972.82122304497, 4016.578259282733, 4024.9798751006642, 4025.396190571379, 4037.656799172103, 2284.303287497329, 2401.4956859059444, 2412.3969007748065, 2433.381801102247, 2444.960891621054, 4294.012377153273, 4305.461817272841, 4355.607995280377, 4357.934630980474, 4370.2352088384405, 4990.451050384455, 5053.267276244924, 5214.392803598201, 5240.9475905241225, 5255.211718242294, 4860.465348811698, 4885.877853053702, 4897.41231052276, 4908.803647854046, 4926.655134140576, 4881.463039065771, 5098.821541246187, 5105.310783044241, 5122.948770512247, 5129.666571672829, 5007.271037284616, 5018.673786203885, 5032.3206367139965, 5037.974810125926, 5058.595312375075, 4867.8094857313645, 4887.706737595756, 4908.828191013297, 4934.432540257772, 4934.55588996992, 3667.8532858685353, 3674.8713795017047, 3674.9081272968388, 3690.723195760275, 3700.5004324416936, 4913.77887995034, 5103.18349064148, 5133.717645529532, 5138.640295179451, 5146.279520867007, 4940.9505904941925, 4970.8757281068265, 4972.950270497248, 4978.8257410990445, 5004.999000199902, 4973.5523802857915, 4985.675931064469, 4995.025969935828, 4998.87525306803, 5003.299538064746, 4670.299455081765, 4856.441509226484, 4858.975705121452, 4914.803407863646, 4916.3362946001835, 4968.751562421792, 5001.24981252815, 5003.799848006039, 5030.270610761346, 5057.115004874206, 4791.305260737243, 4869.561739443467, 4938.43208031081, 4946.282788995647, 4971.577415919687], "value": 3691.6853796108535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.4053708439898, 624.3226099681845, 643.4434214404541, 717.300631883913, 755.3994574313421, 12208.938955305233, 13088.541901033466, 13135.474581016748, 13162.407691653874, 13229.603111906657, 12328.938355308212, 13725.725485490284, 13741.793873091912, 13748.037637365389, 13749.175049497037, 621.5121129913019, 768.0552919908516, 778.2412148155546, 782.3701919954434, 787.8542469643106, 782.2646712090645, 784.5096814490943, 786.6420778545777, 787.0751866556801, 790.3479629305817, 832.4505826154739, 837.2841220756227, 837.9497230166179, 838.9412741108125, 839.1189251286156, 644.7646608987709, 803.8191406933452, 818.5457071325412, 825.9504429734235, 827.5241736001763, 608.1546650156287, 608.2123649873424, 608.4615115622706, 608.4706305514187, 608.8812681527104, 13278.402471888789, 13293.20240785556, 13293.667658308523, 13308.0, 13310.134841235289, 12665.620031398981, 13018.479260829556, 13023.86976130236, 13260.138091024053, 13407.937928976386, 11391.430428478625, 11462.770744585061, 11463.484143213493, 11493.540258389654, 11719.648410547697, 3069.570260163579, 3150.6534281229046, 3157.763167762427, 3191.2500562367827, 4278.807453664593, 53106.46893531054, 57998.7100064497, 59406.40593594052, 59407.0, 59575.0, 10440.321379110334, 10604.57581696739, 10637.361758294526, 10661.413622250695, 10811.83782243267, 18523.90738046301, 18554.628907421775, 18576.53558661017, 18644.627107458047, 18677.15952782128, 6864.553804002724, 6881.346272104142, 6887.449004079662, 6937.7224911004005, 7109.857802843914, 3524.4360902255517, 3603.9279214415565, 3616.457531370263, 3626.4197728363333, 3646.5441819772527, 2910.1415082550698, 2999.79001469895, 3013.141254742388, 3015.321552650636, 3019.139545229643, 496.6374546581016, 512.6052939236766, 526.3000209721062, 527.2828952624428, 528.3052785586941, 440.55944055944053, 501.6588719670586, 504.7097918696764, 547.7754120810448, 552.5711422945099, 7708.267714567107, 8201.466904651179, 8256.8348633027, 8289.253967142866, 8453.154684531497, 537.0180114451377, 556.1018954388633, 567.9091345384719, 602.7769725201704, 613.2028363127915, 3981.5023122109737, 4012.137390461065, 4023.0, 4023.597640235953, 4024.8390064397095, 94095.52952235195, 102140.48929755304, 103456.48271758592, 105162.0, 106903.46548267365, 57302.7134864323, 75037.0, 80941.0, 81211.59394202991, 92675.0, 50020.74989625029, 61732.38267617267, 62709.0, 63428.36571634225, 80480.19519804844, 8350.83298334042, 8530.957345213483, 8574.528400938008, 8597.828043439222, 8728.258098061737, 38185.80907095447, 38626.6137338623, 41615.7919210402, 43366.132677346905, 43581.564184357754, 39629.2074158521, 48406.0, 51833.481665182866, 55729.16406253991, 59234.0, 11458.369789661649, 11677.532898684298, 11771.411429428666, 11816.527338906348, 11955.0, 12685.492580296685, 12784.74430511403, 13078.0, 13418.530351437652, 13993.300334983007, 10630.25588208818, 10870.293430926964, 11016.182329915795, 11170.329780213213, 11299.717507062389, 12251.0, 12585.181963172365, 12631.368431578201, 12834.614961551168, 12838.807417888553, 11131.888681113409, 11364.715882102682, 11378.203525753448, 11798.351090690094, 11805.881941180478, 9706.70879873605, 9924.900750992687, 9939.247500829424, 10258.12805911476, 10529.42088185157, 9350.812983740423, 9512.286578506779, 9926.0, 9976.20190384753, 9994.900050999397], "value": 6491.68929388541, "unit": "score"}], "name": "dromaeo_css", "value": 6255.28590201927, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 115.0, 115.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 136.0, 198.0, 129.0, 132.0, 151.0, 143.0, 196.0, 132.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0, 163.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 120.0, 78.0, 77.0, 75.0, 76.0, 98.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 114.0, 87.0, 87.0, 86.0, 115.0, 85.0, 86.0, 127.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 64.0, 67.0, 63.0, 63.0, 65.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 88.0, 84.0, 86.0, 84.0, 85.0, 85.0, 118.0, 86.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 135.0, 132.0, 144.0, 136.0, 134.0, 129.0, 151.0, 135.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 173.0, 169.0, 173.0, 169.0, 169.0, 173.0, 170.0, 168.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 66.0, 67.0, 67.0, 70.0, 68.0, 68.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1555.4999999999998, "alertThreshold": 2.0}]} 07:20:02 INFO - Return code: 0 07:20:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:02 ERROR - # TBPL SUCCESS # 07:20:02 INFO - Running post-action listener: _resource_record_post_action 07:20:02 INFO - ##### 07:20:02 INFO - ##### Finished run-tests step (success) 07:20:02 INFO - ##### 07:20:02 INFO - Running post-run listener: _resource_record_post_run 07:20:02 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 12288; Write bytes: 534335488; Read time: 204; Write time: 379628 07:20:02 INFO - TinderboxPrint: CPU usage
13.2% 07:20:02 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 204 07:20:02 INFO - TinderboxPrint: I/O write bytes / time
534,335,488 / 379,628 07:20:02 INFO - TinderboxPrint: CPU idle
8,312.3 (86.8%) 07:20:02 INFO - TinderboxPrint: CPU user
1,216.8 (12.7%) 07:20:02 INFO - TinderboxPrint: Swap in / out
0 / 0 07:20:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248041472; Read time: 0; Write time: 217844 07:20:02 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 12288; Write bytes: 286294016; Read time: 204; Write time: 161784 07:20:03 INFO - Running post-run listener: _upload_blobber_files 07:20:03 INFO - Blob upload gear active. 07:20:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:03 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 07:20:03 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'] 07:20:03 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 07:20:03 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:20:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:20:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:04 INFO - (blobuploader) - INFO - Done attempting. 07:20:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:20:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:05 INFO - (blobuploader) - INFO - Done attempting. 07:20:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:10 INFO - (blobuploader) - INFO - Done attempting. 07:20:10 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:10 INFO - Return code: 0 07:20:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b650a26f044675a29635459ca13431600332883e7008e69e11bc8388789c8e9098793369235d82d57201a280aaac5fb477732dcdc8388c041044cb1ddf5dafc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b48c4633120063b3b20125352c03a9da143c887b8e746669e7bc97324d7d6c22da2d460d8df58ec40c04092f5c292444057a121dbb5cd749136556ab50200aae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e879853d9a6564b99c16c6560e5e39b181d29ca076f9ce3f5a1ff9159e1b4457dc10b12cfd6e1157504f9651f034cb6e3c68600c888d9d63abf2ee9f084d5630"} 07:20:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:10 INFO - Contents: 07:20:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b650a26f044675a29635459ca13431600332883e7008e69e11bc8388789c8e9098793369235d82d57201a280aaac5fb477732dcdc8388c041044cb1ddf5dafc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b48c4633120063b3b20125352c03a9da143c887b8e746669e7bc97324d7d6c22da2d460d8df58ec40c04092f5c292444057a121dbb5cd749136556ab50200aae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e879853d9a6564b99c16c6560e5e39b181d29ca076f9ce3f5a1ff9159e1b4457dc10b12cfd6e1157504f9651f034cb6e3c68600c888d9d63abf2ee9f084d5630"} 07:20:10 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:10 INFO - Copying logs to upload dir... 07:20:10 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.501338 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 07:20:10.334875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 07:20:10.338097) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b650a26f044675a29635459ca13431600332883e7008e69e11bc8388789c8e9098793369235d82d57201a280aaac5fb477732dcdc8388c041044cb1ddf5dafc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b48c4633120063b3b20125352c03a9da143c887b8e746669e7bc97324d7d6c22da2d460d8df58ec40c04092f5c292444057a121dbb5cd749136556ab50200aae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e879853d9a6564b99c16c6560e5e39b181d29ca076f9ce3f5a1ff9159e1b4457dc10b12cfd6e1157504f9651f034cb6e3c68600c888d9d63abf2ee9f084d5630"} build_url:https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/LtlJjtdOTmi-S6d3qNyRrg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2b650a26f044675a29635459ca13431600332883e7008e69e11bc8388789c8e9098793369235d82d57201a280aaac5fb477732dcdc8388c041044cb1ddf5dafc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b48c4633120063b3b20125352c03a9da143c887b8e746669e7bc97324d7d6c22da2d460d8df58ec40c04092f5c292444057a121dbb5cd749136556ab50200aae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e879853d9a6564b99c16c6560e5e39b181d29ca076f9ce3f5a1ff9159e1b4457dc10b12cfd6e1157504f9651f034cb6e3c68600c888d9d63abf2ee9f084d5630"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 07:20:10.363919) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:20:10.364288) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465480669.228714-882696866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:20:10.449096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 07:20:10.449440) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 07:20:10.450028) ========= ========= Total master_lag: 0.17 =========