builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1465859678.96 results: success (0) buildid: 20160613133008 builduid: b525de4aa3c34360b0bac3ef66cbc5c9 revision: 823b470e5aacc0c2426d2563197e0ae90a36dd53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:38.962632) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:38.964945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:38.965230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:39.001243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:39.001499) ========= 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=4300f881736b422476174874000001bc-1465858891.187657-561040716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 16:14:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-13 16:14:39 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:39.129421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:39.129740) ========= 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=4300f881736b422476174874000001bc-1465858891.187657-561040716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015716 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:39.179046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 16:14:39.179371) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 823b470e5aacc0c2426d2563197e0ae90a36dd53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 823b470e5aacc0c2426d2563197e0ae90a36dd53 --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=4300f881736b422476174874000001bc-1465858891.187657-561040716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 16:14:39,874 truncating revision to first 12 chars 2016-06-13 16:14:39,874 Setting DEBUG logging. 2016-06-13 16:14:39,874 attempt 1/10 2016-06-13 16:14:39,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/823b470e5aac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 16:14:41,008 unpacking tar archive at: mozilla-inbound-823b470e5aac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.555901 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-13 16:14:40.748986) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:40.749295) ========= script_repo_revision: 823b470e5aacc0c2426d2563197e0ae90a36dd53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:40.749699) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:40.749963) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 16:14:40.760253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-13 16:14:40.760534) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=4300f881736b422476174874000001bc-1465858891.187657-561040716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:14:41 INFO - MultiFileLogger online at 20160613 16:14:41 in /builds/slave/test 16:14:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:14:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:14:41 INFO - {'append_to_log': False, 16:14:41 INFO - 'base_work_dir': '/builds/slave/test', 16:14:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:14:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:14:41 INFO - 'branch': 'Mozilla-Inbound', 16:14:41 INFO - 'buildbot_json_path': 'buildprops.json', 16:14:41 INFO - 'config_files': ('talos/linux_config.py',), 16:14:41 INFO - 'default_actions': ('clobber', 16:14:41 INFO - 'read-buildbot-config', 16:14:41 INFO - 'download-and-extract', 16:14:41 INFO - 'populate-webroot', 16:14:41 INFO - 'create-virtualenv', 16:14:41 INFO - 'install', 16:14:41 INFO - 'run-tests'), 16:14:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:14:41 INFO - 'download_minidump_stackwalk': True, 16:14:41 INFO - 'download_symbols': 'ondemand', 16:14:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:14:41 INFO - 'tooltool.py': '/tools/tooltool.py', 16:14:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:14:41 INFO - '/tools/misc-python/virtualenv.py')}, 16:14:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:14:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:14:41 INFO - 'installer_path': 'installer.exe', 16:14:41 INFO - 'log_level': 'info', 16:14:41 INFO - 'log_name': 'talos', 16:14:41 INFO - 'log_to_console': True, 16:14:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:14:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:14:41 INFO - 'opt_config_files': (), 16:14:41 INFO - 'pip_index': False, 16:14:41 INFO - 'sps_profile': False, 16:14:41 INFO - 'sps_profile_interval': 0, 16:14:41 INFO - 'suite': 'dromaeojs', 16:14:41 INFO - 'system_bits': '32', 16:14:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:14:41 INFO - 'title': 'talos-linux64-ix-045', 16:14:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:14:41 INFO - 'use_talos_json': True, 16:14:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:14:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:14:41 INFO - 'work_dir': 'build'} 16:14:41 INFO - ##### 16:14:41 INFO - ##### Running clobber step. 16:14:41 INFO - ##### 16:14:41 INFO - Running pre-action listener: _resource_record_pre_action 16:14:41 INFO - Running main action method: clobber 16:14:41 INFO - rmtree: /builds/slave/test/build 16:14:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:14:42 INFO - Running post-action listener: _resource_record_post_action 16:14:42 INFO - ##### 16:14:42 INFO - ##### Finished clobber step (success) 16:14:42 INFO - ##### 16:14:42 INFO - ##### 16:14:42 INFO - ##### Running read-buildbot-config step. 16:14:42 INFO - ##### 16:14:42 INFO - Running pre-action listener: _resource_record_pre_action 16:14:42 INFO - Running main action method: read_buildbot_config 16:14:42 INFO - Using buildbot properties: 16:14:42 INFO - { 16:14:42 INFO - "project": "", 16:14:42 INFO - "product": "firefox", 16:14:42 INFO - "script_repo_revision": "production", 16:14:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:14:42 INFO - "repository": "", 16:14:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:14:42 INFO - "buildid": "20160613133008", 16:14:42 INFO - "pgo_build": "True", 16:14:42 INFO - "basedir": "/builds/slave/test", 16:14:42 INFO - "buildnumber": 1922, 16:14:42 INFO - "slavename": "talos-linux64-ix-045", 16:14:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:14:42 INFO - "platform": "ubuntu64_hw", 16:14:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:14:42 INFO - "branch": "mozilla-inbound", 16:14:42 INFO - "repo_path": "integration/mozilla-inbound", 16:14:42 INFO - "revision": "823b470e5aacc0c2426d2563197e0ae90a36dd53", 16:14:42 INFO - "stage_platform": "linux64-pgo", 16:14:42 INFO - "builduid": "b525de4aa3c34360b0bac3ef66cbc5c9", 16:14:42 INFO - "slavebuilddir": "test" 16:14:42 INFO - } 16:14:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:14:42 INFO - Running post-action listener: _resource_record_post_action 16:14:42 INFO - ##### 16:14:42 INFO - ##### Finished read-buildbot-config step (success) 16:14:42 INFO - ##### 16:14:42 INFO - ##### 16:14:42 INFO - ##### Running download-and-extract step. 16:14:42 INFO - ##### 16:14:42 INFO - Running pre-action listener: _resource_record_pre_action 16:14:42 INFO - Running main action method: download_and_extract 16:14:42 INFO - mkdir: /builds/slave/test/build/tests 16:14:42 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')]} 16:14:42 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:14:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:14:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:14:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:43 INFO - Downloaded 1361 bytes. 16:14:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:14:43 INFO - Using the following test package requirements: 16:14:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:14:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:14:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:14:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'jsshell-linux-x86_64.zip'], 16:14:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:14:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:14:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:14:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:14:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:14:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:14:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:14:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:14: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')]} 16:14:43 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:44 INFO - Downloaded 24220083 bytes. 16:14:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:14:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:14:45 INFO - Return code: 0 16:14:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:14: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')]} 16:14:45 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:14:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:14:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:14:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:46 INFO - Downloaded 24220083 bytes. 16:14:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:14:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:14:48 INFO - Return code: 0 16:14:48 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')]} 16:14:48 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:49 INFO - Downloaded 14405384 bytes. 16:14:49 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'] 16:14:49 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 16:14:49 INFO - Return code: 0 16:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:49 INFO - https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:14:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:14:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:14:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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 16:14:50 INFO - Downloaded 59346061 bytes. 16:14:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:14:50 INFO - mkdir: /builds/slave/test/properties 16:14:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:50 INFO - Contents: 16:14:50 INFO - build_url:https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:14:51 INFO - Running post-action listener: _resource_record_post_action 16:14:51 INFO - Running post-action listener: set_extra_try_arguments 16:14:51 INFO - ##### 16:14:51 INFO - ##### Finished download-and-extract step (success) 16:14:51 INFO - ##### 16:14:51 INFO - ##### 16:14:51 INFO - ##### Running populate-webroot step. 16:14:51 INFO - ##### 16:14:51 INFO - Running pre-action listener: _resource_record_pre_action 16:14:51 INFO - Running main action method: populate_webroot 16:14:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:51 INFO - '--tppagecycles', 16:14:51 INFO - '7'], 16:14:51 INFO - 'tests': ['tsvgm']}}, 16:14:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['damp', 'tps']}, 16:14:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'tests': ['damp', 'tps']}, 16:14:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['dromaeo_dom']}, 16:14:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['basic_compositor_video']}, 16:14:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:14:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['a11yr', 16:14:51 INFO - 'ts_paint', 16:14:51 INFO - 'tpaint', 16:14:51 INFO - 'sessionrestore', 16:14:51 INFO - 'sessionrestore_no_auto_restore', 16:14:51 INFO - 'tabpaint']}, 16:14:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tsvgx', 16:14:51 INFO - 'tsvgr_opacity', 16:14:51 INFO - 'tart', 16:14:51 INFO - 'tscrollx', 16:14:51 INFO - 'cart']}, 16:14:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:51 INFO - 'tsvgr_opacity', 16:14:51 INFO - 'tart', 16:14:51 INFO - 'tscrollx', 16:14:51 INFO - 'cart']}, 16:14:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s'], 16:14:51 INFO - 'tests': ['tp5o']}, 16:14:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'tests': ['tp5o']}, 16:14:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--disable-e10s', 16:14:51 INFO - '--xperf_path', 16:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:51 INFO - 'tests': ['tp5n']}, 16:14:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:51 INFO - 'talos_options': ['--xperf_path', 16:14:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:51 INFO - 'tests': ['tp5n']}}, 16:14:51 INFO - 'talos.zip': {'path': '', 16:14:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:51 INFO - Running post-action listener: _resource_record_post_action 16:14:51 INFO - ##### 16:14:51 INFO - ##### Finished populate-webroot step (success) 16:14:51 INFO - ##### 16:14:51 INFO - ##### 16:14:51 INFO - ##### Running create-virtualenv step. 16:14:51 INFO - ##### 16:14:51 INFO - Running pre-action listener: _resource_record_pre_action 16:14:51 INFO - Running main action method: create_virtualenv 16:14:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:14:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:51 INFO - Using real prefix '/usr' 16:14:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:54 INFO - Installing pip.................done. 16:14:54 INFO - Return code: 0 16:14:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:14:54 INFO - Using env: {'DISPLAY': ':0', 16:14:54 INFO - 'HOME': '/home/cltbld', 16:14:54 INFO - 'LANG': 'en_US.UTF-8', 16:14:54 INFO - 'LANGUAGE': 'en_US:en', 16:14:54 INFO - 'LOGNAME': 'cltbld', 16:14:54 INFO - 'MAIL': '/var/mail/cltbld', 16:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:54 INFO - 'MOZ_NO_REMOTE': '1', 16:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:54 INFO - 'NO_EM_RESTART': '1', 16:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:54 INFO - 'PWD': '/builds/slave/test', 16:14:54 INFO - 'SHELL': '/bin/bash', 16:14:54 INFO - 'SHLVL': '1', 16:14:54 INFO - 'TERM': 'linux', 16:14:54 INFO - 'TMOUT': '86400', 16:14:54 INFO - 'USER': 'cltbld', 16:14:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:54 INFO - '_': '/tools/buildbot/bin/python'} 16:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:54 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 16:14:54 INFO - Cleaning up... 16:14:54 INFO - Return code: 0 16:14:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:14:54 INFO - Using env: {'DISPLAY': ':0', 16:14:54 INFO - 'HOME': '/home/cltbld', 16:14:54 INFO - 'LANG': 'en_US.UTF-8', 16:14:54 INFO - 'LANGUAGE': 'en_US:en', 16:14:54 INFO - 'LOGNAME': 'cltbld', 16:14:54 INFO - 'MAIL': '/var/mail/cltbld', 16:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:54 INFO - 'MOZ_NO_REMOTE': '1', 16:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:54 INFO - 'NO_EM_RESTART': '1', 16:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:54 INFO - 'PWD': '/builds/slave/test', 16:14:54 INFO - 'SHELL': '/bin/bash', 16:14:54 INFO - 'SHLVL': '1', 16:14:54 INFO - 'TERM': 'linux', 16:14:54 INFO - 'TMOUT': '86400', 16:14:54 INFO - 'USER': 'cltbld', 16:14:54 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:54 INFO - '_': '/tools/buildbot/bin/python'} 16:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:54 INFO - Downloading/unpacking psutil>=3.1.1 16:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:56 INFO - Installing collected packages: psutil 16:14:56 INFO - Running setup.py install for psutil 16:14:56 INFO - building 'psutil._psutil_linux' extension 16:14:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:14:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:14:56 INFO - building 'psutil._psutil_posix' extension 16:14:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:14:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:57 INFO - Successfully installed psutil 16:14:57 INFO - Cleaning up... 16:14:57 INFO - Return code: 0 16:14:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:57 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 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:14:57 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 16:14:57 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 16:14:57 INFO - Using env: {'DISPLAY': ':0', 16:14:57 INFO - 'HOME': '/home/cltbld', 16:14:57 INFO - 'LANG': 'en_US.UTF-8', 16:14:57 INFO - 'LANGUAGE': 'en_US:en', 16:14:57 INFO - 'LOGNAME': 'cltbld', 16:14:57 INFO - 'MAIL': '/var/mail/cltbld', 16:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:57 INFO - 'MOZ_NO_REMOTE': '1', 16:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:57 INFO - 'NO_EM_RESTART': '1', 16:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:57 INFO - 'PWD': '/builds/slave/test', 16:14:57 INFO - 'SHELL': '/bin/bash', 16:14:57 INFO - 'SHLVL': '1', 16:14:57 INFO - 'TERM': 'linux', 16:14:57 INFO - 'TMOUT': '86400', 16:14:57 INFO - 'USER': 'cltbld', 16:14:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:57 INFO - '_': '/tools/buildbot/bin/python'} 16:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:57 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 16:14:57 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 16:14:57 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 16:14:57 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 16:14:57 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 16:14:57 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 16:14:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:59 INFO - Installing collected packages: mozsystemmonitor 16:14:59 INFO - Running setup.py install for mozsystemmonitor 16:14:59 INFO - Successfully installed mozsystemmonitor 16:14:59 INFO - Cleaning up... 16:14:59 INFO - Return code: 0 16:14:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:14:59 INFO - Using env: {'DISPLAY': ':0', 16:14:59 INFO - 'HOME': '/home/cltbld', 16:14:59 INFO - 'LANG': 'en_US.UTF-8', 16:14:59 INFO - 'LANGUAGE': 'en_US:en', 16:14:59 INFO - 'LOGNAME': 'cltbld', 16:14:59 INFO - 'MAIL': '/var/mail/cltbld', 16:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:59 INFO - 'MOZ_NO_REMOTE': '1', 16:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:59 INFO - 'NO_EM_RESTART': '1', 16:14:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:59 INFO - 'PWD': '/builds/slave/test', 16:14:59 INFO - 'SHELL': '/bin/bash', 16:14:59 INFO - 'SHLVL': '1', 16:14:59 INFO - 'TERM': 'linux', 16:14:59 INFO - 'TMOUT': '86400', 16:14:59 INFO - 'USER': 'cltbld', 16:14:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:59 INFO - '_': '/tools/buildbot/bin/python'} 16:14:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:59 INFO - Downloading/unpacking jsonschema==2.5.1 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:15:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:15:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15: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 16:15:01 INFO - Downloading functools32-3.2.3-2.tar.gz 16:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:15:01 INFO - warning: no files found matching '*.txt' 16:15:01 INFO - no previously-included directories found matching 'build' 16:15:01 INFO - no previously-included directories found matching 'dist' 16:15:01 INFO - no previously-included directories found matching '.git*' 16:15:01 INFO - Installing collected packages: jsonschema, functools32 16:15:01 INFO - Running setup.py install for functools32 16:15:01 INFO - warning: no files found matching '*.txt' 16:15:01 INFO - no previously-included directories found matching 'build' 16:15:01 INFO - no previously-included directories found matching 'dist' 16:15:01 INFO - no previously-included directories found matching '.git*' 16:15:01 INFO - Successfully installed jsonschema functools32 16:15:01 INFO - Cleaning up... 16:15:01 INFO - Return code: 0 16:15:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:15:01 INFO - Using env: {'DISPLAY': ':0', 16:15:01 INFO - 'HOME': '/home/cltbld', 16:15:01 INFO - 'LANG': 'en_US.UTF-8', 16:15:01 INFO - 'LANGUAGE': 'en_US:en', 16:15:01 INFO - 'LOGNAME': 'cltbld', 16:15:01 INFO - 'MAIL': '/var/mail/cltbld', 16:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:01 INFO - 'MOZ_NO_REMOTE': '1', 16:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:01 INFO - 'NO_EM_RESTART': '1', 16:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:01 INFO - 'PWD': '/builds/slave/test', 16:15:01 INFO - 'SHELL': '/bin/bash', 16:15:01 INFO - 'SHLVL': '1', 16:15:01 INFO - 'TERM': 'linux', 16:15:01 INFO - 'TMOUT': '86400', 16:15:01 INFO - 'USER': 'cltbld', 16:15:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:01 INFO - '_': '/tools/buildbot/bin/python'} 16:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:15:02 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 16:15:02 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 16:15:02 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 16:15:02 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 16:15:02 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 16:15:02 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 16:15:04 INFO - Downloading blobuploader-1.2.4.tar.gz 16:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:15:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:15:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:04 INFO - Downloading docopt-0.6.1.tar.gz 16:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:15:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:15:04 INFO - Running setup.py install for blobuploader 16:15:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:15:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:15:04 INFO - Running setup.py install for requests 16:15:05 INFO - Running setup.py install for docopt 16:15:05 INFO - Successfully installed blobuploader requests docopt 16:15:05 INFO - Cleaning up... 16:15:05 INFO - Return code: 0 16:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:15:05 INFO - Using env: {'DISPLAY': ':0', 16:15:05 INFO - 'HOME': '/home/cltbld', 16:15:05 INFO - 'LANG': 'en_US.UTF-8', 16:15:05 INFO - 'LANGUAGE': 'en_US:en', 16:15:05 INFO - 'LOGNAME': 'cltbld', 16:15:05 INFO - 'MAIL': '/var/mail/cltbld', 16:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:05 INFO - 'MOZ_NO_REMOTE': '1', 16:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:05 INFO - 'NO_EM_RESTART': '1', 16:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:05 INFO - 'PWD': '/builds/slave/test', 16:15:05 INFO - 'SHELL': '/bin/bash', 16:15:05 INFO - 'SHLVL': '1', 16:15:05 INFO - 'TERM': 'linux', 16:15:05 INFO - 'TMOUT': '86400', 16:15:05 INFO - 'USER': 'cltbld', 16:15:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:05 INFO - '_': '/tools/buildbot/bin/python'} 16:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:05 INFO - Running setup.py (path:/tmp/pip-fO8rHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:05 INFO - Running setup.py (path:/tmp/pip-QJiaWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:05 INFO - Running setup.py (path:/tmp/pip-A8njMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:05 INFO - Running setup.py (path:/tmp/pip-zkwJT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:05 INFO - Running setup.py (path:/tmp/pip-6pTAUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:06 INFO - Running setup.py (path:/tmp/pip-jldpas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:06 INFO - Running setup.py (path:/tmp/pip-P3tauU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:06 INFO - Running setup.py (path:/tmp/pip-h6AHRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:06 INFO - Running setup.py (path:/tmp/pip-FwqLQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:06 INFO - Running setup.py (path:/tmp/pip-S0H7_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:06 INFO - Running setup.py (path:/tmp/pip-bdukRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:06 INFO - Running setup.py (path:/tmp/pip-_cjkEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:06 INFO - Running setup.py (path:/tmp/pip-06cM04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:06 INFO - Running setup.py (path:/tmp/pip-YI6RLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:06 INFO - Running setup.py (path:/tmp/pip-d5VZ7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:06 INFO - Running setup.py (path:/tmp/pip-JVFqMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:06 INFO - Running setup.py (path:/tmp/pip-rAsZFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:15:06 INFO - Running setup.py install for manifestparser 16:15:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:15:06 INFO - Running setup.py install for mozcrash 16:15:07 INFO - Running setup.py install for mozdebug 16:15:07 INFO - Running setup.py install for mozdevice 16:15:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Running setup.py install for mozfile 16:15:07 INFO - Running setup.py install for mozhttpd 16:15:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Running setup.py install for mozinfo 16:15:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Running setup.py install for mozInstall 16:15:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Running setup.py install for mozleak 16:15:07 INFO - Running setup.py install for mozlog 16:15:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:15:07 INFO - Running setup.py install for moznetwork 16:15:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozprocess 16:15:08 INFO - Running setup.py install for mozprofile 16:15:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozrunner 16:15:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Running setup.py install for mozscreenshot 16:15:08 INFO - Running setup.py install for moztest 16:15:08 INFO - Running setup.py install for mozversion 16:15:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:15:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:15:08 INFO - Cleaning up... 16:15:08 INFO - Return code: 0 16:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:15:08 INFO - Using env: {'DISPLAY': ':0', 16:15:08 INFO - 'HOME': '/home/cltbld', 16:15:08 INFO - 'LANG': 'en_US.UTF-8', 16:15:08 INFO - 'LANGUAGE': 'en_US:en', 16:15:08 INFO - 'LOGNAME': 'cltbld', 16:15:08 INFO - 'MAIL': '/var/mail/cltbld', 16:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:08 INFO - 'MOZ_NO_REMOTE': '1', 16:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:08 INFO - 'NO_EM_RESTART': '1', 16:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:08 INFO - 'PWD': '/builds/slave/test', 16:15:08 INFO - 'SHELL': '/bin/bash', 16:15:08 INFO - 'SHLVL': '1', 16:15:08 INFO - 'TERM': 'linux', 16:15:08 INFO - 'TMOUT': '86400', 16:15:08 INFO - 'USER': 'cltbld', 16:15:08 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:08 INFO - '_': '/tools/buildbot/bin/python'} 16:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:15:08 INFO - Running setup.py (path:/tmp/pip-n6Mybh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:15:08 INFO - Running setup.py (path:/tmp/pip-7NC1tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:15:09 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)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:15:09 INFO - Running setup.py (path:/tmp/pip-zWRusV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:15:09 INFO - Running setup.py (path:/tmp/pip-1W9RDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:15:09 INFO - Running setup.py (path:/tmp/pip-7Dxrfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:15:09 INFO - Running setup.py (path:/tmp/pip-4TIIfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:15:09 INFO - Running setup.py (path:/tmp/pip-4tNwCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:15:09 INFO - Running setup.py (path:/tmp/pip-yP45qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:15:09 INFO - Running setup.py (path:/tmp/pip-R5no7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:15:09 INFO - Running setup.py (path:/tmp/pip-Fto9Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:15:09 INFO - Running setup.py (path:/tmp/pip-oXqJSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:15:09 INFO - Running setup.py (path:/tmp/pip-eNEQRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:15:09 INFO - Running setup.py (path:/tmp/pip-Tt0MDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:15:09 INFO - Running setup.py (path:/tmp/pip-K43fMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:09 INFO - Running setup.py (path:/tmp/pip-6KtE8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:15:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:15:09 INFO - Running setup.py (path:/tmp/pip-kL10AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:15:10 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)) 16:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:15:10 INFO - Running setup.py (path:/tmp/pip-LZLr3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:15:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:12 INFO - Downloading blessings-1.6.tar.gz 16:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:15:12 INFO - Installing collected packages: blessings 16:15:12 INFO - Running setup.py install for blessings 16:15:12 INFO - Successfully installed blessings 16:15:12 INFO - Cleaning up... 16:15:12 INFO - Return code: 0 16:15:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:15:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:12 INFO - Reading from file tmpfile_stdout 16:15:12 INFO - Current package versions: 16:15:12 INFO - argparse == 1.2.1 16:15:12 INFO - blessings == 1.6 16:15:12 INFO - blobuploader == 1.2.4 16:15:12 INFO - docopt == 0.6.1 16:15:12 INFO - functools32 == 3.2.3-2 16:15:12 INFO - jsonschema == 2.5.1 16:15:12 INFO - manifestparser == 1.1 16:15:12 INFO - mozInstall == 1.12 16:15:12 INFO - mozcrash == 0.17 16:15:12 INFO - mozdebug == 0.1 16:15:12 INFO - mozdevice == 0.48 16:15:12 INFO - mozfile == 1.2 16:15:12 INFO - mozhttpd == 0.7 16:15:12 INFO - mozinfo == 0.9 16:15:12 INFO - mozleak == 0.1 16:15:12 INFO - mozlog == 3.2 16:15:12 INFO - moznetwork == 0.27 16:15:12 INFO - mozprocess == 0.22 16:15:12 INFO - mozprofile == 0.28 16:15:12 INFO - mozrunner == 6.11 16:15:12 INFO - mozscreenshot == 0.1 16:15:12 INFO - mozsystemmonitor == 0.3 16:15:12 INFO - moztest == 0.7 16:15:12 INFO - mozversion == 1.4 16:15:12 INFO - psutil == 3.1.1 16:15:12 INFO - requests == 1.2.3 16:15:12 INFO - wsgiref == 0.1.2 16:15:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:15:12 INFO - Using env: {'DISPLAY': ':0', 16:15:12 INFO - 'HOME': '/home/cltbld', 16:15:12 INFO - 'LANG': 'en_US.UTF-8', 16:15:12 INFO - 'LANGUAGE': 'en_US:en', 16:15:12 INFO - 'LOGNAME': 'cltbld', 16:15:12 INFO - 'MAIL': '/var/mail/cltbld', 16:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:12 INFO - 'MOZ_NO_REMOTE': '1', 16:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:12 INFO - 'NO_EM_RESTART': '1', 16:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:12 INFO - 'PWD': '/builds/slave/test', 16:15:12 INFO - 'SHELL': '/bin/bash', 16:15:12 INFO - 'SHLVL': '1', 16:15:12 INFO - 'TERM': 'linux', 16:15:12 INFO - 'TMOUT': '86400', 16:15:12 INFO - 'USER': 'cltbld', 16:15:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:12 INFO - '_': '/tools/buildbot/bin/python'} 16:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:15:12 INFO - Cleaning up... 16:15:12 INFO - Return code: 0 16:15:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:15:12 INFO - Using env: {'DISPLAY': ':0', 16:15:12 INFO - 'HOME': '/home/cltbld', 16:15:12 INFO - 'LANG': 'en_US.UTF-8', 16:15:12 INFO - 'LANGUAGE': 'en_US:en', 16:15:12 INFO - 'LOGNAME': 'cltbld', 16:15:12 INFO - 'MAIL': '/var/mail/cltbld', 16:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:12 INFO - 'MOZ_NO_REMOTE': '1', 16:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:12 INFO - 'NO_EM_RESTART': '1', 16:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:12 INFO - 'PWD': '/builds/slave/test', 16:15:12 INFO - 'SHELL': '/bin/bash', 16:15:12 INFO - 'SHLVL': '1', 16:15:12 INFO - 'TERM': 'linux', 16:15:12 INFO - 'TMOUT': '86400', 16:15:12 INFO - 'USER': 'cltbld', 16:15:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:12 INFO - '_': '/tools/buildbot/bin/python'} 16:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:15:12 INFO - Cleaning up... 16:15:12 INFO - Return code: 0 16:15:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:15:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7323882f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1966350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, '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': '4300f881736b422476174874000001bc-1465858891.187657-561040716', '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 16:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:15:12 INFO - Using env: {'DISPLAY': ':0', 16:15:12 INFO - 'HOME': '/home/cltbld', 16:15:12 INFO - 'LANG': 'en_US.UTF-8', 16:15:12 INFO - 'LANGUAGE': 'en_US:en', 16:15:12 INFO - 'LOGNAME': 'cltbld', 16:15:12 INFO - 'MAIL': '/var/mail/cltbld', 16:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:12 INFO - 'MOZ_NO_REMOTE': '1', 16:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:12 INFO - 'NO_EM_RESTART': '1', 16:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:12 INFO - 'PWD': '/builds/slave/test', 16:15:12 INFO - 'SHELL': '/bin/bash', 16:15:12 INFO - 'SHLVL': '1', 16:15:12 INFO - 'TERM': 'linux', 16:15:12 INFO - 'TMOUT': '86400', 16:15:12 INFO - 'USER': 'cltbld', 16:15:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:12 INFO - '_': '/tools/buildbot/bin/python'} 16:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:15:13 INFO - Downloading/unpacking flake8 16:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:15:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:15:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:15:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:15:15 INFO - no previously-included directories found matching 'docs/_build' 16:15:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:15:15 INFO - Running setup.py install for pep8 16:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:15:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:15:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:15:15 INFO - no previously-included directories found matching 'docs/_build' 16:15:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:15:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:15:15 INFO - Cleaning up... 16:15:15 INFO - Return code: 0 16:15:15 INFO - Running post-action listener: _resource_record_post_action 16:15:15 INFO - Running post-action listener: _start_resource_monitoring 16:15:16 INFO - Starting resource monitoring. 16:15:16 INFO - ##### 16:15:16 INFO - ##### Finished create-virtualenv step (success) 16:15:16 INFO - ##### 16:15:16 INFO - ##### 16:15:16 INFO - ##### Running install step. 16:15:16 INFO - ##### 16:15:16 INFO - Running pre-action listener: _resource_record_pre_action 16:15:16 INFO - Running main action method: install 16:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:15:16 INFO - Reading from file tmpfile_stdout 16:15:16 INFO - Detecting whether we're running mozinstall >=1.0... 16:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:15:16 INFO - Reading from file tmpfile_stdout 16:15:16 INFO - Output received: 16:15:16 INFO - Usage: mozinstall [options] installer 16:15:16 INFO - Options: 16:15:16 INFO - -h, --help show this help message and exit 16:15:16 INFO - -d DEST, --destination=DEST 16:15:16 INFO - Directory to install application into. [default: 16:15:16 INFO - "/builds/slave/test"] 16:15:16 INFO - --app=APP Application being installed. [default: firefox] 16:15:16 INFO - mkdir: /builds/slave/test/build/application 16:15:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:15:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:15:33 INFO - Reading from file tmpfile_stdout 16:15:33 INFO - Output received: 16:15:33 INFO - /builds/slave/test/build/application/firefox/firefox 16:15:33 INFO - Running post-action listener: _resource_record_post_action 16:15:33 INFO - ##### 16:15:33 INFO - ##### Finished install step (success) 16:15:33 INFO - ##### 16:15:33 INFO - ##### 16:15:33 INFO - ##### Running run-tests step. 16:15:33 INFO - ##### 16:15:33 INFO - Running pre-action listener: _resource_record_pre_action 16:15:33 INFO - Running main action method: run_tests 16:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:15:33 INFO - Python 2.7.3 16:15:33 INFO - Return code: 0 16:15:33 INFO - grabbing minidump binary from tooltool 16:15: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')]} 16:15:33 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 0x19f51c0>, '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 0x19f60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:15:33 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 16:15:33 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 16:15:33 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 16:15:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:15:33 INFO - Return code: 0 16:15:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:15:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:15:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:15:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:15:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:15:34 INFO - Return code: 0 16:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 16:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 16:15:34 INFO - Using env: {'DISPLAY': ':0', 16:15:34 INFO - 'HOME': '/home/cltbld', 16:15:34 INFO - 'LANG': 'en_US.UTF-8', 16:15:34 INFO - 'LANGUAGE': 'en_US:en', 16:15:34 INFO - 'LOGNAME': 'cltbld', 16:15:34 INFO - 'MAIL': '/var/mail/cltbld', 16:15:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:34 INFO - 'MOZ_NO_REMOTE': '1', 16:15:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:34 INFO - 'NO_EM_RESTART': '1', 16:15:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:34 INFO - 'PWD': '/builds/slave/test', 16:15:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:34 INFO - 'SHELL': '/bin/bash', 16:15:34 INFO - 'SHLVL': '1', 16:15:34 INFO - 'TERM': 'linux', 16:15:34 INFO - 'TMOUT': '86400', 16:15:34 INFO - 'USER': 'cltbld', 16:15:34 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1465858891.187657-561040716', 16:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:34 INFO - '_': '/tools/buildbot/bin/python'} 16:15:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 16:15:34 INFO - mozversion application_buildid: 20160613133008 16:15:34 INFO - mozversion application_changeset: 823b470e5aacc0c2426d2563197e0ae90a36dd53 16:15:34 INFO - mozversion application_display_name: Nightly 16:15:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:15:34 INFO - mozversion application_name: Firefox 16:15:34 INFO - mozversion application_remotingname: firefox 16:15:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:15:34 INFO - mozversion application_vendor: Mozilla 16:15:34 INFO - mozversion application_version: 50.0a1 16:15:34 INFO - mozversion platform_buildid: 20160613133008 16:15:34 INFO - mozversion platform_changeset: 823b470e5aacc0c2426d2563197e0ae90a36dd53 16:15:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:15:34 INFO - mozversion platform_version: 50.0a1 16:15:34 INFO - using testdate: 1465859734 16:15:34 INFO - actual date: 1465859734 16:15:34 INFO - starting webserver on 'localhost:49111' 16:15:34 INFO - SUITE-START | Running 2 tests 16:15:34 INFO - TEST-START | dromaeo_css 16:15:34 INFO - operating with platform_type : linux_ 16:15:34 INFO - Initialising browser for dromaeo_css test... 16:15:34 INFO - TEST-INFO | started process 4380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJI0iSh/profile http://localhost:49111/getInfo.html) 16:15:38 INFO - PROCESS | 4380 | __metrics Screen width/height:1600/1200 16:15:38 INFO - PROCESS | 4380 | colorDepth:24 16:15:38 INFO - PROCESS | 4380 | Browser inner width/height: 1024/697 16:15:38 INFO - PROCESS | 4380 | __metrics 16:15:39 INFO - PROCESS | 4380 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:15:39 INFO - PROCESS | 4380 | console.error: PushService: 16:15:39 INFO - PROCESS | 4380 | stateChangeProcessEnqueue: Error transitioning state 16:15:39 INFO - PROCESS | 4380 | UnknownError 16:15:40 INFO - TEST-INFO | 4380: exit 0 16:15:40 INFO - Browser initialized. 16:15:40 INFO - Running cycle 1/1 for dromaeo_css test... 16:15:40 INFO - TEST-INFO | started process 4462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJI0iSh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:52 INFO - PROCESS | 4462 | RSS: Main: 174268416 16:15:52 INFO - PROCESS | 4462 | 16:16:44 INFO - PROCESS | 4462 | 1465859804011 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] 16:18:51 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49111/tests/dromaeo/cssquery-ext.html) 16:18:52 INFO - PROCESS | 4462 | RSS: Main: 276217856 16:18:52 INFO - PROCESS | 4462 | 16:21:55 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-ext.html (next: http://localhost:49111/tests/dromaeo/cssquery-jquery.html) 16:21:55 INFO - PROCESS | 4462 | RSS: Main: 260034560 16:21:55 INFO - PROCESS | 4462 | 16:24:57 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49111/tests/dromaeo/cssquery-mootools.html) 16:24:58 INFO - PROCESS | 4462 | RSS: Main: 266825728 16:24:58 INFO - PROCESS | 4462 | 16:28:00 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49111/tests/dromaeo/cssquery-prototype.html) 16:28:00 INFO - PROCESS | 4462 | RSS: Main: 250597376 16:28:00 INFO - PROCESS | 4462 | 16:31:03 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49111/tests/dromaeo/cssquery-yui.html) 16:31:03 INFO - PROCESS | 4462 | RSS: Main: 231477248 16:31:03 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | Cycle 1(1): loaded http://localhost:49111/tests/dromaeo/cssquery-yui.html (next: http://localhost:49111/tests/dromaeo/cssquery-dojo.html) 16:34:06 INFO - PROCESS | 4462 | RSS: Main: 317579264 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | __start_tp_report 16:34:06 INFO - PROCESS | 4462 | _x_x_mozilla_page_load 16:34:06 INFO - PROCESS | 4462 | _x_x_mozilla_page_load_details 16:34:06 INFO - PROCESS | 4462 | |i|pagename|runs| 16:34:06 INFO - PROCESS | 4462 | |0;dojo.html;3094.149108995026;3105.394448082625;3122.281875168711;3150.527420886868;3164.4620414529527;5163.019026384994;5182.792688292464;5288.576913846892;5395.190721391788;5424.294841670578;5265.684058956465;5327.973360133194;5335.0663633864015;5355.7857685692625;5402.405735369106;4811.494793046723;4854.514548545152;4884.242942343943;4903;5044.319016932722;4947.752612369385;4948.653594248404;4980.97509512452;5008.9499105008845;5012.924806127911;4687.2969054641735;4756.143894099061;4762.904741905159;4795.160846851822;4840.854774356775;4827.831025914112;4840.467548569654;4843.56407923285;4844.951550484485;4889.657723959324;4640.303954406832;4801.687890287155;4804.8318308859025;4821.831235906727;4865.464798872121;5242.213667949838;5317.175837745156;5325.068113080196;5411.026015317241;5413.783448662049;5747.425257474261;5785.797497087582;5792.855178620526;5794.82615521535;5802.767889284466;5602.299712535933;5628.549716022709;5720.11338242573;5750.424957504216;5750.769969201227;5290.81482148123;5379.354477462691;5380.973095134499;5382.730863456851;5385.999999999961;5841.532677385799;5854.648721076749;5886.352501224862;5898.321693005273;5899.351071382144;5475.06923822951;5627.296587926509;5642.576806739511;5646.378898321182;5658.943410565924;5717.942820571824;5724;5730.656160630292;5731.512821410143;5734.741936612862;5659.207710920475;5668.234788303609;5696.316442026983;5700.828975130753;5717.742701578439;5517.613767036269;5528.308961379827;5595.104783234663;5615.298087739033;5715;4333.263345231318;4349.543297953733;4353.934690979638;4354.673399495051;4380.5838445347645;3878.1855810279594;3897.922041559153;3903.1022864741267;3913.2760439318818;3934.449177115206;5147.0992576298995;5195.428502864682;5348.064088784525;5359.544438722674;5405.864853378697;5753.194552762617;5766.971165144148;5770.711464426762;5778.3354914184565;5808.796692115756;5150.896982060338;5407.324084489439;5416.837494875082;5421.647592906448;5421.728913554307;4926;4970.751462426864;4994.725290109006;5010;5015.348004759431;5965.34381218057;5967.19442875215;5973.402659734079;5980.611260268156;5983.9401605983385;5473.124300111963;5581.5255703265675;5806.158107074366;5831.446012628793;5832.387599302182;5764;5775.653460792366;5787.276590426197;5840.678762668094;5888.263967004124;5533.2253484513;5565.582581306499;5571;5571.164325351229;5580.967521008626;5517;5671.376148623731;5676.7161641918565;5679.630823996427;5737;5588.30146231721;5657.868426314836;5681.0910254359105;5681.261436013292;5733.254676891977;5551.056320425618;5586.581006424453;5605.355384130877;5608.579356548356;5617.354004289559;5248.527632513092;5387.703676297684;5439.184122381675;5515.917261241165;5528.419515950767;5602.85992850182;5638.23883775685;5644;5647.237622920853;5652.039153344023;5437.048516509674;5482.479164479368;5485.6982865942755;5493.890122197614;5531.612787104864 16:34:06 INFO - PROCESS | 4462 | |1;ext.html;577.9942200577993;589.9321578018528;619.2568917299236;622.0824284180833;627.5105417774134;32243.35513289736;41655.79172104139;42441.36337954933;42858.35712464315;43067.35398969018;44394.55605443945;44902.775486122526;44964.550354496445;44971.55028449723;44972.3254151188;7965.72119975801;8947.686830960902;9032.412893161923;9082.500462474562;10610.098141657969;10434.68695939123;10740.409277489734;10829.187810914174;10873.510692018877;10886;10777.868323826004;10832.837507437394;10839.83740243897;10840.512176952017;10843.186760992918;10710.892891071067;10796.190285728524;10833.945830270877;10869.347839129598;10884.346939183675;10802.297850639683;10897.073748731367;10897.83653245202;10898.836517452244;10899.83650245247;42415.15169696589;42674.57325426737;42888.78555607233;42889.78555107205;42898.57101428977;3667.174885650734;3704.518412606344;3726.5155529781227;3928.4500169976227;4201.222773786859;32645.836770815993;32862.83568582142;32896.342073158405;33406;33469.49795753066;4262.083652014831;4315.956840431619;4351.49957754859;4403.889902752425;4410.691251612388;321964;323712;323942;324540;325444;32959.340813184084;33292.66707332944;33531.16172095717;56148.719256403456;56856;37456.25087498235;37468.25063498715;37569;37812.810935945694;37939.24121517554;15255.771163432557;15416;15433.228338583025;15435.691286174213;15449.691006179813;12219.755604887852;12400.689982750504;12774.297413642153;12848.935755321163;13383.330833458289;8977.775555611162;8988.910110898938;8998.820023599492;9036.502992335485;9068.773280668036;3196.5844440222622;3398.2290360783345;3466.6533346665133;3486.529318542015;3511.0871173495075;983.6163896080534;1076.208986394999;1120.6918097523082;1147.4205526209378;1204.951801927913;31689.84155079256;32299.86302602498;32720.509192362133;32902.67097329044;33028;1108.3959242213014;1190.8213767934706;1194.7311854832767;1210.3585099897068;1251.6495381293253;16866.578335541708;17311.826881731275;17384.65230695379;17387.65224695499;17477.300907963792;547316;555340;557719;558271;560041;57913;58947.11579326313;59240.111398329056;59341.40658593359;59460.702696487104;1246.8628450870397;1341.2354957674227;1383.0940733819364;1400.355836315286;1410.8589141086015;31477.8426107868;33387.83306083454;33461.330773384885;33608.1597960053;34013.82993085118;48884;49393.25910111423;49490;49495.50504495053;49535.50464495453;275909;280428;281157;281339;281619;25898.482030359664;28212.85893570519;28790;28813.855930720212;31015.68984310128;48715.756421219085;49232;49619.75190124026;49796;50087.74956125196;40917;41159.38260926148;41269;42020.579794201665;42570.5742942579;41183.7940810294;41711.10250528733;41838.79080604578;41929.580704192565;42289;41076;41420.1715965673;44968.55031449644;45858.31212531748;46118;41082.79458602688;45777.54222457733;46222.53777462182;46491.048260898206;46963.29555056609;34494;35315.646843531234;35351.64648353484;35639;35641 16:34:06 INFO - PROCESS | 4462 | |2;jquery.html;414.4342971843434;415.920975014747;420.9431726716894;421.96202341789234;438.0931471853263;18189.454316370513;19524.90237548814;20002.799972000277;20067.59864802703;20170.294039708613;18882;18893.622127557475;20140.194392224294;20154.89922550389;20166.294179703713;5032.370953630787;5329.973350133244;5341.919871201935;5399.19012148177;5402.459754024586;5272.288241087443;5311.256424100629;5375.11310633745;5376.059189641797;5380.811671591495;5221.503957124067;5270.894582108374;5285.86785330366;5403.405625381224;5405.837824865261;5365;5378.327709036371;5384.596155288349;5395.865103372408;5607.102863541854;5740.942590574083;5805.7387417566315;5815.331236907768;5834.824955251307;5848.327442344143;14114.717705645933;14129.858701412957;14331.42674293027;14494.855051449562;15165.545033649008;2128.265748316828;2225.9666105008437;2279.566882292376;2307.457747429353;2423.418379588886;10035.147012503947;10442.321249118782;10568.577256909715;11054.778904421946;11057.06014988727;1732.6534693061312;1806.4490330449207;1866.001689096327;1933.7582802149732;1973.190991693399;79378.60310698468;85784.57107714421;86868.56565717194;87099.56450217772;87608.56195719044;10637.946810266054;10736.463176841127;11390.37352945596;11536.480858361394;11921.821172682417;14627.049241799248;15240.314185861664;15343.156126413154;15907;16015.039097654178;8285.461445006054;8351.624176912053;8353.95823020881;8447.493150410995;8542.701005464778;8229.95885020571;8235.682290833558;8292.460990035628;8439.873401898976;8529.019162796234;4840.370751802243;4960.801567937242;4996.200607902718;5060.2662613920775;5062.772175252123;1860.8046155153784;1925.0952052535285;1939.990300048519;1974.1079318797742;2001.7597888253504;934.1685899549407;936.8969413364524;950.4629884115452;1027.337367398024;1090.4093765248235;19758.506037348892;19992.400227993185;19998.600027999357;20078;20164;973.6202880876464;983.9409635421755;990.2770977186694;998.1964518562627;1042.890496497872;10781;11493.252938558968;11505.654830355103;11510.942445287887;11517.48171332292;421406;427856;428081;430371;436064;67798;82702;84227;94719;96473.51763241139;968.2157452463528;974.8927617962019;991.8710567626163;999.4253304350028;1002.5638847101388;17723.82276177222;18057.1874265661;18160.18279177414;18236;18652.626947461245;40219.3967090488;40689.38965915573;40988.18023639451;41006.1798764029;42081;53949;55695.16457253064;55917.44082559285;57203;57779.71110144423;9055.230305424113;9074.954625226832;9076.818463630823;9176.128267814547;9291.67479138227;11270.605528806453;13280.667983300495;13434.596962091153;14019.299035048003;14067.929660351632;11964.222325548812;12139.150259481752;12215.877841221474;12255.816162757745;12288.385580721108;11669.708257293636;12049.638510844688;12103.213291136048;12229.143959923076;12377.381130943597;12268.263904165779;12329.630111096682;12458.75082498363;12463;12545.811812822998;8893.333000025154;9043.276537876822;9321.72034838956;9376.48429336393;9444.433333999981;12142.696432589257;12238.938805305916;12288.877111228774;12383.133180677627;12562.371881406076 16:34:06 INFO - PROCESS | 4462 | |3;mootools.html;1263.1852455166425;1424.9216293103877;1464.0117920403727;1601.247413715554;1761.5067781021319;8473.661053557858;8834.337424693149;8846.02693703692;9000.414973026749;9106.77233069172;8794.252488538466;8980.101989801033;9004.549772511382;9010.954945225265;9012.188902998729;2092.7697953225133;2148.720666313377;2148.7421509418814;2423.3941514621347;2455.2143314139485;2118.4174352053233;2330.976690233093;2400.7839294463497;2401.3756423329887;2407.8555286682767;2334.2180369576213;2345.495718420539;2352.2120089769946;2354.105439932823;2358.492924021335;2016.3547664747286;2285.1887579909057;2290.335802617239;2291.5875142474347;2292.8853557322236;2311.653252012195;2369.0523790483944;2370.2178281167344;2390.9163179288817;2393.676853624756;8981.236594889377;9011.188992990663;9035.864462033074;9037.186653201243;9043.547822608909;5263.815766448156;5418.078926582491;5421.051316019681;5431;5434.402215756264;3444.9311013779584;3495.3009398120225;3576.7317451191007;3580.534530511043;3606.2607165531003;1157.282484859384;1176.5705517486142;1181.9645410637695;1189.6906804230875;1195.229077245172;12750.29873356965;12781.61655150347;12792.424340904681;12795.680107997281;12796.48814047437;4640.69835460694;4645.558671926162;4726.669133160714;4749.216379297377;4750.572448479654;10486;10560.47197640115;10636.840447393295;10638.202134839918;10641.840372394265;5360.088784906575;5362.651427657268;5364.490373414519;5416.729163541807;5422.593305502103;4725.976370118127;4871.3667223260745;4896.926546101811;4948.802047918115;4967.254911763264;3907.6873850091924;3946.4869566956113;3966.7421617594764;3991.4212439196735;4040.5151381834366;1207.390267914715;1215.5198696515004;1219.9634010979685;1228.3919459867245;1244.1291096232674;791.928726414614;872.1017352127319;890.105444028747;913.7076135636665;914.0996118823087;5476.096444086681;5697.914531282034;5740.1102829061565;5757.510611598061;5936.8812623748145;462.53746253746255;463.5202565344919;465.3926625753357;471.73347058911605;475.02619629758857;3624.2932628137787;3713.294474049922;3735.9626403736156;3759;3777.546694396635;10991.505382257817;11448.656540303804;11456.599019034295;11534.538618455168;11563.190576659721;11047.83428248577;11078.446077696082;11162;11164.218504704755;11171;7518.436117291225;7669.7315593953945;7678.270564296383;8503.149685031447;8625.913740862636;5440.7551660174595;5600.411956744483;5621.471605628421;5748.310202775694;5766.596338256281;9803.117719405287;9957.402555846673;9984.301098923006;10279.897201027894;10292.176625870063;9316.301277404085;10223.539940702538;10397.480125993821;10423.114035307084;10460.26778125524;7420.480566360303;7613.162552119373;7629.38964882797;7827.47364263963;7827.982362292865;8451.281641060334;8491.405601607828;8493.065762765968;8611.354148439017;8732.301415886586;7749.41879359039;7795.181505941794;7835.647395867314;7887.44787864844;7889.605519724106;7248.347648711641;7281.7815465533995;7320.121585409572;7327;7402.740904068547;6332;6384.968075159594;6461.063145843732;6575.868482630416;6576.013597960345;4861.927071093865;4893.363862697826;4917.508249175054;4928.950710492849;4982.327385803015;4826.686265392738;4846.951530484791;4901.240307752304;4909.3126962224605;4983.775730092082 16:34:06 INFO - PROCESS | 4462 | |4;prototype.html;330.2900636917556;340.32955078495365;346.27628256943;346.3281234405253;348.8029263466143;5288.312519372476;5400.891982160354;5459.153831156173;5467.835964921053;5499;5358.579976306282;5401.352587460823;5407.783688652459;5437.613408580806;5469.72651367432;4238.894027649302;4259.488861336628;4271.508776490697;4272.230998420283;4310.633596144332;4165.500139983191;4284.186004659105;4299.892502687442;4319.438472998506;4332.501762297345;4221.873343799691;4222.134462435193;4247.5964783345535;4286.978565107186;4301.677374196932;4218.831246750126;4226.260404429213;4238.788060596958;4259.169461954935;4272.594103560157;3734.3651579231596;3784.5836957934607;3798.8670396536263;3833.9073364091378;3835.5013848199555;5222.216667499867;5236.397814251333;5237.271700338917;5255.318298144595;5310.36275646921;4861.440934292531;4885.682430642032;4932.679375840559;4958.082754690394;4959.132151873408;5556.499915007668;5686.521504408842;5694.971525142348;5704.146152500454;5706.629069110494;4195.223883581547;4229.809658565372;4245.893852653709;4259.659227261812;4266.6586673066395;5897.8820423591715;5951.196588460546;5956.37458066901;5962.075878238837;6002.519798416116;4113.280175969194;4294.312909934395;4314.676399270067;4336.566343365701;4364.432623758955;4336.4145840311785;4342.609165175086;4361.5170841913905;4368.410264614236;4394.384786129945;4894.314795928502;4913.729744863996;4927.679700819435;4927.802887884444;4970.950290497121;5516.972415137899;5766.5675074368755;5776.711164441761;5789.247397838254;5839.240898683144;1498.1610298233024;1507.6457032597332;1514.6364872430759;1514.788169464424;1520.103139147886;937.2267878999852;938.7420856052922;948.118250027481;955.4028732042474;959.9057074934581;4807.115730561705;4925.532074452921;4946.851594452172;4958.7024778513405;4980.729913872012;5073.720945347967;5137.741253392943;5142.357205349332;5146.665466744649;5161.716105614152;4550.259274032695;4817.626976311734;4830.227163653799;4922.655414120977;4923.310736496894;2751.5872619107295;2756.79324050697;2767.4326763013532;2774.9445011099665;2794.664640243184;5244.951009798056;5257.369115706139;5271.262023316662;5304.336957880265;5305.44292849253;5287.603429742785;5307.283516725192;5562.833115006556;6039.305479869871;6047.334793172836;6016.939830601726;6047.697615119315;6066.848328791815;6082.787102451482;6085.574009819358;5553.916691249554;5869.559783016205;5937.554683398676;5941.554383421174;5946.464818166386;5753.8561535961935;5791.681457519877;5808.6224395414165;5813.110739009754;5834.504067154339;5804.301000035004;5991.281046274475;6015.428534289235;6029.8191054268445;6078.756849726138;4049.817758200947;4182.874513764592;4187.790610469525;4188.267053265728;4194.790260487024;5785.103308987113;5785.479306862402;5811.4188581143235;5855.765769369348;5877.500412464989;5626.578006649435;5674.15147216546;5727.656340619576;5759.1649210865025;5768.307803063659;5611.372701916399;5654.46282603152;5679.9432005681065;5727.942720572908;5751.1883756616535;5578.553715702653;5586.190002449541;5605.271314729059;5619.297587801525;5650.491455769001;5407.405185429679;5686.317641883001;5697.4872261495;5714.714264286686;5763.135529670415;5549.528290095387;5578.903708441691;5613.635113717595;5615.6630602164005;5641.351244606759 16:34:06 INFO - PROCESS | 4462 | |5;yui.html;648.9091527186195;700.9404200642945;715.1882613233981;768.6541056524562;802.3701394405391;14513.782293265596;15903.20483975801;16202.594935126628;16349.34602615897;16889.324427022904;14977.925110374461;15013.324400401982;15087.396504139848;15118.546443606681;15137.31882065307;667.2226855713088;682.7200847652464;683.5386114372803;797.1112209885964;810.1574362662853;685.7874059041688;785.7996210966196;808.6199486241458;810.1007881251805;817.7301490508119;842.2756429470651;842.6797816829596;844.8183640517287;846.0355195077616;846.9280111190557;687.2714922182503;838.4717627894418;838.8532006898769;839.496302218667;840.7982084299755;591.3081694417542;606.1544145916466;606.939306069394;611.5505103748741;611.8715069835296;15236.771448428282;15322.846771532253;15345.539633811004;15349.693006139927;15358.155301458415;13914.165150090927;14562.563123106323;14568.708625827425;14657.853421465756;14845;12740.745185096339;12883.227006379553;12985.740285194337;13032.543860964915;13209.207447553177;4365.978170109161;4377.671674624416;4400.899775056236;4457.398251236074;4493.573110554492;74939;77139;78526;78551.99999999943;79349.20650793475;10879.945600272107;10967.341959482297;11184.888151118384;11311.886881131084;11787.528498859949;20486.487837804176;20790.792092079188;20841;20867.8956605216;20973.79026209749;8806.559672016501;8903.866442003375;9267.490288034223;9318.627254909863;9319.580618872167;4919.1883339248625;4973.776180071905;5011.6241281904;5044.747762611854;5187.403448603459;3402.6937575617817;3497.7026952709307;3508.456189290664;3513.806740629239;3525.7884526928465;618.4217756397783;620.92548894133;632.6994677528137;635.291649810458;650.1710319342876;716.6810769207652;726.3426598927979;741.3624283116516;742.962851857405;744.8659241336611;9347.738055362575;9351.532423378803;9505.809883802285;9550.713478595653;9581.808363832824;602.7558838670345;626.5770604841714;658.8945768676989;718.1633397092434;728.1298847876736;4424.247877860707;4484.344990843697;4508.323751437245;4510.526394728572;4556.544345565417;99134;103130.48434757779;103532.64673532586;110395.44802275937;115909;97802.51098744603;100980;101107;101416;101441.49279253556;86091.56954215314;87757.5612121948;89167.55416222877;89331;92879;9500.714978550379;9703.805923881624;9787.424257475088;9807.754806129904;9869.963653816247;50625;50799.746001269756;52160;52788;54163.45836541584;56390;73103.63448182937;74251.62874185595;74481;75851.62074189594;12927.935360323138;13120.737585248433;13405;13470.663233419244;13932.721345573234;14838.925805370904;15160.469383571522;15164.545063648107;15368.077915325117;15627.687446251239;13570.93214533921;13681.726365472834;14055.789163162764;14129.364178612193;14172;14720.705585888436;14910.105393676415;15040.323780614879;15040.548783536511;15082.773758393852;13038.674033149247;13390.330483475982;13392.93303533515;13691.178529288274;14414.207218603078;11170.832437513282;11334.659960201207;12154.149209555246;12254.509819607116;12619.558315458915;11184.328940263611;11729.476633108596;11765.11761617865;11840.70398240051;12026.458809353426 16:34:06 INFO - PROCESS | 4462 | __end_tp_report 16:34:06 INFO - PROCESS | 4462 | __start_cc_report 16:34:06 INFO - PROCESS | 4462 | _x_x_mozilla_cycle_collect,857 16:34:06 INFO - PROCESS | 4462 | __end_cc_report 16:34:06 INFO - PROCESS | 4462 | __startTimestamp1465860846870__endTimestamp 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | ------- Summary: start ------- 16:34:06 INFO - PROCESS | 4462 | Number of tests: 6 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | [#0] dojo.html Cycles:165 Average:5300.33 Median:5485.70 stddev:597.90 (10.9%) stddev-sans-first:574.14 16:34:06 INFO - PROCESS | 4462 | Values: 3094.1 3105.4 3122.3 3150.5 3164.5 5163.0 5182.8 5288.6 5395.2 5424.3 5265.7 5328.0 5335.1 5355.8 5402.4 4811.5 4854.5 4884.2 4903.0 5044.3 4947.8 4948.7 4981.0 5008.9 5012.9 4687.3 4756.1 4762.9 4795.2 4840.9 4827.8 4840.5 4843.6 4845.0 4889.7 4640.3 4801.7 4804.8 4821.8 4865.5 5242.2 5317.2 5325.1 5411.0 5413.8 5747.4 5785.8 5792.9 5794.8 5802.8 5602.3 5628.5 5720.1 5750.4 5750.8 5290.8 5379.4 5381.0 5382.7 5386.0 5841.5 5854.6 5886.4 5898.3 5899.4 5475.1 5627.3 5642.6 5646.4 5658.9 5717.9 5724.0 5730.7 5731.5 5734.7 5659.2 5668.2 5696.3 5700.8 5717.7 5517.6 5528.3 5595.1 5615.3 5715.0 4333.3 4349.5 4353.9 4354.7 4380.6 3878.2 3897.9 3903.1 3913.3 3934.4 5147.1 5195.4 5348.1 5359.5 5405.9 5753.2 5767.0 5770.7 5778.3 5808.8 5150.9 5407.3 5416.8 5421.6 5421.7 4926.0 4970.8 4994.7 5010.0 5015.3 5965.3 5967.2 5973.4 5980.6 5983.9 5473.1 5581.5 5806.2 5831.4 5832.4 5764.0 5775.7 5787.3 5840.7 5888.3 5533.2 5565.6 5571.0 5571.2 5581.0 5517.0 5671.4 5676.7 5679.6 5737.0 5588.3 5657.9 5681.1 5681.3 5733.3 5551.1 5586.6 5605.4 5608.6 5617.4 5248.5 5387.7 5439.2 5515.9 5528.4 5602.9 5638.2 5644.0 5647.2 5652.0 5437.0 5482.5 5485.7 5493.9 5531.6 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | [#1] ext.html Cycles:180 Average:55103.10 Median:35333.65 stddev:107578.08 (304.5%) stddev-sans-first:107801.98 16:34:06 INFO - PROCESS | 4462 | Values: 578.0 589.9 619.3 622.1 627.5 32243.4 41655.8 42441.4 42858.4 43067.4 44394.6 44902.8 44964.6 44971.6 44972.3 7965.7 8947.7 9032.4 9082.5 10610.1 10434.7 10740.4 10829.2 10873.5 10886.0 10777.9 10832.8 10839.8 10840.5 10843.2 10710.9 10796.2 10833.9 10869.3 10884.3 10802.3 10897.1 10897.8 10898.8 10899.8 42415.2 42674.6 42888.8 42889.8 42898.6 3667.2 3704.5 3726.5 3928.5 4201.2 32645.8 32862.8 32896.3 33406.0 33469.5 4262.1 4316.0 4351.5 4403.9 4410.7 321964.0 323712.0 323942.0 324540.0 325444.0 32959.3 33292.7 33531.2 56148.7 56856.0 37456.3 37468.3 37569.0 37812.8 37939.2 15255.8 15416.0 15433.2 15435.7 15449.7 12219.8 12400.7 12774.3 12848.9 13383.3 8977.8 8988.9 8998.8 9036.5 9068.8 3196.6 3398.2 3466.7 3486.5 3511.1 983.6 1076.2 1120.7 1147.4 1205.0 31689.8 32299.9 32720.5 32902.7 33028.0 1108.4 1190.8 1194.7 1210.4 1251.6 16866.6 17311.8 17384.7 17387.7 17477.3 547316.0 555340.0 557719.0 558271.0 560041.0 57913.0 58947.1 59240.1 59341.4 59460.7 1246.9 1341.2 1383.1 1400.4 1410.9 31477.8 33387.8 33461.3 33608.2 34013.8 48884.0 49393.3 49490.0 49495.5 49535.5 275909.0 280428.0 281157.0 281339.0 281619.0 25898.5 28212.9 28790.0 28813.9 31015.7 48715.8 49232.0 49619.8 49796.0 50087.7 40917.0 41159.4 41269.0 42020.6 42570.6 41183.8 41711.1 41838.8 41929.6 42289.0 41076.0 41420.2 44968.6 45858.3 46118.0 41082.8 45777.5 46222.5 46491.0 46963.3 34494.0 35315.6 35351.6 35639.0 35641.0 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | [#2] jquery.html Cycles:180 Average:27107.26 Median:40838.78 stddev:71001.85 (173.9%) stddev-sans-first:71172.74 16:34:06 INFO - PROCESS | 4462 | Values: 414.4 415.9 420.9 422.0 438.1 18189.5 19524.9 20002.8 20067.6 20170.3 18882.0 18893.6 20140.2 20154.9 20166.3 5032.4 5330.0 5341.9 5399.2 5402.5 5272.3 5311.3 5375.1 5376.1 5380.8 5221.5 5270.9 5285.9 5403.4 5405.8 5365.0 5378.3 5384.6 5395.9 5607.1 5740.9 5805.7 5815.3 5834.8 5848.3 14114.7 14129.9 14331.4 14494.9 15165.5 2128.3 2226.0 2279.6 2307.5 2423.4 10035.1 10442.3 10568.6 11054.8 11057.1 1732.7 1806.4 1866.0 1933.8 1973.2 79378.6 85784.6 86868.6 87099.6 87608.6 10637.9 10736.5 11390.4 11536.5 11921.8 14627.0 15240.3 15343.2 15907.0 16015.0 8285.5 8351.6 8354.0 8447.5 8542.7 8230.0 8235.7 8292.5 8439.9 8529.0 4840.4 4960.8 4996.2 5060.3 5062.8 1860.8 1925.1 1940.0 1974.1 2001.8 934.2 936.9 950.5 1027.3 1090.4 19758.5 19992.4 19998.6 20078.0 20164.0 973.6 983.9 990.3 998.2 1042.9 10781.0 11493.3 11505.7 11510.9 11517.5 421406.0 427856.0 428081.0 430371.0 436064.0 67798.0 82702.0 84227.0 94719.0 96473.5 968.2 974.9 991.9 999.4 1002.6 17723.8 18057.2 18160.2 18236.0 18652.6 40219.4 40689.4 40988.2 41006.2 42081.0 53949.0 55695.2 55917.4 57203.0 57779.7 9055.2 9075.0 9076.8 9176.1 9291.7 11270.6 13280.7 13434.6 14019.3 14067.9 11964.2 12139.2 12215.9 12255.8 12288.4 11669.7 12049.6 12103.2 12229.1 12377.4 12268.3 12329.6 12458.8 12463.0 12545.8 8893.3 9043.3 9321.7 9376.5 9444.4 12142.7 12238.9 12288.9 12383.1 12562.4 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | [#3] mootools.html Cycles:180 Average:5787.37 Median:2612.80 stddev:3396.81 (130.0%) stddev-sans-first:3389.32 16:34:06 INFO - PROCESS | 4462 | Values: 1263.2 1424.9 1464.0 1601.2 1761.5 8473.7 8834.3 8846.0 9000.4 9106.8 8794.3 8980.1 9004.5 9011.0 9012.2 2092.8 2148.7 2148.7 2423.4 2455.2 2118.4 2331.0 2400.8 2401.4 2407.9 2334.2 2345.5 2352.2 2354.1 2358.5 2016.4 2285.2 2290.3 2291.6 2292.9 2311.7 2369.1 2370.2 2390.9 2393.7 8981.2 9011.2 9035.9 9037.2 9043.5 5263.8 5418.1 5421.1 5431.0 5434.4 3444.9 3495.3 3576.7 3580.5 3606.3 1157.3 1176.6 1182.0 1189.7 1195.2 12750.3 12781.6 12792.4 12795.7 12796.5 4640.7 4645.6 4726.7 4749.2 4750.6 10486.0 10560.5 10636.8 10638.2 10641.8 5360.1 5362.7 5364.5 5416.7 5422.6 4726.0 4871.4 4896.9 4948.8 4967.3 3907.7 3946.5 3966.7 3991.4 4040.5 1207.4 1215.5 1220.0 1228.4 1244.1 791.9 872.1 890.1 913.7 914.1 5476.1 5697.9 5740.1 5757.5 5936.9 462.5 463.5 465.4 471.7 475.0 3624.3 3713.3 3736.0 3759.0 3777.5 10991.5 11448.7 11456.6 11534.5 11563.2 11047.8 11078.4 11162.0 11164.2 11171.0 7518.4 7669.7 7678.3 8503.1 8625.9 5440.8 5600.4 5621.5 5748.3 5766.6 9803.1 9957.4 9984.3 10279.9 10292.2 9316.3 10223.5 10397.5 10423.1 10460.3 7420.5 7613.2 7629.4 7827.5 7828.0 8451.3 8491.4 8493.1 8611.4 8732.3 7749.4 7795.2 7835.6 7887.4 7889.6 7248.3 7281.8 7320.1 7327.0 7402.7 6332.0 6385.0 6461.1 6575.9 6576.0 4861.9 4893.4 4917.5 4929.0 4982.3 4826.7 4847.0 4901.2 4909.3 4983.8 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | [#4] prototype.html Cycles:180 Average:4731.31 Median:5264.32 stddev:1377.00 (26.2%) stddev-sans-first:1340.65 16:34:06 INFO - PROCESS | 4462 | Values: 330.3 340.3 346.3 346.3 348.8 5288.3 5400.9 5459.2 5467.8 5499.0 5358.6 5401.4 5407.8 5437.6 5469.7 4238.9 4259.5 4271.5 4272.2 4310.6 4165.5 4284.2 4299.9 4319.4 4332.5 4221.9 4222.1 4247.6 4287.0 4301.7 4218.8 4226.3 4238.8 4259.2 4272.6 3734.4 3784.6 3798.9 3833.9 3835.5 5222.2 5236.4 5237.3 5255.3 5310.4 4861.4 4885.7 4932.7 4958.1 4959.1 5556.5 5686.5 5695.0 5704.1 5706.6 4195.2 4229.8 4245.9 4259.7 4266.7 5897.9 5951.2 5956.4 5962.1 6002.5 4113.3 4294.3 4314.7 4336.6 4364.4 4336.4 4342.6 4361.5 4368.4 4394.4 4894.3 4913.7 4927.7 4927.8 4971.0 5517.0 5766.6 5776.7 5789.2 5839.2 1498.2 1507.6 1514.6 1514.8 1520.1 937.2 938.7 948.1 955.4 959.9 4807.1 4925.5 4946.9 4958.7 4980.7 5073.7 5137.7 5142.4 5146.7 5161.7 4550.3 4817.6 4830.2 4922.7 4923.3 2751.6 2756.8 2767.4 2774.9 2794.7 5245.0 5257.4 5271.3 5304.3 5305.4 5287.6 5307.3 5562.8 6039.3 6047.3 6016.9 6047.7 6066.8 6082.8 6085.6 5553.9 5869.6 5937.6 5941.6 5946.5 5753.9 5791.7 5808.6 5813.1 5834.5 5804.3 5991.3 6015.4 6029.8 6078.8 4049.8 4182.9 4187.8 4188.3 4194.8 5785.1 5785.5 5811.4 5855.8 5877.5 5626.6 5674.2 5727.7 5759.2 5768.3 5611.4 5654.5 5679.9 5727.9 5751.2 5578.6 5586.2 5605.3 5619.3 5650.5 5407.4 5686.3 5697.5 5714.7 5763.1 5549.5 5578.9 5613.6 5615.7 5641.4 16:34:06 INFO - PROCESS | 4462 | 16:34:06 INFO - PROCESS | 4462 | [#5] yui.html Cycles:180 Average:20818.62 Median:4509.43 stddev:29391.33 (651.8%) stddev-sans-first:29434.76 16:34:06 INFO - PROCESS | 4462 | Values: 648.9 700.9 715.2 768.7 802.4 14513.8 15903.2 16202.6 16349.3 16889.3 14977.9 15013.3 15087.4 15118.5 15137.3 667.2 682.7 683.5 797.1 810.2 685.8 785.8 808.6 810.1 817.7 842.3 842.7 844.8 846.0 846.9 687.3 838.5 838.9 839.5 840.8 591.3 606.2 606.9 611.6 611.9 15236.8 15322.8 15345.5 15349.7 15358.2 13914.2 14562.6 14568.7 14657.9 14845.0 12740.7 12883.2 12985.7 13032.5 13209.2 4366.0 4377.7 4400.9 4457.4 4493.6 74939.0 77139.0 78526.0 78552.0 79349.2 10879.9 10967.3 11184.9 11311.9 11787.5 20486.5 20790.8 20841.0 20867.9 20973.8 8806.6 8903.9 9267.5 9318.6 9319.6 4919.2 4973.8 5011.6 5044.7 5187.4 3402.7 3497.7 3508.5 3513.8 3525.8 618.4 620.9 632.7 635.3 650.2 716.7 726.3 741.4 743.0 744.9 9347.7 9351.5 9505.8 9550.7 9581.8 602.8 626.6 658.9 718.2 728.1 4424.2 4484.3 4508.3 4510.5 4556.5 99134.0 103130.5 103532.6 110395.4 115909.0 97802.5 100980.0 101107.0 101416.0 101441.5 86091.6 87757.6 89167.6 89331.0 92879.0 9500.7 9703.8 9787.4 9807.8 9870.0 50625.0 50799.7 52160.0 52788.0 54163.5 56390.0 73103.6 74251.6 74481.0 75851.6 12927.9 13120.7 13405.0 13470.7 13932.7 14838.9 15160.5 15164.5 15368.1 15627.7 13570.9 13681.7 14055.8 14129.4 14172.0 14720.7 14910.1 15040.3 15040.5 15082.8 13038.7 13390.3 13392.9 13691.2 14414.2 11170.8 11334.7 12154.1 12254.5 12619.6 11184.3 11729.5 11765.1 11840.7 12026.5 16:34:06 INFO - PROCESS | 4462 | -------- Summary: end -------- 16:34:06 INFO - PROCESS | 4462 | 16:34:07 INFO - TEST-INFO | 4462: exit 0 16:34:07 INFO - TEST-OK | dromaeo_css | took 1113257ms 16:34:07 INFO - TEST-START | kraken 16:34:07 INFO - operating with platform_type : linux_ 16:34:07 INFO - Initialising browser for kraken test... 16:34:07 INFO - TEST-INFO | started process 4646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwCXH2B/profile http://localhost:49111/getInfo.html) 16:34:11 INFO - PROCESS | 4646 | __metrics Screen width/height:1600/1200 16:34:11 INFO - PROCESS | 4646 | colorDepth:24 16:34:11 INFO - PROCESS | 4646 | Browser inner width/height: 1024/697 16:34:11 INFO - PROCESS | 4646 | __metrics 16:34:13 INFO - PROCESS | 4646 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:34:13 INFO - PROCESS | 4646 | console.error: PushService: 16:34:13 INFO - PROCESS | 4646 | stateChangeProcessEnqueue: Error transitioning state 16:34:13 INFO - PROCESS | 4646 | UnknownError 16:34:13 INFO - TEST-INFO | 4646: exit 0 16:34:13 INFO - Browser initialized. 16:34:13 INFO - Running cycle 1/1 for kraken test... 16:34:13 INFO - TEST-INFO | started process 4729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwCXH2B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:25 INFO - PROCESS | 4729 | RSS: Main: 173604864 16:34:25 INFO - PROCESS | 4729 | 16:34:28 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-beat-detection) 16:34:29 INFO - PROCESS | 4729 | RSS: Main: 232976384 16:34:29 INFO - PROCESS | 4729 | 16:34:31 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-dft) 16:34:32 INFO - PROCESS | 4729 | RSS: Main: 220717056 16:34:32 INFO - PROCESS | 4729 | 16:34:35 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-fft) 16:34:36 INFO - PROCESS | 4729 | RSS: Main: 286269440 16:34:36 INFO - PROCESS | 4729 | 16:34:38 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49111/tests/kraken/driver.html?testName=audio-oscillator) 16:34:39 INFO - PROCESS | 4729 | RSS: Main: 197922816 16:34:39 INFO - PROCESS | 4729 | 16:34:41 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49111/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:34:41 INFO - PROCESS | 4729 | RSS: Main: 201654272 16:34:41 INFO - PROCESS | 4729 | 16:34:44 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49111/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:45 INFO - PROCESS | 4729 | RSS: Main: 238141440 16:34:45 INFO - PROCESS | 4729 | 16:34:48 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49111/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:49 INFO - PROCESS | 4729 | RSS: Main: 238280704 16:34:49 INFO - PROCESS | 4729 | 16:34:52 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49111/tests/kraken/driver.html?testName=json-parse-financial) 16:34:52 INFO - PROCESS | 4729 | RSS: Main: 238399488 16:34:52 INFO - PROCESS | 4729 | 16:34:54 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49111/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:54 INFO - PROCESS | 4729 | RSS: Main: 226930688 16:34:54 INFO - PROCESS | 4729 | 16:34:56 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:57 INFO - PROCESS | 4729 | RSS: Main: 228847616 16:34:57 INFO - PROCESS | 4729 | 16:34:59 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:35:00 INFO - PROCESS | 4729 | RSS: Main: 236879872 16:35:00 INFO - PROCESS | 4729 | 16:35:02 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:35:03 INFO - PROCESS | 4729 | RSS: Main: 237658112 16:35:03 INFO - PROCESS | 4729 | 16:35:05 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:35:06 INFO - PROCESS | 4729 | RSS: Main: 235831296 16:35:06 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | Cycle 1(1): loaded http://localhost:49111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49111/tests/kraken/driver.html?testName=ai-astar) 16:35:08 INFO - PROCESS | 4729 | RSS: Main: 279388160 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | __start_tp_report 16:35:08 INFO - PROCESS | 4729 | _x_x_mozilla_page_load 16:35:08 INFO - PROCESS | 4729 | _x_x_mozilla_page_load_details 16:35:08 INFO - PROCESS | 4729 | |i|pagename|runs| 16:35:08 INFO - PROCESS | 4729 | |0;ai-astar;109;105;109;109;111;112;108;109;110;108 16:35:08 INFO - PROCESS | 4729 | |1;audio-beat-detection;159;124;128;171;125;126;152;128;201;124 16:35:08 INFO - PROCESS | 4729 | |2;audio-dft;160;162;160;162;163;164;163;163;161;160 16:35:08 INFO - PROCESS | 4729 | |3;audio-fft;74;75;75;130;76;76;73;74;111;76 16:35:08 INFO - PROCESS | 4729 | |4;audio-oscillator;86;86;107;84;85;86;112;84;84;125 16:35:08 INFO - PROCESS | 4729 | |5;imaging-gaussian-blur;118;118;117;116;117;116;116;117;117;117 16:35:08 INFO - PROCESS | 4729 | |6;imaging-darkroom;146;145;146;147;147;146;146;145;146;146 16:35:08 INFO - PROCESS | 4729 | |7;imaging-desaturate;95;94;94;95;95;95;95;95;95;94 16:35:08 INFO - PROCESS | 4729 | |8;json-parse-financial;54;55;53;53;55;54;53;53;54;53 16:35:08 INFO - PROCESS | 4729 | |9;json-stringify-tinderbox;60;61;70;60;60;61;60;61;61;61 16:35:08 INFO - PROCESS | 4729 | |10;stanford-crypto-aes;80;79;80;80;81;82;80;81;115;86 16:35:08 INFO - PROCESS | 4729 | |11;stanford-crypto-ccm;123;127;141;123;123;120;118;118;162;120 16:35:08 INFO - PROCESS | 4729 | |12;stanford-crypto-pbkdf2;163;162;163;162;165;158;159;161;160;157 16:35:08 INFO - PROCESS | 4729 | |13;stanford-crypto-sha256-iterative;66;63;63;63;64;64;63;63;63;62 16:35:08 INFO - PROCESS | 4729 | __end_tp_report 16:35:08 INFO - PROCESS | 4729 | __start_cc_report 16:35:08 INFO - PROCESS | 4729 | _x_x_mozilla_cycle_collect,1606 16:35:08 INFO - PROCESS | 4729 | __end_cc_report 16:35:08 INFO - PROCESS | 4729 | __startTimestamp1465860908439__endTimestamp 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | ------- Summary: start ------- 16:35:08 INFO - PROCESS | 4729 | Number of tests: 14 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:1.89 (1.7%) stddev-sans-first:2.00 16:35:08 INFO - PROCESS | 4729 | Values: 109.0 105.0 109.0 109.0 111.0 112.0 108.0 109.0 110.0 108.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:140.00 stddev:26.38 (18.8%) stddev-sans-first:27.40 16:35:08 INFO - PROCESS | 4729 | Values: 159.0 124.0 128.0 171.0 125.0 126.0 152.0 128.0 201.0 124.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.48 (0.9%) stddev-sans-first:1.41 16:35:08 INFO - PROCESS | 4729 | Values: 160.0 162.0 160.0 162.0 163.0 164.0 163.0 163.0 161.0 160.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#3] audio-fft Cycles:10 Average:84.00 Median:75.00 stddev:19.78 (26.4%) stddev-sans-first:20.64 16:35:08 INFO - PROCESS | 4729 | Values: 74.0 75.0 75.0 130.0 76.0 76.0 73.0 74.0 111.0 76.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.50 stddev:15.01 (17.8%) stddev-sans-first:15.64 16:35:08 INFO - PROCESS | 4729 | Values: 86.0 86.0 107.0 84.0 85.0 86.0 112.0 84.0 84.0 125.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 16:35:08 INFO - PROCESS | 4729 | Values: 118.0 118.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:35:08 INFO - PROCESS | 4729 | Values: 146.0 145.0 146.0 147.0 147.0 146.0 146.0 145.0 146.0 146.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:35:08 INFO - PROCESS | 4729 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 16:35:08 INFO - PROCESS | 4729 | Values: 54.0 55.0 53.0 53.0 55.0 54.0 53.0 53.0 54.0 53.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:3.03 (5.0%) stddev-sans-first:3.16 16:35:08 INFO - PROCESS | 4729 | Values: 60.0 61.0 70.0 60.0 60.0 61.0 60.0 61.0 61.0 61.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:80.50 stddev:10.93 (13.6%) stddev-sans-first:11.47 16:35:08 INFO - PROCESS | 4729 | Values: 80.0 79.0 80.0 80.0 81.0 82.0 80.0 81.0 115.0 86.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:123.00 stddev:13.85 (11.3%) stddev-sans-first:14.59 16:35:08 INFO - PROCESS | 4729 | Values: 123.0 127.0 141.0 123.0 123.0 120.0 118.0 118.0 162.0 120.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:162.00 stddev:2.49 (1.5%) stddev-sans-first:2.54 16:35:08 INFO - PROCESS | 4729 | Values: 163.0 162.0 163.0 162.0 165.0 158.0 159.0 161.0 160.0 157.0 16:35:08 INFO - PROCESS | 4729 | 16:35:08 INFO - PROCESS | 4729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.07 (1.7%) stddev-sans-first:0.60 16:35:08 INFO - PROCESS | 4729 | Values: 66.0 63.0 63.0 63.0 64.0 64.0 63.0 63.0 63.0 62.0 16:35:08 INFO - PROCESS | 4729 | -------- Summary: end -------- 16:35:08 INFO - PROCESS | 4729 | 16:35:09 INFO - TEST-INFO | 4729: exit 0 16:35:09 INFO - TEST-OK | kraken | took 61798ms 16:35:09 INFO - SUITE-END | took 1175s 16:35:09 INFO - Completed test suite (00:19:35) 16:35:09 INFO - javascript benchmark 16:35:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.149108995026, 3105.394448082625, 3122.281875168711, 3150.527420886868, 3164.4620414529527, 5163.019026384994, 5182.792688292464, 5288.576913846892, 5395.190721391788, 5424.294841670578, 5265.684058956465, 5327.973360133194, 5335.0663633864015, 5355.7857685692625, 5402.405735369106, 4811.494793046723, 4854.514548545152, 4884.242942343943, 4903.0, 5044.319016932722, 4947.752612369385, 4948.653594248404, 4980.97509512452, 5008.9499105008845, 5012.924806127911, 4687.2969054641735, 4756.143894099061, 4762.904741905159, 4795.160846851822, 4840.854774356775, 4827.831025914112, 4840.467548569654, 4843.56407923285, 4844.951550484485, 4889.657723959324, 4640.303954406832, 4801.687890287155, 4804.8318308859025, 4821.831235906727, 4865.464798872121, 5242.213667949838, 5317.175837745156, 5325.068113080196, 5411.026015317241, 5413.783448662049, 5747.425257474261, 5785.797497087582, 5792.855178620526, 5794.82615521535, 5802.767889284466, 5602.299712535933, 5628.549716022709, 5720.11338242573, 5750.424957504216, 5750.769969201227, 5290.81482148123, 5379.354477462691, 5380.973095134499, 5382.730863456851, 5385.999999999961, 5841.532677385799, 5854.648721076749, 5886.352501224862, 5898.321693005273, 5899.351071382144, 5475.06923822951, 5627.296587926509, 5642.576806739511, 5646.378898321182, 5658.943410565924, 5717.942820571824, 5724.0, 5730.656160630292, 5731.512821410143, 5734.741936612862, 5659.207710920475, 5668.234788303609, 5696.316442026983, 5700.828975130753, 5717.742701578439, 5517.613767036269, 5528.308961379827, 5595.104783234663, 5615.298087739033, 5715.0, 4333.263345231318, 4349.543297953733, 4353.934690979638, 4354.673399495051, 4380.5838445347645, 3878.1855810279594, 3897.922041559153, 3903.1022864741267, 3913.2760439318818, 3934.449177115206, 5147.0992576298995, 5195.428502864682, 5348.064088784525, 5359.544438722674, 5405.864853378697, 5753.194552762617, 5766.971165144148, 5770.711464426762, 5778.3354914184565, 5808.796692115756, 5150.896982060338, 5407.324084489439, 5416.837494875082, 5421.647592906448, 5421.728913554307, 4926.0, 4970.751462426864, 4994.725290109006, 5010.0, 5015.348004759431, 5965.34381218057, 5967.19442875215, 5973.402659734079, 5980.611260268156, 5983.9401605983385, 5473.124300111963, 5581.5255703265675, 5806.158107074366, 5831.446012628793, 5832.387599302182, 5764.0, 5775.653460792366, 5787.276590426197, 5840.678762668094, 5888.263967004124, 5533.2253484513, 5565.582581306499, 5571.0, 5571.164325351229, 5580.967521008626, 5517.0, 5671.376148623731, 5676.7161641918565, 5679.630823996427, 5737.0, 5588.30146231721, 5657.868426314836, 5681.0910254359105, 5681.261436013292, 5733.254676891977, 5551.056320425618, 5586.581006424453, 5605.355384130877, 5608.579356548356, 5617.354004289559, 5248.527632513092, 5387.703676297684, 5439.184122381675, 5515.917261241165, 5528.419515950767, 5602.85992850182, 5638.23883775685, 5644.0, 5647.237622920853, 5652.039153344023, 5437.048516509674, 5482.479164479368, 5485.6982865942755, 5493.890122197614, 5531.612787104864], "value": 5260.599460296236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.9942200577993, 589.9321578018528, 619.2568917299236, 622.0824284180833, 627.5105417774134, 32243.35513289736, 41655.79172104139, 42441.36337954933, 42858.35712464315, 43067.35398969018, 44394.55605443945, 44902.775486122526, 44964.550354496445, 44971.55028449723, 44972.3254151188, 7965.72119975801, 8947.686830960902, 9032.412893161923, 9082.500462474562, 10610.098141657969, 10434.68695939123, 10740.409277489734, 10829.187810914174, 10873.510692018877, 10886.0, 10777.868323826004, 10832.837507437394, 10839.83740243897, 10840.512176952017, 10843.186760992918, 10710.892891071067, 10796.190285728524, 10833.945830270877, 10869.347839129598, 10884.346939183675, 10802.297850639683, 10897.073748731367, 10897.83653245202, 10898.836517452244, 10899.83650245247, 42415.15169696589, 42674.57325426737, 42888.78555607233, 42889.78555107205, 42898.57101428977, 3667.174885650734, 3704.518412606344, 3726.5155529781227, 3928.4500169976227, 4201.222773786859, 32645.836770815993, 32862.83568582142, 32896.342073158405, 33406.0, 33469.49795753066, 4262.083652014831, 4315.956840431619, 4351.49957754859, 4403.889902752425, 4410.691251612388, 321964.0, 323712.0, 323942.0, 324540.0, 325444.0, 32959.340813184084, 33292.66707332944, 33531.16172095717, 56148.719256403456, 56856.0, 37456.25087498235, 37468.25063498715, 37569.0, 37812.810935945694, 37939.24121517554, 15255.771163432557, 15416.0, 15433.228338583025, 15435.691286174213, 15449.691006179813, 12219.755604887852, 12400.689982750504, 12774.297413642153, 12848.935755321163, 13383.330833458289, 8977.775555611162, 8988.910110898938, 8998.820023599492, 9036.502992335485, 9068.773280668036, 3196.5844440222622, 3398.2290360783345, 3466.6533346665133, 3486.529318542015, 3511.0871173495075, 983.6163896080534, 1076.208986394999, 1120.6918097523082, 1147.4205526209378, 1204.951801927913, 31689.84155079256, 32299.86302602498, 32720.509192362133, 32902.67097329044, 33028.0, 1108.3959242213014, 1190.8213767934706, 1194.7311854832767, 1210.3585099897068, 1251.6495381293253, 16866.578335541708, 17311.826881731275, 17384.65230695379, 17387.65224695499, 17477.300907963792, 547316.0, 555340.0, 557719.0, 558271.0, 560041.0, 57913.0, 58947.11579326313, 59240.111398329056, 59341.40658593359, 59460.702696487104, 1246.8628450870397, 1341.2354957674227, 1383.0940733819364, 1400.355836315286, 1410.8589141086015, 31477.8426107868, 33387.83306083454, 33461.330773384885, 33608.1597960053, 34013.82993085118, 48884.0, 49393.25910111423, 49490.0, 49495.50504495053, 49535.50464495453, 275909.0, 280428.0, 281157.0, 281339.0, 281619.0, 25898.482030359664, 28212.85893570519, 28790.0, 28813.855930720212, 31015.68984310128, 48715.756421219085, 49232.0, 49619.75190124026, 49796.0, 50087.74956125196, 40917.0, 41159.38260926148, 41269.0, 42020.579794201665, 42570.5742942579, 41183.7940810294, 41711.10250528733, 41838.79080604578, 41929.580704192565, 42289.0, 41076.0, 41420.1715965673, 44968.55031449644, 45858.31212531748, 46118.0, 41082.79458602688, 45777.54222457733, 46222.53777462182, 46491.048260898206, 46963.29555056609, 34494.0, 35315.646843531234, 35351.64648353484, 35639.0, 35641.0], "value": 19480.618553880864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.4342971843434, 415.920975014747, 420.9431726716894, 421.96202341789234, 438.0931471853263, 18189.454316370513, 19524.90237548814, 20002.799972000277, 20067.59864802703, 20170.294039708613, 18882.0, 18893.622127557475, 20140.194392224294, 20154.89922550389, 20166.294179703713, 5032.370953630787, 5329.973350133244, 5341.919871201935, 5399.19012148177, 5402.459754024586, 5272.288241087443, 5311.256424100629, 5375.11310633745, 5376.059189641797, 5380.811671591495, 5221.503957124067, 5270.894582108374, 5285.86785330366, 5403.405625381224, 5405.837824865261, 5365.0, 5378.327709036371, 5384.596155288349, 5395.865103372408, 5607.102863541854, 5740.942590574083, 5805.7387417566315, 5815.331236907768, 5834.824955251307, 5848.327442344143, 14114.717705645933, 14129.858701412957, 14331.42674293027, 14494.855051449562, 15165.545033649008, 2128.265748316828, 2225.9666105008437, 2279.566882292376, 2307.457747429353, 2423.418379588886, 10035.147012503947, 10442.321249118782, 10568.577256909715, 11054.778904421946, 11057.06014988727, 1732.6534693061312, 1806.4490330449207, 1866.001689096327, 1933.7582802149732, 1973.190991693399, 79378.60310698468, 85784.57107714421, 86868.56565717194, 87099.56450217772, 87608.56195719044, 10637.946810266054, 10736.463176841127, 11390.37352945596, 11536.480858361394, 11921.821172682417, 14627.049241799248, 15240.314185861664, 15343.156126413154, 15907.0, 16015.039097654178, 8285.461445006054, 8351.624176912053, 8353.95823020881, 8447.493150410995, 8542.701005464778, 8229.95885020571, 8235.682290833558, 8292.460990035628, 8439.873401898976, 8529.019162796234, 4840.370751802243, 4960.801567937242, 4996.200607902718, 5060.2662613920775, 5062.772175252123, 1860.8046155153784, 1925.0952052535285, 1939.990300048519, 1974.1079318797742, 2001.7597888253504, 934.1685899549407, 936.8969413364524, 950.4629884115452, 1027.337367398024, 1090.4093765248235, 19758.506037348892, 19992.400227993185, 19998.600027999357, 20078.0, 20164.0, 973.6202880876464, 983.9409635421755, 990.2770977186694, 998.1964518562627, 1042.890496497872, 10781.0, 11493.252938558968, 11505.654830355103, 11510.942445287887, 11517.48171332292, 421406.0, 427856.0, 428081.0, 430371.0, 436064.0, 67798.0, 82702.0, 84227.0, 94719.0, 96473.51763241139, 968.2157452463528, 974.8927617962019, 991.8710567626163, 999.4253304350028, 1002.5638847101388, 17723.82276177222, 18057.1874265661, 18160.18279177414, 18236.0, 18652.626947461245, 40219.3967090488, 40689.38965915573, 40988.18023639451, 41006.1798764029, 42081.0, 53949.0, 55695.16457253064, 55917.44082559285, 57203.0, 57779.71110144423, 9055.230305424113, 9074.954625226832, 9076.818463630823, 9176.128267814547, 9291.67479138227, 11270.605528806453, 13280.667983300495, 13434.596962091153, 14019.299035048003, 14067.929660351632, 11964.222325548812, 12139.150259481752, 12215.877841221474, 12255.816162757745, 12288.385580721108, 11669.708257293636, 12049.638510844688, 12103.213291136048, 12229.143959923076, 12377.381130943597, 12268.263904165779, 12329.630111096682, 12458.75082498363, 12463.0, 12545.811812822998, 8893.333000025154, 9043.276537876822, 9321.72034838956, 9376.48429336393, 9444.433333999981, 12142.696432589257, 12238.938805305916, 12288.877111228774, 12383.133180677627, 12562.371881406076], "value": 9161.700434569393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.1852455166425, 1424.9216293103877, 1464.0117920403727, 1601.247413715554, 1761.5067781021319, 8473.661053557858, 8834.337424693149, 8846.02693703692, 9000.414973026749, 9106.77233069172, 8794.252488538466, 8980.101989801033, 9004.549772511382, 9010.954945225265, 9012.188902998729, 2092.7697953225133, 2148.720666313377, 2148.7421509418814, 2423.3941514621347, 2455.2143314139485, 2118.4174352053233, 2330.976690233093, 2400.7839294463497, 2401.3756423329887, 2407.8555286682767, 2334.2180369576213, 2345.495718420539, 2352.2120089769946, 2354.105439932823, 2358.492924021335, 2016.3547664747286, 2285.1887579909057, 2290.335802617239, 2291.5875142474347, 2292.8853557322236, 2311.653252012195, 2369.0523790483944, 2370.2178281167344, 2390.9163179288817, 2393.676853624756, 8981.236594889377, 9011.188992990663, 9035.864462033074, 9037.186653201243, 9043.547822608909, 5263.815766448156, 5418.078926582491, 5421.051316019681, 5431.0, 5434.402215756264, 3444.9311013779584, 3495.3009398120225, 3576.7317451191007, 3580.534530511043, 3606.2607165531003, 1157.282484859384, 1176.5705517486142, 1181.9645410637695, 1189.6906804230875, 1195.229077245172, 12750.29873356965, 12781.61655150347, 12792.424340904681, 12795.680107997281, 12796.48814047437, 4640.69835460694, 4645.558671926162, 4726.669133160714, 4749.216379297377, 4750.572448479654, 10486.0, 10560.47197640115, 10636.840447393295, 10638.202134839918, 10641.840372394265, 5360.088784906575, 5362.651427657268, 5364.490373414519, 5416.729163541807, 5422.593305502103, 4725.976370118127, 4871.3667223260745, 4896.926546101811, 4948.802047918115, 4967.254911763264, 3907.6873850091924, 3946.4869566956113, 3966.7421617594764, 3991.4212439196735, 4040.5151381834366, 1207.390267914715, 1215.5198696515004, 1219.9634010979685, 1228.3919459867245, 1244.1291096232674, 791.928726414614, 872.1017352127319, 890.105444028747, 913.7076135636665, 914.0996118823087, 5476.096444086681, 5697.914531282034, 5740.1102829061565, 5757.510611598061, 5936.8812623748145, 462.53746253746255, 463.5202565344919, 465.3926625753357, 471.73347058911605, 475.02619629758857, 3624.2932628137787, 3713.294474049922, 3735.9626403736156, 3759.0, 3777.546694396635, 10991.505382257817, 11448.656540303804, 11456.599019034295, 11534.538618455168, 11563.190576659721, 11047.83428248577, 11078.446077696082, 11162.0, 11164.218504704755, 11171.0, 7518.436117291225, 7669.7315593953945, 7678.270564296383, 8503.149685031447, 8625.913740862636, 5440.7551660174595, 5600.411956744483, 5621.471605628421, 5748.310202775694, 5766.596338256281, 9803.117719405287, 9957.402555846673, 9984.301098923006, 10279.897201027894, 10292.176625870063, 9316.301277404085, 10223.539940702538, 10397.480125993821, 10423.114035307084, 10460.26778125524, 7420.480566360303, 7613.162552119373, 7629.38964882797, 7827.47364263963, 7827.982362292865, 8451.281641060334, 8491.405601607828, 8493.065762765968, 8611.354148439017, 8732.301415886586, 7749.41879359039, 7795.181505941794, 7835.647395867314, 7887.44787864844, 7889.605519724106, 7248.347648711641, 7281.7815465533995, 7320.121585409572, 7327.0, 7402.740904068547, 6332.0, 6384.968075159594, 6461.063145843732, 6575.868482630416, 6576.013597960345, 4861.927071093865, 4893.363862697826, 4917.508249175054, 4928.950710492849, 4982.327385803015, 4826.686265392738, 4846.951530484791, 4901.240307752304, 4909.3126962224605, 4983.775730092082], "value": 4520.282235303382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.2900636917556, 340.32955078495365, 346.27628256943, 346.3281234405253, 348.8029263466143, 5288.312519372476, 5400.891982160354, 5459.153831156173, 5467.835964921053, 5499.0, 5358.579976306282, 5401.352587460823, 5407.783688652459, 5437.613408580806, 5469.72651367432, 4238.894027649302, 4259.488861336628, 4271.508776490697, 4272.230998420283, 4310.633596144332, 4165.500139983191, 4284.186004659105, 4299.892502687442, 4319.438472998506, 4332.501762297345, 4221.873343799691, 4222.134462435193, 4247.5964783345535, 4286.978565107186, 4301.677374196932, 4218.831246750126, 4226.260404429213, 4238.788060596958, 4259.169461954935, 4272.594103560157, 3734.3651579231596, 3784.5836957934607, 3798.8670396536263, 3833.9073364091378, 3835.5013848199555, 5222.216667499867, 5236.397814251333, 5237.271700338917, 5255.318298144595, 5310.36275646921, 4861.440934292531, 4885.682430642032, 4932.679375840559, 4958.082754690394, 4959.132151873408, 5556.499915007668, 5686.521504408842, 5694.971525142348, 5704.146152500454, 5706.629069110494, 4195.223883581547, 4229.809658565372, 4245.893852653709, 4259.659227261812, 4266.6586673066395, 5897.8820423591715, 5951.196588460546, 5956.37458066901, 5962.075878238837, 6002.519798416116, 4113.280175969194, 4294.312909934395, 4314.676399270067, 4336.566343365701, 4364.432623758955, 4336.4145840311785, 4342.609165175086, 4361.5170841913905, 4368.410264614236, 4394.384786129945, 4894.314795928502, 4913.729744863996, 4927.679700819435, 4927.802887884444, 4970.950290497121, 5516.972415137899, 5766.5675074368755, 5776.711164441761, 5789.247397838254, 5839.240898683144, 1498.1610298233024, 1507.6457032597332, 1514.6364872430759, 1514.788169464424, 1520.103139147886, 937.2267878999852, 938.7420856052922, 948.118250027481, 955.4028732042474, 959.9057074934581, 4807.115730561705, 4925.532074452921, 4946.851594452172, 4958.7024778513405, 4980.729913872012, 5073.720945347967, 5137.741253392943, 5142.357205349332, 5146.665466744649, 5161.716105614152, 4550.259274032695, 4817.626976311734, 4830.227163653799, 4922.655414120977, 4923.310736496894, 2751.5872619107295, 2756.79324050697, 2767.4326763013532, 2774.9445011099665, 2794.664640243184, 5244.951009798056, 5257.369115706139, 5271.262023316662, 5304.336957880265, 5305.44292849253, 5287.603429742785, 5307.283516725192, 5562.833115006556, 6039.305479869871, 6047.334793172836, 6016.939830601726, 6047.697615119315, 6066.848328791815, 6082.787102451482, 6085.574009819358, 5553.916691249554, 5869.559783016205, 5937.554683398676, 5941.554383421174, 5946.464818166386, 5753.8561535961935, 5791.681457519877, 5808.6224395414165, 5813.110739009754, 5834.504067154339, 5804.301000035004, 5991.281046274475, 6015.428534289235, 6029.8191054268445, 6078.756849726138, 4049.817758200947, 4182.874513764592, 4187.790610469525, 4188.267053265728, 4194.790260487024, 5785.103308987113, 5785.479306862402, 5811.4188581143235, 5855.765769369348, 5877.500412464989, 5626.578006649435, 5674.15147216546, 5727.656340619576, 5759.1649210865025, 5768.307803063659, 5611.372701916399, 5654.46282603152, 5679.9432005681065, 5727.942720572908, 5751.1883756616535, 5578.553715702653, 5586.190002449541, 5605.271314729059, 5619.297587801525, 5650.491455769001, 5407.405185429679, 5686.317641883001, 5697.4872261495, 5714.714264286686, 5763.135529670415, 5549.528290095387, 5578.903708441691, 5613.635113717595, 5615.6630602164005, 5641.351244606759], "value": 4294.549287447244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.9091527186195, 700.9404200642945, 715.1882613233981, 768.6541056524562, 802.3701394405391, 14513.782293265596, 15903.20483975801, 16202.594935126628, 16349.34602615897, 16889.324427022904, 14977.925110374461, 15013.324400401982, 15087.396504139848, 15118.546443606681, 15137.31882065307, 667.2226855713088, 682.7200847652464, 683.5386114372803, 797.1112209885964, 810.1574362662853, 685.7874059041688, 785.7996210966196, 808.6199486241458, 810.1007881251805, 817.7301490508119, 842.2756429470651, 842.6797816829596, 844.8183640517287, 846.0355195077616, 846.9280111190557, 687.2714922182503, 838.4717627894418, 838.8532006898769, 839.496302218667, 840.7982084299755, 591.3081694417542, 606.1544145916466, 606.939306069394, 611.5505103748741, 611.8715069835296, 15236.771448428282, 15322.846771532253, 15345.539633811004, 15349.693006139927, 15358.155301458415, 13914.165150090927, 14562.563123106323, 14568.708625827425, 14657.853421465756, 14845.0, 12740.745185096339, 12883.227006379553, 12985.740285194337, 13032.543860964915, 13209.207447553177, 4365.978170109161, 4377.671674624416, 4400.899775056236, 4457.398251236074, 4493.573110554492, 74939.0, 77139.0, 78526.0, 78551.99999999943, 79349.20650793475, 10879.945600272107, 10967.341959482297, 11184.888151118384, 11311.886881131084, 11787.528498859949, 20486.487837804176, 20790.792092079188, 20841.0, 20867.8956605216, 20973.79026209749, 8806.559672016501, 8903.866442003375, 9267.490288034223, 9318.627254909863, 9319.580618872167, 4919.1883339248625, 4973.776180071905, 5011.6241281904, 5044.747762611854, 5187.403448603459, 3402.6937575617817, 3497.7026952709307, 3508.456189290664, 3513.806740629239, 3525.7884526928465, 618.4217756397783, 620.92548894133, 632.6994677528137, 635.291649810458, 650.1710319342876, 716.6810769207652, 726.3426598927979, 741.3624283116516, 742.962851857405, 744.8659241336611, 9347.738055362575, 9351.532423378803, 9505.809883802285, 9550.713478595653, 9581.808363832824, 602.7558838670345, 626.5770604841714, 658.8945768676989, 718.1633397092434, 728.1298847876736, 4424.247877860707, 4484.344990843697, 4508.323751437245, 4510.526394728572, 4556.544345565417, 99134.0, 103130.48434757779, 103532.64673532586, 110395.44802275937, 115909.0, 97802.51098744603, 100980.0, 101107.0, 101416.0, 101441.49279253556, 86091.56954215314, 87757.5612121948, 89167.55416222877, 89331.0, 92879.0, 9500.714978550379, 9703.805923881624, 9787.424257475088, 9807.754806129904, 9869.963653816247, 50625.0, 50799.746001269756, 52160.0, 52788.0, 54163.45836541584, 56390.0, 73103.63448182937, 74251.62874185595, 74481.0, 75851.62074189594, 12927.935360323138, 13120.737585248433, 13405.0, 13470.663233419244, 13932.721345573234, 14838.925805370904, 15160.469383571522, 15164.545063648107, 15368.077915325117, 15627.687446251239, 13570.93214533921, 13681.726365472834, 14055.789163162764, 14129.364178612193, 14172.0, 14720.705585888436, 14910.105393676415, 15040.323780614879, 15040.548783536511, 15082.773758393852, 13038.674033149247, 13390.330483475982, 13392.93303533515, 13691.178529288274, 14414.207218603078, 11170.832437513282, 11334.659960201207, 12154.149209555246, 12254.509819607116, 12619.558315458915, 11184.328940263611, 11729.476633108596, 11765.11761617865, 11840.70398240051, 12026.458809353426], "value": 7617.998135712749, "unit": "score"}], "name": "dromaeo_css", "value": 7196.098005281705, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 105.0, 109.0, 109.0, 111.0, 112.0, 108.0, 109.0, 110.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 128.0, 171.0, 125.0, 126.0, 152.0, 128.0, 201.0, 124.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 163.0, 164.0, 163.0, 163.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 130.0, 76.0, 76.0, 73.0, 74.0, 111.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 107.0, 84.0, 85.0, 86.0, 112.0, 84.0, 84.0, 125.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 53.0, 55.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 70.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 80.0, 81.0, 82.0, 80.0, 81.0, 115.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 127.0, 141.0, 123.0, 123.0, 120.0, 118.0, 118.0, 162.0, 120.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 165.0, 158.0, 159.0, 161.0, 160.0, 157.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1501.6000000000004, "alertThreshold": 2.0}]} 16:35:09 INFO - Return code: 0 16:35:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:35:09 INFO - # TBPL SUCCESS # 16:35:09 INFO - Running post-action listener: _resource_record_post_action 16:35:09 INFO - ##### 16:35:09 INFO - ##### Finished run-tests step (success) 16:35:09 INFO - ##### 16:35:09 INFO - Running post-run listener: _resource_record_post_run 16:35:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555536384; Read time: 8; Write time: 486912 16:35:09 INFO - TinderboxPrint: CPU usage
13.2% 16:35:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:35:09 INFO - TinderboxPrint: I/O write bytes / time
555,536,384 / 486,912 16:35:09 INFO - TinderboxPrint: CPU idle
8,263.4 (86.8%) 16:35:09 INFO - TinderboxPrint: CPU user
1,208.0 (12.7%) 16:35:09 INFO - TinderboxPrint: Swap in / out
0 / 0 16:35:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263045120; Read time: 0; Write time: 270460 16:35:09 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292491264; Read time: 8; Write time: 216452 16:35:10 INFO - Running post-run listener: _upload_blobber_files 16:35:10 INFO - Blob upload gear active. 16:35:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:35:10 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 16:35:10 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:35:10 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:35:10 INFO - (blobuploader) - INFO - Open directory for files ... 16:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:35:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:11 INFO - (blobuploader) - INFO - Done attempting. 16:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:15 INFO - (blobuploader) - INFO - Done attempting. 16:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:35:16 INFO - (blobuploader) - INFO - Done attempting. 16:35:16 INFO - (blobuploader) - INFO - Iteration through files over. 16:35:16 INFO - Return code: 0 16:35:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:35:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:35:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/575dd26ef5faff306cf0b58f4c16f66d432673dce3047d29e75462f31ea6f0438133590f9647c5689cec1255119f260151a5d1a8f0664d35c0567f3782d7342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3207c0c1c82e7885619585c23dfd6641fb7bc950d71ddca5813be84c00830adb9888d159a7e8b38efcf101b942693ce276ec8ea0ee4e196a639d3715a3f8603", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/19ec2eb1bcc3da8b07f52ec7e10f1f1e4f1288c95dd97b9909c5b92bccdda40f9bb73d630d84f800d2714be156d93f4fda05a2fc7075fbc3f885dd90a75ec0d8"} 16:35:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:35:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:35:16 INFO - Contents: 16:35:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/575dd26ef5faff306cf0b58f4c16f66d432673dce3047d29e75462f31ea6f0438133590f9647c5689cec1255119f260151a5d1a8f0664d35c0567f3782d7342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3207c0c1c82e7885619585c23dfd6641fb7bc950d71ddca5813be84c00830adb9888d159a7e8b38efcf101b942693ce276ec8ea0ee4e196a639d3715a3f8603", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/19ec2eb1bcc3da8b07f52ec7e10f1f1e4f1288c95dd97b9909c5b92bccdda40f9bb73d630d84f800d2714be156d93f4fda05a2fc7075fbc3f885dd90a75ec0d8"} 16:35:16 INFO - Running post-run listener: copy_logs_to_upload_dir 16:35:16 INFO - Copying logs to upload dir... 16:35:16 INFO - mkdir: /builds/slave/test/build/upload/logs 16:35:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.161940 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-13 16:35:15.937706) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:35:15.940896) ========= 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=4300f881736b422476174874000001bc-1465858891.187657-561040716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/575dd26ef5faff306cf0b58f4c16f66d432673dce3047d29e75462f31ea6f0438133590f9647c5689cec1255119f260151a5d1a8f0664d35c0567f3782d7342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3207c0c1c82e7885619585c23dfd6641fb7bc950d71ddca5813be84c00830adb9888d159a7e8b38efcf101b942693ce276ec8ea0ee4e196a639d3715a3f8603", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/19ec2eb1bcc3da8b07f52ec7e10f1f1e4f1288c95dd97b9909c5b92bccdda40f9bb73d630d84f800d2714be156d93f4fda05a2fc7075fbc3f885dd90a75ec0d8"} build_url:https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/IGf6dMwcTqWqPLCEMKo0yA/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/Mozilla-Inbound/sha512/575dd26ef5faff306cf0b58f4c16f66d432673dce3047d29e75462f31ea6f0438133590f9647c5689cec1255119f260151a5d1a8f0664d35c0567f3782d7342d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3207c0c1c82e7885619585c23dfd6641fb7bc950d71ddca5813be84c00830adb9888d159a7e8b38efcf101b942693ce276ec8ea0ee4e196a639d3715a3f8603", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/19ec2eb1bcc3da8b07f52ec7e10f1f1e4f1288c95dd97b9909c5b92bccdda40f9bb73d630d84f800d2714be156d93f4fda05a2fc7075fbc3f885dd90a75ec0d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 16:35:15.965509) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:35:15.965797) ========= 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=4300f881736b422476174874000001bc-1465858891.187657-561040716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:35:16.051200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:35:16.051515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 16:35:16.051803) ========= ========= Total master_lag: 0.17 =========