builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1465515125.34 results: success (0) buildid: 20160609133023 builduid: cd0e2202699c47d28f53e6416b0bf60d revision: 5e5914f1100056bd3144b0061a7c826bf73ef918 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.341828) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.342397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.342721) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.458302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.458683) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 16:32:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-06-09 16:32:05 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118253 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.592142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.592559) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019560 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.642575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:05.643002) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5e5914f1100056bd3144b0061a7c826bf73ef918 --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 5e5914f1100056bd3144b0061a7c826bf73ef918 --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=78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 16:32:05,833 truncating revision to first 12 chars 2016-06-09 16:32:05,833 Setting DEBUG logging. 2016-06-09 16:32:05,833 attempt 1/10 2016-06-09 16:32:05,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5e5914f11000?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 16:32:06,140 unpacking tar archive at: mozilla-inbound-5e5914f11000/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.316659) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.317088) ========= script_repo_revision: 5e5914f1100056bd3144b0061a7c826bf73ef918 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.317623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.317955) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 16:32:06.330093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-09 16:32:06.330601) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:32:06 INFO - MultiFileLogger online at 20160609 16:32:06 in /builds/slave/test 16:32:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:32:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:32:06 INFO - {'append_to_log': False, 16:32:06 INFO - 'base_work_dir': '/builds/slave/test', 16:32:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:32:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:32:06 INFO - 'branch': 'Mozilla-Inbound', 16:32:06 INFO - 'buildbot_json_path': 'buildprops.json', 16:32:06 INFO - 'config_files': ('talos/linux_config.py',), 16:32:06 INFO - 'default_actions': ('clobber', 16:32:06 INFO - 'read-buildbot-config', 16:32:06 INFO - 'download-and-extract', 16:32:06 INFO - 'populate-webroot', 16:32:06 INFO - 'create-virtualenv', 16:32:06 INFO - 'install', 16:32:06 INFO - 'run-tests'), 16:32:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:32:06 INFO - 'download_minidump_stackwalk': True, 16:32:06 INFO - 'download_symbols': 'ondemand', 16:32:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:32:06 INFO - 'tooltool.py': '/tools/tooltool.py', 16:32:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:32:06 INFO - '/tools/misc-python/virtualenv.py')}, 16:32:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:32:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:32:06 INFO - 'installer_path': 'installer.exe', 16:32:06 INFO - 'log_level': 'info', 16:32:06 INFO - 'log_name': 'talos', 16:32:06 INFO - 'log_to_console': True, 16:32:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:32:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:32:06 INFO - 'opt_config_files': (), 16:32:06 INFO - 'pip_index': False, 16:32:06 INFO - 'sps_profile': False, 16:32:06 INFO - 'sps_profile_interval': 0, 16:32:06 INFO - 'suite': 'dromaeojs-e10s', 16:32:06 INFO - 'system_bits': '32', 16:32:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:32:06 INFO - 'title': 'talos-linux64-ix-019', 16:32:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:32:06 INFO - 'use_talos_json': True, 16:32:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:32:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:32:06 INFO - 'work_dir': 'build'} 16:32:06 INFO - ##### 16:32:06 INFO - ##### Running clobber step. 16:32:06 INFO - ##### 16:32:06 INFO - Running pre-action listener: _resource_record_pre_action 16:32:06 INFO - Running main action method: clobber 16:32:06 INFO - rmtree: /builds/slave/test/build 16:32:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:32:07 INFO - Running post-action listener: _resource_record_post_action 16:32:07 INFO - ##### 16:32:07 INFO - ##### Finished clobber step (success) 16:32:07 INFO - ##### 16:32:07 INFO - ##### 16:32:07 INFO - ##### Running read-buildbot-config step. 16:32:07 INFO - ##### 16:32:07 INFO - Running pre-action listener: _resource_record_pre_action 16:32:07 INFO - Running main action method: read_buildbot_config 16:32:07 INFO - Using buildbot properties: 16:32:07 INFO - { 16:32:07 INFO - "project": "", 16:32:07 INFO - "product": "firefox", 16:32:07 INFO - "script_repo_revision": "production", 16:32:07 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:32:07 INFO - "repository": "", 16:32:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:32:07 INFO - "buildid": "20160609133023", 16:32:07 INFO - "pgo_build": "True", 16:32:07 INFO - "basedir": "/builds/slave/test", 16:32:07 INFO - "buildnumber": 847, 16:32:07 INFO - "slavename": "talos-linux64-ix-019", 16:32:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:32:07 INFO - "platform": "ubuntu64_hw", 16:32:07 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:32:07 INFO - "branch": "mozilla-inbound", 16:32:07 INFO - "repo_path": "integration/mozilla-inbound", 16:32:07 INFO - "revision": "5e5914f1100056bd3144b0061a7c826bf73ef918", 16:32:07 INFO - "stage_platform": "linux64-pgo", 16:32:07 INFO - "builduid": "cd0e2202699c47d28f53e6416b0bf60d", 16:32:07 INFO - "slavebuilddir": "test" 16:32:07 INFO - } 16:32:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:32:07 INFO - Running post-action listener: _resource_record_post_action 16:32:07 INFO - ##### 16:32:07 INFO - ##### Finished read-buildbot-config step (success) 16:32:07 INFO - ##### 16:32:07 INFO - ##### 16:32:07 INFO - ##### Running download-and-extract step. 16:32:07 INFO - ##### 16:32:07 INFO - Running pre-action listener: _resource_record_pre_action 16:32:07 INFO - Running main action method: download_and_extract 16:32:07 INFO - mkdir: /builds/slave/test/build/tests 16:32:07 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:32:07 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:07 INFO - Downloaded 1361 bytes. 16:32:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:32:07 INFO - Using the following test package requirements: 16:32:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:32:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:32:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:32:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'jsshell-linux-x86_64.zip'], 16:32:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:32:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:32:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:32:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:32:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:32:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:32:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:32:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:32:07 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:32:07 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:32:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:08 INFO - Downloaded 24463850 bytes. 16:32:08 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:32:08 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:32:10 INFO - Return code: 0 16:32:10 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:32:10 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:32:10 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:32:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:32:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:12 INFO - Downloaded 24463850 bytes. 16:32:12 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:32:12 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:32:13 INFO - Return code: 0 16:32:13 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:32:13 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:32:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:32:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:14 INFO - Downloaded 10833377 bytes. 16:32:14 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:32:14 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:32:14 INFO - Return code: 0 16:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:14 INFO - https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:32:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X5ScYxYoQauPA__11W7O1g/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:32:16 INFO - Downloaded 59345126 bytes. 16:32:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:16 INFO - mkdir: /builds/slave/test/properties 16:32:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:16 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:16 INFO - Contents: 16:32:16 INFO - build_url:https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:32:18 INFO - Running post-action listener: _resource_record_post_action 16:32:18 INFO - Running post-action listener: set_extra_try_arguments 16:32:18 INFO - ##### 16:32:18 INFO - ##### Finished download-and-extract step (success) 16:32:18 INFO - ##### 16:32:18 INFO - ##### 16:32:18 INFO - ##### Running populate-webroot step. 16:32:18 INFO - ##### 16:32:18 INFO - Running pre-action listener: _resource_record_pre_action 16:32:18 INFO - Running main action method: populate_webroot 16:32:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:32:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:32:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:32:18 INFO - '--tppagecycles', 16:32:18 INFO - '7'], 16:32:18 INFO - 'tests': ['tsvgm']}}, 16:32:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:32:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:32:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['damp', 'tps']}, 16:32:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'tests': ['damp', 'tps']}, 16:32:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['dromaeo_dom']}, 16:32:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['a11yr', 16:32:18 INFO - 'ts_paint', 16:32:18 INFO - 'tpaint', 16:32:18 INFO - 'sessionrestore', 16:32:18 INFO - 'sessionrestore_no_auto_restore', 16:32:18 INFO - 'tabpaint']}, 16:32:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tsvgx', 16:32:18 INFO - 'tsvgr_opacity', 16:32:18 INFO - 'tart', 16:32:18 INFO - 'tscrollx', 16:32:18 INFO - 'cart']}, 16:32:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:18 INFO - 'tsvgr_opacity', 16:32:18 INFO - 'tart', 16:32:18 INFO - 'tscrollx', 16:32:18 INFO - 'cart']}, 16:32:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s'], 16:32:18 INFO - 'tests': ['tp5o']}, 16:32:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'tests': ['tp5o']}, 16:32:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--disable-e10s', 16:32:18 INFO - '--xperf_path', 16:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:18 INFO - 'tests': ['tp5n']}, 16:32:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:32:18 INFO - 'talos_options': ['--xperf_path', 16:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:18 INFO - 'tests': ['tp5n']}}, 16:32:18 INFO - 'talos.zip': {'path': '', 16:32:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:32:18 INFO - Running post-action listener: _resource_record_post_action 16:32:18 INFO - ##### 16:32:18 INFO - ##### Finished populate-webroot step (success) 16:32:18 INFO - ##### 16:32:18 INFO - ##### 16:32:18 INFO - ##### Running create-virtualenv step. 16:32:18 INFO - ##### 16:32:18 INFO - Running pre-action listener: _resource_record_pre_action 16:32:18 INFO - Running main action method: create_virtualenv 16:32:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:18 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:32:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:18 INFO - Using real prefix '/usr' 16:32:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:18 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:20 INFO - Installing pip.................done. 16:32:20 INFO - Return code: 0 16:32:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:20 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:32:20 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:32:20 INFO - Using env: {'DISPLAY': ':0', 16:32:20 INFO - 'HOME': '/home/cltbld', 16:32:20 INFO - 'LANG': 'en_US.UTF-8', 16:32:20 INFO - 'LANGUAGE': 'en_US:en', 16:32:20 INFO - 'LOGNAME': 'cltbld', 16:32:20 INFO - 'MAIL': '/var/mail/cltbld', 16:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:20 INFO - 'MOZ_NO_REMOTE': '1', 16:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:20 INFO - 'NO_EM_RESTART': '1', 16:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:20 INFO - 'PWD': '/builds/slave/test', 16:32:20 INFO - 'SHELL': '/bin/bash', 16:32:20 INFO - 'SHLVL': '1', 16:32:20 INFO - 'TERM': 'linux', 16:32:20 INFO - 'TMOUT': '86400', 16:32:20 INFO - 'USER': 'cltbld', 16:32:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:20 INFO - '_': '/tools/buildbot/bin/python'} 16:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:20 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:32:20 INFO - Cleaning up... 16:32:20 INFO - Return code: 0 16:32:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:20 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:20 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:32:20 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:32:20 INFO - Using env: {'DISPLAY': ':0', 16:32:20 INFO - 'HOME': '/home/cltbld', 16:32:20 INFO - 'LANG': 'en_US.UTF-8', 16:32:20 INFO - 'LANGUAGE': 'en_US:en', 16:32:20 INFO - 'LOGNAME': 'cltbld', 16:32:20 INFO - 'MAIL': '/var/mail/cltbld', 16:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:20 INFO - 'MOZ_NO_REMOTE': '1', 16:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:20 INFO - 'NO_EM_RESTART': '1', 16:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:20 INFO - 'PWD': '/builds/slave/test', 16:32:20 INFO - 'SHELL': '/bin/bash', 16:32:20 INFO - 'SHLVL': '1', 16:32:20 INFO - 'TERM': 'linux', 16:32:20 INFO - 'TMOUT': '86400', 16:32:20 INFO - 'USER': 'cltbld', 16:32:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:20 INFO - '_': '/tools/buildbot/bin/python'} 16:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:21 INFO - Downloading/unpacking psutil>=3.1.1 16:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:23 INFO - Installing collected packages: psutil 16:32:23 INFO - Running setup.py install for psutil 16:32:23 INFO - building 'psutil._psutil_linux' extension 16:32:23 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:32:23 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:32:23 INFO - building 'psutil._psutil_posix' extension 16:32:23 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:32:23 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:32:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:23 INFO - Successfully installed psutil 16:32:23 INFO - Cleaning up... 16:32:23 INFO - Return code: 0 16:32:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:23 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:23 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:32:23 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:32:23 INFO - Using env: {'DISPLAY': ':0', 16:32:23 INFO - 'HOME': '/home/cltbld', 16:32:23 INFO - 'LANG': 'en_US.UTF-8', 16:32:23 INFO - 'LANGUAGE': 'en_US:en', 16:32:23 INFO - 'LOGNAME': 'cltbld', 16:32:23 INFO - 'MAIL': '/var/mail/cltbld', 16:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:23 INFO - 'MOZ_NO_REMOTE': '1', 16:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:23 INFO - 'NO_EM_RESTART': '1', 16:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:23 INFO - 'PWD': '/builds/slave/test', 16:32:23 INFO - 'SHELL': '/bin/bash', 16:32:23 INFO - 'SHLVL': '1', 16:32:23 INFO - 'TERM': 'linux', 16:32:23 INFO - 'TMOUT': '86400', 16:32:23 INFO - 'USER': 'cltbld', 16:32:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:23 INFO - '_': '/tools/buildbot/bin/python'} 16:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:23 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:32:23 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:32:23 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:32:23 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:32:23 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:32:23 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:32:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:25 INFO - Installing collected packages: mozsystemmonitor 16:32:25 INFO - Running setup.py install for mozsystemmonitor 16:32:26 INFO - Successfully installed mozsystemmonitor 16:32:26 INFO - Cleaning up... 16:32:26 INFO - Return code: 0 16:32:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32:26 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:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:26 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:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:26 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:26 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:32:26 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:32:26 INFO - Using env: {'DISPLAY': ':0', 16:32:26 INFO - 'HOME': '/home/cltbld', 16:32:26 INFO - 'LANG': 'en_US.UTF-8', 16:32:26 INFO - 'LANGUAGE': 'en_US:en', 16:32:26 INFO - 'LOGNAME': 'cltbld', 16:32:26 INFO - 'MAIL': '/var/mail/cltbld', 16:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:26 INFO - 'MOZ_NO_REMOTE': '1', 16:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:26 INFO - 'NO_EM_RESTART': '1', 16:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:26 INFO - 'PWD': '/builds/slave/test', 16:32:26 INFO - 'SHELL': '/bin/bash', 16:32:26 INFO - 'SHLVL': '1', 16:32:26 INFO - 'TERM': 'linux', 16:32:26 INFO - 'TMOUT': '86400', 16:32:26 INFO - 'USER': 'cltbld', 16:32:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:26 INFO - '_': '/tools/buildbot/bin/python'} 16:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:26 INFO - Downloading/unpacking jsonschema==2.5.1 16:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:26 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:32:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:28 INFO - warning: no files found matching '*.txt' 16:32:28 INFO - no previously-included directories found matching 'build' 16:32:28 INFO - no previously-included directories found matching 'dist' 16:32:28 INFO - no previously-included directories found matching '.git*' 16:32:28 INFO - Installing collected packages: jsonschema, functools32 16:32:28 INFO - Running setup.py install for functools32 16:32:28 INFO - warning: no files found matching '*.txt' 16:32:28 INFO - no previously-included directories found matching 'build' 16:32:28 INFO - no previously-included directories found matching 'dist' 16:32:28 INFO - no previously-included directories found matching '.git*' 16:32:28 INFO - Successfully installed jsonschema functools32 16:32:28 INFO - Cleaning up... 16:32:28 INFO - Return code: 0 16:32:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:28 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:28 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:32:28 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:32:28 INFO - Using env: {'DISPLAY': ':0', 16:32:28 INFO - 'HOME': '/home/cltbld', 16:32:28 INFO - 'LANG': 'en_US.UTF-8', 16:32:28 INFO - 'LANGUAGE': 'en_US:en', 16:32:28 INFO - 'LOGNAME': 'cltbld', 16:32:28 INFO - 'MAIL': '/var/mail/cltbld', 16:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:28 INFO - 'MOZ_NO_REMOTE': '1', 16:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:28 INFO - 'NO_EM_RESTART': '1', 16:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:28 INFO - 'PWD': '/builds/slave/test', 16:32:28 INFO - 'SHELL': '/bin/bash', 16:32:28 INFO - 'SHLVL': '1', 16:32:28 INFO - 'TERM': 'linux', 16:32:28 INFO - 'TMOUT': '86400', 16:32:28 INFO - 'USER': 'cltbld', 16:32:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:28 INFO - '_': '/tools/buildbot/bin/python'} 16:32:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:28 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:32:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32:31 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:32:31 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:32:31 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:32:31 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:32:31 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:32:31 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:32:31 INFO - Downloading docopt-0.6.1.tar.gz 16:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:31 INFO - Running setup.py install for blobuploader 16:32:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:31 INFO - Running setup.py install for requests 16:32:31 INFO - Running setup.py install for docopt 16:32:32 INFO - Successfully installed blobuploader requests docopt 16:32:32 INFO - Cleaning up... 16:32:32 INFO - Return code: 0 16:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:32 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:32 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:32:32 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:32:32 INFO - Using env: {'DISPLAY': ':0', 16:32:32 INFO - 'HOME': '/home/cltbld', 16:32:32 INFO - 'LANG': 'en_US.UTF-8', 16:32:32 INFO - 'LANGUAGE': 'en_US:en', 16:32:32 INFO - 'LOGNAME': 'cltbld', 16:32:32 INFO - 'MAIL': '/var/mail/cltbld', 16:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:32 INFO - 'MOZ_NO_REMOTE': '1', 16:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:32 INFO - 'NO_EM_RESTART': '1', 16:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:32 INFO - 'PWD': '/builds/slave/test', 16:32:32 INFO - 'SHELL': '/bin/bash', 16:32:32 INFO - 'SHLVL': '1', 16:32:32 INFO - 'TERM': 'linux', 16:32:32 INFO - 'TMOUT': '86400', 16:32:32 INFO - 'USER': 'cltbld', 16:32:32 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:32 INFO - '_': '/tools/buildbot/bin/python'} 16:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:32 INFO - Running setup.py (path:/tmp/pip-ziGnZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:32 INFO - Running setup.py (path:/tmp/pip-3LRgtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:32 INFO - Running setup.py (path:/tmp/pip-yr0rR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:32 INFO - Running setup.py (path:/tmp/pip-8WIN6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:32 INFO - Running setup.py (path:/tmp/pip-QdvgY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:32 INFO - Running setup.py (path:/tmp/pip-ru5y4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:32 INFO - Running setup.py (path:/tmp/pip-_BkDu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:32 INFO - Running setup.py (path:/tmp/pip-89SiRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:32 INFO - Running setup.py (path:/tmp/pip-jU_o3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:32 INFO - Running setup.py (path:/tmp/pip-J6NEhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:33 INFO - Running setup.py (path:/tmp/pip-EMN9O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:33 INFO - Running setup.py (path:/tmp/pip-R7jh5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:33 INFO - Running setup.py (path:/tmp/pip-V9MHxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:33 INFO - Running setup.py (path:/tmp/pip-XDe5XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:33 INFO - Running setup.py (path:/tmp/pip-T6ZpEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:33 INFO - Running setup.py (path:/tmp/pip-NXn_D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:33 INFO - Running setup.py (path:/tmp/pip-sPavI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:33 INFO - Running setup.py install for manifestparser 16:32:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:33 INFO - Running setup.py install for mozcrash 16:32:33 INFO - Running setup.py install for mozdebug 16:32:33 INFO - Running setup.py install for mozdevice 16:32:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:33 INFO - Running setup.py install for mozfile 16:32:34 INFO - Running setup.py install for mozhttpd 16:32:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Running setup.py install for mozinfo 16:32:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Running setup.py install for mozInstall 16:32:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Running setup.py install for mozleak 16:32:34 INFO - Running setup.py install for mozlog 16:32:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Running setup.py install for moznetwork 16:32:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Running setup.py install for mozprocess 16:32:34 INFO - Running setup.py install for mozprofile 16:32:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:34 INFO - Running setup.py install for mozrunner 16:32:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Running setup.py install for mozscreenshot 16:32:35 INFO - Running setup.py install for moztest 16:32:35 INFO - Running setup.py install for mozversion 16:32:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:35 INFO - Cleaning up... 16:32:35 INFO - Return code: 0 16:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:35 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:35 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:32:35 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:32:35 INFO - Using env: {'DISPLAY': ':0', 16:32:35 INFO - 'HOME': '/home/cltbld', 16:32:35 INFO - 'LANG': 'en_US.UTF-8', 16:32:35 INFO - 'LANGUAGE': 'en_US:en', 16:32:35 INFO - 'LOGNAME': 'cltbld', 16:32:35 INFO - 'MAIL': '/var/mail/cltbld', 16:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:35 INFO - 'MOZ_NO_REMOTE': '1', 16:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:35 INFO - 'NO_EM_RESTART': '1', 16:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:35 INFO - 'PWD': '/builds/slave/test', 16:32:35 INFO - 'SHELL': '/bin/bash', 16:32:35 INFO - 'SHLVL': '1', 16:32:35 INFO - 'TERM': 'linux', 16:32:35 INFO - 'TMOUT': '86400', 16:32:35 INFO - 'USER': 'cltbld', 16:32:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:35 INFO - '_': '/tools/buildbot/bin/python'} 16:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:35 INFO - Running setup.py (path:/tmp/pip-SnrwoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:35 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:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:35 INFO - Running setup.py (path:/tmp/pip-vvtQTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:35 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:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:35 INFO - Running setup.py (path:/tmp/pip-exg_CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:35 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:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:35 INFO - Running setup.py (path:/tmp/pip-cnHka_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:35 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:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:35 INFO - Running setup.py (path:/tmp/pip-5cYMhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:35 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:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:35 INFO - Running setup.py (path:/tmp/pip-F20KE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:35 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:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:35 INFO - Running setup.py (path:/tmp/pip-jZDLrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:36 INFO - Running setup.py (path:/tmp/pip-Pf8QZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:36 INFO - Running setup.py (path:/tmp/pip-pIIBmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:36 INFO - Running setup.py (path:/tmp/pip-F1ewzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:36 INFO - Running setup.py (path:/tmp/pip-1MiV85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:36 INFO - Running setup.py (path:/tmp/pip-sAVn12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:36 INFO - Running setup.py (path:/tmp/pip-2o1fQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:36 INFO - Running setup.py (path:/tmp/pip-f5WlAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:36 INFO - Running setup.py (path:/tmp/pip-nLQp04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:36 INFO - Running setup.py (path:/tmp/pip-N03tbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:36 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:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:36 INFO - Running setup.py (path:/tmp/pip-zVlggy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:36 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:32:36 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:32:36 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:32:36 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:32:36 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:32:36 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:32:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:36 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:32:36 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:32:36 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:32:36 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:32:36 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:32:36 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:32:38 INFO - Downloading blessings-1.6.tar.gz 16:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:38 INFO - Installing collected packages: blessings 16:32:38 INFO - Running setup.py install for blessings 16:32:38 INFO - Successfully installed blessings 16:32:38 INFO - Cleaning up... 16:32:38 INFO - Return code: 0 16:32:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:39 INFO - Reading from file tmpfile_stdout 16:32:39 INFO - Current package versions: 16:32:39 INFO - argparse == 1.2.1 16:32:39 INFO - blessings == 1.6 16:32:39 INFO - blobuploader == 1.2.4 16:32:39 INFO - docopt == 0.6.1 16:32:39 INFO - functools32 == 3.2.3-2 16:32:39 INFO - jsonschema == 2.5.1 16:32:39 INFO - manifestparser == 1.1 16:32:39 INFO - mozInstall == 1.12 16:32:39 INFO - mozcrash == 0.17 16:32:39 INFO - mozdebug == 0.1 16:32:39 INFO - mozdevice == 0.48 16:32:39 INFO - mozfile == 1.2 16:32:39 INFO - mozhttpd == 0.7 16:32:39 INFO - mozinfo == 0.9 16:32:39 INFO - mozleak == 0.1 16:32:39 INFO - mozlog == 3.2 16:32:39 INFO - moznetwork == 0.27 16:32:39 INFO - mozprocess == 0.22 16:32:39 INFO - mozprofile == 0.28 16:32:39 INFO - mozrunner == 6.11 16:32:39 INFO - mozscreenshot == 0.1 16:32:39 INFO - mozsystemmonitor == 0.3 16:32:39 INFO - moztest == 0.7 16:32:39 INFO - mozversion == 1.4 16:32:39 INFO - psutil == 3.1.1 16:32:39 INFO - requests == 1.2.3 16:32:39 INFO - wsgiref == 0.1.2 16:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:39 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:39 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:32:39 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:32:39 INFO - Using env: {'DISPLAY': ':0', 16:32:39 INFO - 'HOME': '/home/cltbld', 16:32:39 INFO - 'LANG': 'en_US.UTF-8', 16:32:39 INFO - 'LANGUAGE': 'en_US:en', 16:32:39 INFO - 'LOGNAME': 'cltbld', 16:32:39 INFO - 'MAIL': '/var/mail/cltbld', 16:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:39 INFO - 'MOZ_NO_REMOTE': '1', 16:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:39 INFO - 'NO_EM_RESTART': '1', 16:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:39 INFO - 'PWD': '/builds/slave/test', 16:32:39 INFO - 'SHELL': '/bin/bash', 16:32:39 INFO - 'SHLVL': '1', 16:32:39 INFO - 'TERM': 'linux', 16:32:39 INFO - 'TMOUT': '86400', 16:32:39 INFO - 'USER': 'cltbld', 16:32:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:39 INFO - '_': '/tools/buildbot/bin/python'} 16:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 INFO - Cleaning up... 16:32:39 INFO - Return code: 0 16:32:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:39 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:39 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:32:39 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:32:39 INFO - Using env: {'DISPLAY': ':0', 16:32:39 INFO - 'HOME': '/home/cltbld', 16:32:39 INFO - 'LANG': 'en_US.UTF-8', 16:32:39 INFO - 'LANGUAGE': 'en_US:en', 16:32:39 INFO - 'LOGNAME': 'cltbld', 16:32:39 INFO - 'MAIL': '/var/mail/cltbld', 16:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:39 INFO - 'MOZ_NO_REMOTE': '1', 16:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:39 INFO - 'NO_EM_RESTART': '1', 16:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:39 INFO - 'PWD': '/builds/slave/test', 16:32:39 INFO - 'SHELL': '/bin/bash', 16:32:39 INFO - 'SHLVL': '1', 16:32:39 INFO - 'TERM': 'linux', 16:32:39 INFO - 'TMOUT': '86400', 16:32:39 INFO - 'USER': 'cltbld', 16:32:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:39 INFO - '_': '/tools/buildbot/bin/python'} 16:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:39 INFO - Cleaning up... 16:32:39 INFO - Return code: 0 16:32:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:39 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 0x7fb4d4b4df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', '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:32:39 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:32:39 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:32:39 INFO - Using env: {'DISPLAY': ':0', 16:32:39 INFO - 'HOME': '/home/cltbld', 16:32:39 INFO - 'LANG': 'en_US.UTF-8', 16:32:39 INFO - 'LANGUAGE': 'en_US:en', 16:32:39 INFO - 'LOGNAME': 'cltbld', 16:32:39 INFO - 'MAIL': '/var/mail/cltbld', 16:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:39 INFO - 'MOZ_NO_REMOTE': '1', 16:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:39 INFO - 'NO_EM_RESTART': '1', 16:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:39 INFO - 'PWD': '/builds/slave/test', 16:32:39 INFO - 'SHELL': '/bin/bash', 16:32:39 INFO - 'SHLVL': '1', 16:32:39 INFO - 'TERM': 'linux', 16:32:39 INFO - 'TMOUT': '86400', 16:32:39 INFO - 'USER': 'cltbld', 16:32:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:39 INFO - '_': '/tools/buildbot/bin/python'} 16:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:39 INFO - Downloading/unpacking flake8 16:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:32:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:32:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:32:42 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:32:42 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:32:42 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:32:42 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:32:42 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:32:42 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:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:32:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:42 INFO - no previously-included directories found matching 'docs/_build' 16:32:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:32:42 INFO - Running setup.py install for pep8 16:32:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:32:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:32:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:32:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:32:42 INFO - no previously-included directories found matching 'docs/_build' 16:32:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:32:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:32:42 INFO - Cleaning up... 16:32:42 INFO - Return code: 0 16:32:42 INFO - Running post-action listener: _resource_record_post_action 16:32:42 INFO - Running post-action listener: _start_resource_monitoring 16:32:42 INFO - Starting resource monitoring. 16:32:42 INFO - ##### 16:32:42 INFO - ##### Finished create-virtualenv step (success) 16:32:42 INFO - ##### 16:32:42 INFO - ##### 16:32:42 INFO - ##### Running install step. 16:32:42 INFO - ##### 16:32:42 INFO - Running pre-action listener: _resource_record_pre_action 16:32:42 INFO - Running main action method: install 16:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:42 INFO - Reading from file tmpfile_stdout 16:32:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:43 INFO - Reading from file tmpfile_stdout 16:32:43 INFO - Output received: 16:32:43 INFO - Usage: mozinstall [options] installer 16:32:43 INFO - Options: 16:32:43 INFO - -h, --help show this help message and exit 16:32:43 INFO - -d DEST, --destination=DEST 16:32:43 INFO - Directory to install application into. [default: 16:32:43 INFO - "/builds/slave/test"] 16:32:43 INFO - --app=APP Application being installed. [default: firefox] 16:32:43 INFO - mkdir: /builds/slave/test/build/application 16:32:43 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:32:43 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:32:59 INFO - Reading from file tmpfile_stdout 16:32:59 INFO - Output received: 16:32:59 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:59 INFO - Running post-action listener: _resource_record_post_action 16:32:59 INFO - ##### 16:32:59 INFO - ##### Finished install step (success) 16:32:59 INFO - ##### 16:32:59 INFO - ##### 16:32:59 INFO - ##### Running run-tests step. 16:32:59 INFO - ##### 16:32:59 INFO - Running pre-action listener: _resource_record_pre_action 16:32:59 INFO - Running main action method: run_tests 16:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:59 INFO - Python 2.7.3 16:32:59 INFO - Return code: 0 16:32:59 INFO - grabbing minidump binary from tooltool 16:32: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:32:59 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 0xdff1c0>, '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 0xe000c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe00550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:59 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:32:59 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:32:59 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:32:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:59 INFO - Return code: 0 16:32:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:32:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:33:00 INFO - Return code: 0 16:33:00 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:33:00 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:33:00 INFO - Using env: {'DISPLAY': ':0', 16:33:00 INFO - 'HOME': '/home/cltbld', 16:33:00 INFO - 'LANG': 'en_US.UTF-8', 16:33:00 INFO - 'LANGUAGE': 'en_US:en', 16:33:00 INFO - 'LOGNAME': 'cltbld', 16:33:00 INFO - 'MAIL': '/var/mail/cltbld', 16:33:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:33:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:00 INFO - 'MOZ_NO_REMOTE': '1', 16:33:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:00 INFO - 'NO_EM_RESTART': '1', 16:33:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:00 INFO - 'PWD': '/builds/slave/test', 16:33:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:33:00 INFO - 'SHELL': '/bin/bash', 16:33:00 INFO - 'SHLVL': '1', 16:33:00 INFO - 'TERM': 'linux', 16:33:00 INFO - 'TMOUT': '86400', 16:33:00 INFO - 'USER': 'cltbld', 16:33:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577', 16:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:00 INFO - '_': '/tools/buildbot/bin/python'} 16:33:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:33:01 INFO - mozversion application_buildid: 20160609133023 16:33:01 INFO - mozversion application_changeset: 5e5914f1100056bd3144b0061a7c826bf73ef918 16:33:01 INFO - mozversion application_display_name: Nightly 16:33:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:33:01 INFO - mozversion application_name: Firefox 16:33:01 INFO - mozversion application_remotingname: firefox 16:33:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:33:01 INFO - mozversion application_vendor: Mozilla 16:33:01 INFO - mozversion application_version: 50.0a1 16:33:01 INFO - mozversion platform_buildid: 20160609133023 16:33:01 INFO - mozversion platform_changeset: 5e5914f1100056bd3144b0061a7c826bf73ef918 16:33:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:33:01 INFO - mozversion platform_version: 50.0a1 16:33:01 INFO - using testdate: 1465515181 16:33:01 INFO - actual date: 1465515181 16:33:01 INFO - starting webserver on 'localhost:60008' 16:33:01 INFO - SUITE-START | Running 2 tests 16:33:01 INFO - TEST-START | dromaeo_css 16:33:01 INFO - operating with platform_type : linux_ 16:33:01 INFO - Initialising browser for dromaeo_css test... 16:33:01 INFO - TEST-INFO | started process 5394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvUxMf9/profile http://localhost:60008/getInfo.html) 16:33:06 INFO - PROCESS | 5394 | __metrics Screen width/height:1600/1200 16:33:06 INFO - PROCESS | 5394 | colorDepth:24 16:33:06 INFO - PROCESS | 5394 | Browser inner width/height: 1024/697 16:33:06 INFO - PROCESS | 5394 | __metrics 16:33:06 ERROR - PROCESS | 5394 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:33:07 INFO - TEST-INFO | 5394: exit 0 16:33:07 INFO - Browser initialized. 16:33:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:33:07 INFO - TEST-INFO | started process 5515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvUxMf9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:19 INFO - PROCESS | 5515 | RSS: Main: 184963072 16:33:19 INFO - PROCESS | 5515 | 16:34:09 INFO - PROCESS | 5515 | 1465515249171 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:36:16 INFO - PROCESS | 5515 | Cycle 1(1): loaded http://localhost:60008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60008/tests/dromaeo/cssquery-ext.html) 16:36:17 INFO - PROCESS | 5515 | RSS: Main: 188391424 16:36:17 INFO - PROCESS | 5515 | 16:39:20 INFO - PROCESS | 5515 | Cycle 1(1): loaded http://localhost:60008/tests/dromaeo/cssquery-ext.html (next: http://localhost:60008/tests/dromaeo/cssquery-jquery.html) 16:39:20 INFO - PROCESS | 5515 | RSS: Main: 187465728 16:39:20 INFO - PROCESS | 5515 | 16:42:22 INFO - PROCESS | 5515 | Cycle 1(1): loaded http://localhost:60008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60008/tests/dromaeo/cssquery-mootools.html) 16:42:23 INFO - PROCESS | 5515 | RSS: Main: 189157376 16:42:23 INFO - PROCESS | 5515 | 16:45:24 INFO - PROCESS | 5515 | Cycle 1(1): loaded http://localhost:60008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60008/tests/dromaeo/cssquery-prototype.html) 16:45:25 INFO - PROCESS | 5515 | RSS: Main: 186286080 16:45:25 INFO - PROCESS | 5515 | 16:48:27 INFO - PROCESS | 5515 | Cycle 1(1): loaded http://localhost:60008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60008/tests/dromaeo/cssquery-yui.html) 16:48:28 INFO - PROCESS | 5515 | RSS: Main: 188596224 16:48:28 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | Cycle 1(1): loaded http://localhost:60008/tests/dromaeo/cssquery-yui.html (next: http://localhost:60008/tests/dromaeo/cssquery-dojo.html) 16:51:31 INFO - PROCESS | 5515 | RSS: Main: 189263872 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | __start_tp_report 16:51:31 INFO - PROCESS | 5515 | _x_x_mozilla_page_load 16:51:31 INFO - PROCESS | 5515 | _x_x_mozilla_page_load_details 16:51:31 INFO - PROCESS | 5515 | |i|pagename|runs| 16:51:31 INFO - PROCESS | 5515 | |0;dojo.html;3067.171863596829;3098.2409309719123;3099.7985130966485;3135.8745650173996;3136.341368312654;5403.135498320265;5413.891722165555;5447.291852059232;5493.862653433666;5509.3664228613725;5379.704116273603;5411.485908838664;5452.6183167178315;5479.479449452306;5532.75102620382;4902.460729319772;4946.356973593446;5053.9241911371355;5114.181730923053;5164.251183578398;492.40507537640474;4925.729084900329;4939.8024079036795;4956.752162391884;5127.3078134451935;4957.380327459067;4966.453690094087;5029.195328747401;5033.874153146164;5040.218766091261;5018.096742586333;5022.271770593244;5029.5221953914315;5039.420466646346;5068.138416469173;4912.656114072016;4963.429205641325;4977.7262250576205;4991.600671946236;4992.126377883892;5482.5613950883835;5487.506124448819;5497.8075767347955;5569.415211402826;5600.1599760035915;5673.120666296731;5861.384554621746;5893.58744887858;5940.049592065248;5946.791862284843;5860.150278209679;5974.4324289192455;5990.311114221877;5993.101034844764;6043.214382130339;5587.413321601254;5589.636673616202;5592.99326121294;5595.972020139914;5596.440355964371;5809.448102430262;5966.194563733927;6028.788992385245;6075.3317135115985;6089.1779609753;5838.649681019152;5842.386549412336;5849.88300233993;5854.912176317359;5888.087346461305;5917.289925208916;5917.467427931507;5919.852003699942;5925.170476133345;5931.199288096138;5635.042042852725;5840.240768700041;5862.970685146547;5882.176495290662;5901.468867801918;5819.127130930309;5873.236479257669;5877.970610146922;5896.380880007623;5926.762929482858;4473.172463094338;4474.753888536096;4483.574060464251;4502.639788816887;4503.166914120898;3928.0965377962657;3954.8615798446917;3976.483057202603;4018.4976877890263;4038.757674539478;5570.442955704397;5620.57845661577;5625;5631.8592035199445;5693.089105743061;5954;5954.225950626477;5974.880502389928;5988.431099045583;5995.370486098984;5494.587905906993;5549.056660367747;5639.0977443609645;5666.97166514173;5701.771929122871;5116.846494605168;5129.79480820763;5143.691378517301;5143.71709555978;5150.793968241228;5941.435563621449;6194.163787888578;6197.783077592353;6201.286852012076;6212.161358216673;5861.443162899518;5868.559858010666;5874.265716785402;5916.31962324321;5922.200502932049;6061.848453788691;6087.208662873798;6091.177691011834;6095.238095238095;6099.664518451527;5726.513246374105;5802.216700745345;5828.94171058284;5840.737166827418;5848.795292164924;5857.4435428634215;5926.614770039933;5971.7611295547695;5973.701314934323;6027.276726792813;5705.543556515386;5805.535557155333;5813.04084825999;5832.24180856486;5838.912416313674;5689.118186681071;5719.771209151754;5736.913946290892;5798.217240672455;5819.127130930395;5654.802081927113;5666.886662266814;5699.430056994267;5720.141978703228;5743.4256574342235;5810.157527158453;5819.127130930395;5868;5871.324797648325;5891.263592050994;5587.74855131512;5656.830295091154;5667.20659107717;5721.227634269487;5724.484796368347 16:51:31 INFO - PROCESS | 5515 | |1;ext.html;552.9170624406338;601.1523751510371;616.7625464196286;620.9130721698963;645.6287634610095;39535.80232098839;45040.54959450409;45451.090978180415;45488.090238195255;45569.088618227695;44663.33005004928;45000.09999800002;45244;45359.0928181437;45557.31664025034;8865.069167737376;9041.909580904205;9044;9046.502442365667;9087.045860184684;8928.062553431893;9026.142516460959;9048.502332371718;9052.547372631376;9055.909440905572;9095.772605684877;9128.178463938244;9141.360104792668;9143.451392916413;9146.268298536135;9035.774105647346;9046.457212567235;9047.185753282203;9049.638014479413;9067.365284430092;8873.06832782555;8944.284457243404;8950.462972221687;8958;8980.191782739585;34876.12809679753;42883.35674964878;43364;43389.13221735547;43502.34746478805;3399.3201359728155;3497.7995134451944;3655.3785856404475;3901.551321597996;4242.787860606957;31157.532637010463;31581.684183158104;31727.20681982946;32343;32761.18097047593;4149.356849688273;4193.580641935812;4199.223143718422;4228.682848786353;4232.090100628349;302448.95102097833;303287;304003;304491;305367.9999999978;29945.251368715955;31260;31383.529247061313;31434.685653143177;31458.528122078187;30763;31400.21499462486;31530.36939261248;31666.683333166835;31725.524117138262;15114;15238.771418428732;15263.923680381527;15264.847351526343;15370.923145384202;12971.027172962065;13105.606831795061;13117;13160.670983225496;13178.077534572489;6711.563748356341;6713.69788359525;6719.160104986877;6753.898691519631;6797.2523022467485;2680.9463810724064;2759.310172456886;2785.080923295308;2793.064323451626;2807.6771171315154;1005.1757558801859;1156.7333769522359;1168.6727716239466;1173.9024012548296;1201.6478041670941;32329.51505727416;32408.35183296321;32657.836710816293;32815.835920820246;32921.67078329234;1116.1294190531398;1127.5320741892187;1128.2046157458972;1129.6554550862065;1140.4126874659557;16242.350305987864;16245.675086498204;16479.83520164807;16625.3349866004;16725.83274167267;575564;579995.4003219819;581948;583544;586019;55811.44188558144;56141.15788263179;56405;56542.151867722016;56887.71556142275;1332.2206509192038;1396.790481427794;1403.39653948803;1409.3587417724912;1412.1668215752754;28808.279793005342;30277.394452111275;30729.539056913716;30742.826441675785;31031.68968310288;50088;50355;50912.49087509078;50945;50948.490515094374;524051;525329;528717;528775;530456;24273.39316517101;24381.878090609433;24614.384640384134;25738.613920791577;26632.334191645365;50879;51045.74477127591;51548;51886.481135188165;51929.480705192465;41670.79164604157;42444.57555424406;42952.78523607487;43070.56929430665;43423.13153736971;40703.59296406998;41207.79396103;41555.58444415638;41760.37359439672;42515.7874210627;41212.1757564841;41414.37878431886;43083.353749694405;44879.551204487536;45085.32372014488;34156.65843341634;36083.81958090193;36127.81936090303;36649;36684.633153668125;26951.326216844736;27421.862890685417;27716.58425123665;27723.841423786595;27771.583426249028 16:51:31 INFO - PROCESS | 5515 | |2;jquery.html;375.75575875680806;380.82101412336203;397.7553804410289;401.5602914808285;409.2755822194715;14578.708425831504;18184.636307273864;18488.81511184888;20213.797862021376;20282.6957595636;18405;18793.530161745963;19106;19169.424917252505;19429.02854857255;5458.918116228259;5569.164625306196;5662.716864156796;5676.3755986841625;5768.913466298009;5678.716064196794;5764.884702305952;5778.335491418498;5788.04497257952;5811.506021988136;5432.375276843174;5658.321001479808;5667.3482549506925;5716.28546431696;5745.195672605839;5600.243967064435;5617.4382561743905;5623.240862483594;5630.5495560355075;5672.574556908227;5013;5025.497450254982;5168.198929165986;5192.688438693653;5195.350581177353;19535.511612209666;20517.897410513;20727.8963605181;22523.436914077116;22627;2369.7037870266217;2387.6657267982496;2486.651868738378;2878.942421151565;2930.750886174678;10196.133328667072;10202.540885660163;10230.488475576192;12022.939885300604;14737.042092264075;1906.7044608085769;1950.5513731841613;1986.7317912081828;2028.20899849059;2039.9800099950025;74676;75614;75833;76245.61877190579;78204.60897695532;10532.947335263274;10552.206124958775;10704.411257380918;10755.354678719303;10825.458727063615;14688.237411510474;14984.550463486114;14992.250387480583;15004.399824006918;15022.924885375503;7758.650860711282;8103.554304513308;8115.837683246302;8186.222308880647;8197.79505512367;7927.445078844541;7939.126696063428;8019;8108.43240973138;8120.309773669304;4521.88695282614;4556.521565235669;4601.125786100697;4646.7444290564345;4681.99337142516;1892.8138000609317;1912.0267983285846;1929.4983304340692;1929.990350048269;1982.2764690887723;898.6630013744846;913.9223166030962;971.048372594861;1025.220832167558;1078.8813230544633;17539.56151096233;18474.44576662702;18762.155702993397;18881.52796180079;19286.324978625682;1002.6440613582073;1012.5342342522375;1013.7769690668041;1018.165104614224;1045.46158728255;10305.948470257601;10727.463626818628;10812.459377031275;10828.62099826518;11004.559817607205;474941;480000;496358;508448;510522;62307.37692623016;62386;79708.60145699234;80693.19306806974;87057;945.5697657565792;946.2335508238349;963.0321526865455;970.1608108985818;990.0841721407813;16840.242189101766;16846.66306673884;16863.578410539834;17078.914605426893;17341.132943353034;37297.440538391405;37335.626643733216;38024.61975380211;38621.4206786904;39089.60910390974;50574.49425505845;50914.74542627263;51897;53623.463765363405;61097.80668643215;8292.212239837207;8304.377171712025;8320.791980200544;8387.790305242417;8526.701565445428;9092.545372731205;11956.402179891145;12521.812172817234;12609.747805044031;12712.936435318134;10929.180311476512;10955.616553420592;11150.944245278723;11312.264702794291;11509.654710358702;11085.778284434427;11272;11276.718082048015;11503.137264705014;11740.178187526792;8990.820183596423;11261.71845703864;11321.830172547254;11485.47319589689;11497.655070347902;6693.531452798257;7027.859442811217;8369.121242269473;8503.489790612583;8616.267617252604;10036.347637403545;10909.890901090888;10911.181661375587;11010.174236932102;11075.667729968114 16:51:31 INFO - PROCESS | 5515 | |3;mootools.html;1462.3711803924311;1469.3828591991364;1574.3623832347896;1694.8474637282643;1760.137532609022;7900.881486777688;8506.234438900497;8511.191436813508;9065.773355666111;9072.138146876045;8567.957160214206;8765.649374025048;8852.291816654668;8853.424527405714;8964;2349.600567903456;2391.294568102414;2391.6412538119334;2402.267308470916;2408.1089996701244;2313.838031337807;2334.743178250391;2384.95230095398;2386.5942789725786;2407.434252950555;2348.9530209395803;2360.728516220631;2364.326167042393;2383.5113801670705;2387.236084452976;2298;2302.827287953402;2307.538492301538;2310.7111611048617;2317.3974766560814;2236.4520692430297;2238.3396897915154;2246.3485589179118;2247.910083596654;2254.7068881045525;8885.600147993357;8934.73195804127;8936.151065648754;8967.641294348217;9052.140046695553;5112;5242.580593552507;5394.514493695547;5402.054640437907;5402.756875940592;3364.680355366236;3521.964780352215;3547.8048707321086;3567.0547304964207;3600.369935261319;1138.2032577195914;1174.5125772804276;1221.151299846607;1222.5171057432353;2211.557688462298;11968.940155299168;12322.322272275022;12394.690132746664;12395.380230988505;12448.25310481374;4436.44544431946;4648;4662.160811054043;4665.650076244296;4709.152352576569;9659.855102173473;9691.563879625433;9706.611735530641;9766.75583110428;9863.260255480867;5151.896962060738;5229.712365819916;5244.134717771525;5246.632735708464;5283.128283833202;4381.759003254788;4810.7835147418455;4831.879203019882;4957.182064959241;4966.1061009018;3793.336166170909;3813.790241536742;3864.8260828262796;3899.9610003900166;3921.7254792164845;1176.088531388181;1179.5812486567145;1200.0519589524179;1201.08117290273;1212.8120141378101;965.0542468381026;966.8936416994125;980.6567701304486;994.4530508220449;995.6415690351467;5831.912521312183;6004.0693692477735;6018.337982821886;6039.909401358983;6093.146959425684;961.1205746741792;990.4799980010408;995.1740055753708;1003.3227571389283;1027.6762819711766;4055.330870406409;4164.12553363797;4211.578842115764;4220.6412454941055;4251.723637963522;10971.945140274247;11222.214444988937;11224.32654040744;11254.831177532344;11316.321020738782;10659.573617055232;10932.289401188897;11195.720106997227;11219.60731374398;11273.379964101889;8176.528224919452;8250.958745206115;8270.462419942685;8313.750587482386;8314.958425207957;5891.49922256613;5989.251343582052;5994.340622531605;6132.049532322497;6152.938470615237;9892.911779704371;9897.50512474359;9903.108720215216;10090.747731306776;10139.087482126644;10070.093691567794;10218.948905255724;10230.590776368861;10243.487825608541;10253.794924101625;7195.424366050599;7795.922040779747;7822.804429889071;7836.92163078362;8008.239217274349;8549.487030778173;8603.569821508774;8612.440191387539;8641.8703719443;8643.265322447662;7872.56700881457;7911.406644501571;7937.206279372017;8075.111737708965;8096.068952070352;7736.1877002916135;7846;7848.332891704041;7895.960520197592;7928.048634163937;6824.351686589965;7048.506604537633;7143.6428178591905;7144.892826607709;7169.856602868018;4941.160002799605;5105.693658380509;5136.948630513647;5178.249153872743;5256.132738098324;4907.484714104968;4986.975065124651;5127.333446651912;5251.763670634907;5444.047291724011 16:51:31 INFO - PROCESS | 5515 | |4;prototype.html;322.8321272938072;330.46464727142035;336.67342677602716;338.3875185913497;342.13439996808086;5584.162375643646;5589.552835773138;5627.43725627437;5702.657840529566;5724.771009159634;5517.310336207974;5529.30883639545;5533.750981205845;5557.3886872444;5566.471185237396;4261.296886013804;4309.138172365524;4334.696571240014;4350.890522916659;4352.325389564622;4310.245707001262;4318.870433886988;4321.027768752021;4335.761533115678;4396.6043056124945;4353.238183317922;4370.317427790308;4375.824967001332;4382.145481631083;4391.5827996340295;4208.263553878074;4337.787728258595;4341.283688191476;4373.628241599468;4395.230834603932;3836.0985168485386;3836.848945316394;3887.630675085862;3888.5333759948703;3916.295066887959;5503.367112782042;5529.198266251411;5546.4453554644615;5571.387147413781;5583.581231407661;4911.189653707134;5027.49725027498;5037.345145131146;5037.647364684473;5057;5821.708914554255;5828.6502809831545;5852.268466441695;5862.97068514659;5865.530757539429;4260;4279.486461624594;4288.142371525676;4294.849680261207;4301.397804307399;5774.393688662672;6044.667543285118;6075.939240607581;6076.696165191723;6118.449339559416;4187.937180942288;4235.216484950294;4237.194932962727;4258.339957306623;4261.21167583998;4295.603928723178;4319;4321.395004699345;4323.589259020388;4326.502452218036;4793.089313030513;4945.9752701236985;4971.726555039508;4981.775820088033;5000.499950004971;5908.527317814564;5927.347991720907;5941.376155503696;5945.583809133319;6043.546733994968;1484.7327481053514;1538.692261547695;1566.295167174776;1573.3156077106496;1577.7317855964513;991.8660980767504;998.83519219328;1002.6540843409012;1006.6527048168371;1014.60937539048;5022.769421491685;5039.924401133986;5042;5054.570361519239;5054.696718196847;5324.361076670747;5348.598855085884;5350.839474815762;5378.547792096112;5390.4879036491475;5031;5448.318960129984;5565.860853478695;5715.5713321500225;5743.592819759102;3201.551782750417;3229.580154579937;3239.586508051517;3242.3353212591364;3244.0754385000164;6050.304215015241;6105;6205;6206.875862482815;6239.220097487814;6091.903457377626;6155.353687862799;6158.846028849314;6183.350748171467;6191.721372538246;6077.315191304541;6156.538259630545;6184;6194.34959329273;6194.690265486708;5882.264716910387;5976.282846058327;5985.461308482258;6021.397860213943;6056.5154787616;5973.223480947449;5973.462388385066;5983;5998.88002239944;6014.6391216527145;6007.361382796805;6014.789482368096;6214.161088253028;6218.471429928326;6258.468030217483;4372.737635741739;4377.321515165155;4394.340848872567;4397.164538737629;4414.006848459199;6094.634321940698;6097.512199023979;6122.265328160649;6138.508919286357;6140.587664837201;5681.517071048842;5903.321118071477;5932.466078052996;5981.3420523743225;6031.638101713911;5881.617694849821;5938.138969849434;5939.1982082420045;5942.316633587193;5974.1636170935235;5601.487598348342;5729.369769325454;5826.359100498857;5841.299044114733;5845.100342388656;5954.315253745702;5966.433188847052;5985.610935289193;5992.280926288873;6000.489958353589;5363.624546281723;5790.739416726342;5811.1573821794755;5818.185454036523;5847.918135145012 16:51:31 INFO - PROCESS | 5515 | |5;yui.html;796.8366484870602;799.2806474173246;808.1595141053305;812.3420029775882;854.4659587757651;15251.466198683049;16386.180690965448;16644.58388540287;16672.416465423714;16727.414540491085;14612.415503379878;14789.482368117118;15149.697006059872;15180.848191518082;15188.620284492865;673.4511373230825;801.2668408406316;811.7848770075905;815.7022686719364;816.0411516468126;787.1970589998199;816.8611336072881;817.3461231015194;819.8073452738631;820.4134044158426;849.8427790858711;852.9914700853005;854.1543871567166;854.4659587757651;857.3655494933766;848.7156802471179;849.5412477262271;851.2721623012297;855.1021427501099;856.3491746272815;607.4563265877015;610.5603965145089;610.758750293636;615.7998650438581;616.4051690119056;14842.332095055748;14925.2537373132;15000.099994000395;15048;15075.54773356801;15154.545363639108;15398.692026159413;15519.922400387926;15528.456504022304;15547.766783498257;11765.705857353549;12074.939625301906;12117.33354665493;12290.938545307215;12840.486380544768;3886.4947556817433;3890.9805450972563;4054.148628787958;4094.1197642506704;4128.401381799622;72472;73167;73307;73478.63260683662;73768.63115684387;11511.366874821797;11925.821112683318;11952.581659642045;12082.516699332104;12086.576969806014;19459.318923837596;22520.887395562917;22592.09631614717;22631.547369052525;22672.206472773374;8670.566471676391;8811.823763524693;8904.554772261361;9026.18764311215;9053;4856.902861942742;4982.601391888713;5002.74986250686;5019.472955339636;5083.949160508421;3759.3045286622064;3853.1523064925673;3862.787546684903;3865.9226815464094;3866.497355343787;652.0838222297584;652.5334385914094;659.7987613777748;672.801523550544;686.193722376206;654.2541502686846;687.6355531568277;696.689972962027;736.6059158350257;798.2935102434387;10138.493075346203;10447.724172144362;10512.264141510173;10575.259731818698;10607.893921060691;567.9119736440858;587.7883961773758;623.2240860129077;676.8037269191977;727.7598392530558;4714.905701885943;5004.699718016931;5006.899862002812;5013.1227035268685;5015.774290156952;67519.3248067513;77454;88203.55898220467;116872;117674;62075.689621552505;64609;70264;87046.56476717576;90055.54972225097;54978.725106374215;76351.61824190844;85601;86735.56632216925;87645.56177219073;9719.611215551298;9808.705738827846;9903.900960990299;10002.44986525719;10026.598936042477;51758;51972;52611;52767.20849187342;54921.72539137279;73861.63069184619;74027;74712;77375;77486;12246.326452045223;12311.69220769488;12428;12506.124571279923;12686.429110690226;13056.020798440344;14118.647033824236;14125.876905343841;14212.21832799206;14884.925575372054;12867.292298923649;13006.154599950973;13234.205947643171;13245.139065960682;13263.469461221828;12706.36468176569;13082.084254102121;13310.800337995131;13331.400086995915;13592.252426116658;12241.632751017483;12422.440990155645;13337.866621333662;13677.86322136766;13787.241701706502;11217.851249557702;11433;11865.703357416134;11924.463399146885;12068.871003911852;11750.17748757613;11932.522699091938;12119.636410907335;12176.452059657513;12290.139690221598 16:51:31 INFO - PROCESS | 5515 | __end_tp_report 16:51:31 INFO - PROCESS | 5515 | __start_cc_report 16:51:31 INFO - PROCESS | 5515 | _x_x_mozilla_cycle_collect,343 16:51:31 INFO - PROCESS | 5515 | __end_cc_report 16:51:31 INFO - PROCESS | 5515 | __startTimestamp1465516291591__endTimestamp 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | ------- Summary: start ------- 16:51:31 INFO - PROCESS | 5515 | Number of tests: 6 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | [#0] dojo.html Cycles:165 Average:5456.12 Median:5699.43 stddev:748.54 (13.1%) stddev-sans-first:726.99 16:51:31 INFO - PROCESS | 5515 | Values: 3067.2 3098.2 3099.8 3135.9 3136.3 5403.1 5413.9 5447.3 5493.9 5509.4 5379.7 5411.5 5452.6 5479.5 5532.8 4902.5 4946.4 5053.9 5114.2 5164.3 492.4 4925.7 4939.8 4956.8 5127.3 4957.4 4966.5 5029.2 5033.9 5040.2 5018.1 5022.3 5029.5 5039.4 5068.1 4912.7 4963.4 4977.7 4991.6 4992.1 5482.6 5487.5 5497.8 5569.4 5600.2 5673.1 5861.4 5893.6 5940.0 5946.8 5860.2 5974.4 5990.3 5993.1 6043.2 5587.4 5589.6 5593.0 5596.0 5596.4 5809.4 5966.2 6028.8 6075.3 6089.2 5838.6 5842.4 5849.9 5854.9 5888.1 5917.3 5917.5 5919.9 5925.2 5931.2 5635.0 5840.2 5863.0 5882.2 5901.5 5819.1 5873.2 5878.0 5896.4 5926.8 4473.2 4474.8 4483.6 4502.6 4503.2 3928.1 3954.9 3976.5 4018.5 4038.8 5570.4 5620.6 5625.0 5631.9 5693.1 5954.0 5954.2 5974.9 5988.4 5995.4 5494.6 5549.1 5639.1 5667.0 5701.8 5116.8 5129.8 5143.7 5143.7 5150.8 5941.4 6194.2 6197.8 6201.3 6212.2 5861.4 5868.6 5874.3 5916.3 5922.2 6061.8 6087.2 6091.2 6095.2 6099.7 5726.5 5802.2 5828.9 5840.7 5848.8 5857.4 5926.6 5971.8 5973.7 6027.3 5705.5 5805.5 5813.0 5832.2 5838.9 5689.1 5719.8 5736.9 5798.2 5819.1 5654.8 5666.9 5699.4 5720.1 5743.4 5810.2 5819.1 5868.0 5871.3 5891.3 5587.7 5656.8 5667.2 5721.2 5724.5 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | [#1] ext.html Cycles:180 Average:60758.23 Median:22852.47 stddev:129902.47 (568.4%) stddev-sans-first:130188.23 16:51:31 INFO - PROCESS | 5515 | Values: 552.9 601.2 616.8 620.9 645.6 39535.8 45040.5 45451.1 45488.1 45569.1 44663.3 45000.1 45244.0 45359.1 45557.3 8865.1 9041.9 9044.0 9046.5 9087.0 8928.1 9026.1 9048.5 9052.5 9055.9 9095.8 9128.2 9141.4 9143.5 9146.3 9035.8 9046.5 9047.2 9049.6 9067.4 8873.1 8944.3 8950.5 8958.0 8980.2 34876.1 42883.4 43364.0 43389.1 43502.3 3399.3 3497.8 3655.4 3901.6 4242.8 31157.5 31581.7 31727.2 32343.0 32761.2 4149.4 4193.6 4199.2 4228.7 4232.1 302449.0 303287.0 304003.0 304491.0 305368.0 29945.3 31260.0 31383.5 31434.7 31458.5 30763.0 31400.2 31530.4 31666.7 31725.5 15114.0 15238.8 15263.9 15264.8 15370.9 12971.0 13105.6 13117.0 13160.7 13178.1 6711.6 6713.7 6719.2 6753.9 6797.3 2680.9 2759.3 2785.1 2793.1 2807.7 1005.2 1156.7 1168.7 1173.9 1201.6 32329.5 32408.4 32657.8 32815.8 32921.7 1116.1 1127.5 1128.2 1129.7 1140.4 16242.4 16245.7 16479.8 16625.3 16725.8 575564.0 579995.4 581948.0 583544.0 586019.0 55811.4 56141.2 56405.0 56542.2 56887.7 1332.2 1396.8 1403.4 1409.4 1412.2 28808.3 30277.4 30729.5 30742.8 31031.7 50088.0 50355.0 50912.5 50945.0 50948.5 524051.0 525329.0 528717.0 528775.0 530456.0 24273.4 24381.9 24614.4 25738.6 26632.3 50879.0 51045.7 51548.0 51886.5 51929.5 41670.8 42444.6 42952.8 43070.6 43423.1 40703.6 41207.8 41555.6 41760.4 42515.8 41212.2 41414.4 43083.4 44879.6 45085.3 34156.7 36083.8 36127.8 36649.0 36684.6 26951.3 27421.9 27716.6 27723.8 27771.6 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | [#2] jquery.html Cycles:180 Average:28022.47 Median:37316.53 stddev:81066.28 (217.2%) stddev-sans-first:81267.12 16:51:31 INFO - PROCESS | 5515 | Values: 375.8 380.8 397.8 401.6 409.3 14578.7 18184.6 18488.8 20213.8 20282.7 18405.0 18793.5 19106.0 19169.4 19429.0 5458.9 5569.2 5662.7 5676.4 5768.9 5678.7 5764.9 5778.3 5788.0 5811.5 5432.4 5658.3 5667.3 5716.3 5745.2 5600.2 5617.4 5623.2 5630.5 5672.6 5013.0 5025.5 5168.2 5192.7 5195.4 19535.5 20517.9 20727.9 22523.4 22627.0 2369.7 2387.7 2486.7 2878.9 2930.8 10196.1 10202.5 10230.5 12022.9 14737.0 1906.7 1950.6 1986.7 2028.2 2040.0 74676.0 75614.0 75833.0 76245.6 78204.6 10532.9 10552.2 10704.4 10755.4 10825.5 14688.2 14984.6 14992.3 15004.4 15022.9 7758.7 8103.6 8115.8 8186.2 8197.8 7927.4 7939.1 8019.0 8108.4 8120.3 4521.9 4556.5 4601.1 4646.7 4682.0 1892.8 1912.0 1929.5 1930.0 1982.3 898.7 913.9 971.0 1025.2 1078.9 17539.6 18474.4 18762.2 18881.5 19286.3 1002.6 1012.5 1013.8 1018.2 1045.5 10305.9 10727.5 10812.5 10828.6 11004.6 474941.0 480000.0 496358.0 508448.0 510522.0 62307.4 62386.0 79708.6 80693.2 87057.0 945.6 946.2 963.0 970.2 990.1 16840.2 16846.7 16863.6 17078.9 17341.1 37297.4 37335.6 38024.6 38621.4 39089.6 50574.5 50914.7 51897.0 53623.5 61097.8 8292.2 8304.4 8320.8 8387.8 8526.7 9092.5 11956.4 12521.8 12609.7 12712.9 10929.2 10955.6 11150.9 11312.3 11509.7 11085.8 11272.0 11276.7 11503.1 11740.2 8990.8 11261.7 11321.8 11485.5 11497.7 6693.5 7027.9 8369.1 8503.5 8616.3 10036.3 10909.9 10911.2 11010.2 11075.7 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | [#3] mootools.html Cycles:180 Average:5833.30 Median:4976.54 stddev:3290.33 (66.1%) stddev-sans-first:3283.17 16:51:31 INFO - PROCESS | 5515 | Values: 1462.4 1469.4 1574.4 1694.8 1760.1 7900.9 8506.2 8511.2 9065.8 9072.1 8568.0 8765.6 8852.3 8853.4 8964.0 2349.6 2391.3 2391.6 2402.3 2408.1 2313.8 2334.7 2385.0 2386.6 2407.4 2349.0 2360.7 2364.3 2383.5 2387.2 2298.0 2302.8 2307.5 2310.7 2317.4 2236.5 2238.3 2246.3 2247.9 2254.7 8885.6 8934.7 8936.2 8967.6 9052.1 5112.0 5242.6 5394.5 5402.1 5402.8 3364.7 3522.0 3547.8 3567.1 3600.4 1138.2 1174.5 1221.2 1222.5 2211.6 11968.9 12322.3 12394.7 12395.4 12448.3 4436.4 4648.0 4662.2 4665.7 4709.2 9659.9 9691.6 9706.6 9766.8 9863.3 5151.9 5229.7 5244.1 5246.6 5283.1 4381.8 4810.8 4831.9 4957.2 4966.1 3793.3 3813.8 3864.8 3900.0 3921.7 1176.1 1179.6 1200.1 1201.1 1212.8 965.1 966.9 980.7 994.5 995.6 5831.9 6004.1 6018.3 6039.9 6093.1 961.1 990.5 995.2 1003.3 1027.7 4055.3 4164.1 4211.6 4220.6 4251.7 10971.9 11222.2 11224.3 11254.8 11316.3 10659.6 10932.3 11195.7 11219.6 11273.4 8176.5 8251.0 8270.5 8313.8 8315.0 5891.5 5989.3 5994.3 6132.0 6152.9 9892.9 9897.5 9903.1 10090.7 10139.1 10070.1 10218.9 10230.6 10243.5 10253.8 7195.4 7795.9 7822.8 7836.9 8008.2 8549.5 8603.6 8612.4 8641.9 8643.3 7872.6 7911.4 7937.2 8075.1 8096.1 7736.2 7846.0 7848.3 7896.0 7928.0 6824.4 7048.5 7143.6 7144.9 7169.9 4941.2 5105.7 5136.9 5178.2 5256.1 4907.5 4987.0 5127.3 5251.8 5444.0 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | [#4] prototype.html Cycles:180 Average:4917.17 Median:5540.10 stddev:1438.12 (26.0%) stddev-sans-first:1400.20 16:51:31 INFO - PROCESS | 5515 | Values: 322.8 330.5 336.7 338.4 342.1 5584.2 5589.6 5627.4 5702.7 5724.8 5517.3 5529.3 5533.8 5557.4 5566.5 4261.3 4309.1 4334.7 4350.9 4352.3 4310.2 4318.9 4321.0 4335.8 4396.6 4353.2 4370.3 4375.8 4382.1 4391.6 4208.3 4337.8 4341.3 4373.6 4395.2 3836.1 3836.8 3887.6 3888.5 3916.3 5503.4 5529.2 5546.4 5571.4 5583.6 4911.2 5027.5 5037.3 5037.6 5057.0 5821.7 5828.7 5852.3 5863.0 5865.5 4260.0 4279.5 4288.1 4294.8 4301.4 5774.4 6044.7 6075.9 6076.7 6118.4 4187.9 4235.2 4237.2 4258.3 4261.2 4295.6 4319.0 4321.4 4323.6 4326.5 4793.1 4946.0 4971.7 4981.8 5000.5 5908.5 5927.3 5941.4 5945.6 6043.5 1484.7 1538.7 1566.3 1573.3 1577.7 991.9 998.8 1002.7 1006.7 1014.6 5022.8 5039.9 5042.0 5054.6 5054.7 5324.4 5348.6 5350.8 5378.5 5390.5 5031.0 5448.3 5565.9 5715.6 5743.6 3201.6 3229.6 3239.6 3242.3 3244.1 6050.3 6105.0 6205.0 6206.9 6239.2 6091.9 6155.4 6158.8 6183.4 6191.7 6077.3 6156.5 6184.0 6194.3 6194.7 5882.3 5976.3 5985.5 6021.4 6056.5 5973.2 5973.5 5983.0 5998.9 6014.6 6007.4 6014.8 6214.2 6218.5 6258.5 4372.7 4377.3 4394.3 4397.2 4414.0 6094.6 6097.5 6122.3 6138.5 6140.6 5681.5 5903.3 5932.5 5981.3 6031.6 5881.6 5938.1 5939.2 5942.3 5974.2 5601.5 5729.4 5826.4 5841.3 5845.1 5954.3 5966.4 5985.6 5992.3 6000.5 5363.6 5790.7 5811.2 5818.2 5847.9 16:51:31 INFO - PROCESS | 5515 | 16:51:31 INFO - PROCESS | 5515 | [#5] yui.html Cycles:180 Average:19429.41 Median:4919.75 stddev:26265.46 (533.9%) stddev-sans-first:26301.88 16:51:31 INFO - PROCESS | 5515 | Values: 796.8 799.3 808.2 812.3 854.5 15251.5 16386.2 16644.6 16672.4 16727.4 14612.4 14789.5 15149.7 15180.8 15188.6 673.5 801.3 811.8 815.7 816.0 787.2 816.9 817.3 819.8 820.4 849.8 853.0 854.2 854.5 857.4 848.7 849.5 851.3 855.1 856.3 607.5 610.6 610.8 615.8 616.4 14842.3 14925.3 15000.1 15048.0 15075.5 15154.5 15398.7 15519.9 15528.5 15547.8 11765.7 12074.9 12117.3 12290.9 12840.5 3886.5 3891.0 4054.1 4094.1 4128.4 72472.0 73167.0 73307.0 73478.6 73768.6 11511.4 11925.8 11952.6 12082.5 12086.6 19459.3 22520.9 22592.1 22631.5 22672.2 8670.6 8811.8 8904.6 9026.2 9053.0 4856.9 4982.6 5002.7 5019.5 5083.9 3759.3 3853.2 3862.8 3865.9 3866.5 652.1 652.5 659.8 672.8 686.2 654.3 687.6 696.7 736.6 798.3 10138.5 10447.7 10512.3 10575.3 10607.9 567.9 587.8 623.2 676.8 727.8 4714.9 5004.7 5006.9 5013.1 5015.8 67519.3 77454.0 88203.6 116872.0 117674.0 62075.7 64609.0 70264.0 87046.6 90055.5 54978.7 76351.6 85601.0 86735.6 87645.6 9719.6 9808.7 9903.9 10002.4 10026.6 51758.0 51972.0 52611.0 52767.2 54921.7 73861.6 74027.0 74712.0 77375.0 77486.0 12246.3 12311.7 12428.0 12506.1 12686.4 13056.0 14118.6 14125.9 14212.2 14884.9 12867.3 13006.2 13234.2 13245.1 13263.5 12706.4 13082.1 13310.8 13331.4 13592.3 12241.6 12422.4 13337.9 13677.9 13787.2 11217.9 11433.0 11865.7 11924.5 12068.9 11750.2 11932.5 12119.6 12176.5 12290.1 16:51:31 INFO - PROCESS | 5515 | -------- Summary: end -------- 16:51:31 INFO - PROCESS | 5515 | 16:51:32 INFO - TEST-INFO | 5515: exit 0 16:51:32 INFO - TEST-OK | dromaeo_css | took 1111323ms 16:51:32 INFO - TEST-START | kraken 16:51:32 INFO - operating with platform_type : linux_ 16:51:32 INFO - Initialising browser for kraken test... 16:51:32 INFO - TEST-INFO | started process 5751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmpGEi/profile http://localhost:60008/getInfo.html) 16:51:37 INFO - PROCESS | 5751 | __metrics Screen width/height:1600/1200 16:51:37 INFO - PROCESS | 5751 | colorDepth:24 16:51:37 INFO - PROCESS | 5751 | Browser inner width/height: 1024/697 16:51:37 INFO - PROCESS | 5751 | __metrics 16:51:38 ERROR - PROCESS | 5751 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:51:39 INFO - TEST-INFO | 5751: exit 0 16:51:39 INFO - Browser initialized. 16:51:39 INFO - Running cycle 1/1 for kraken test... 16:51:39 INFO - TEST-INFO | started process 5873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmpGEi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:51 INFO - PROCESS | 5873 | RSS: Main: 184770560 16:51:51 INFO - PROCESS | 5873 | 16:51:53 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60008/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:54 INFO - PROCESS | 5873 | RSS: Main: 190623744 16:51:54 INFO - PROCESS | 5873 | 16:51:57 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60008/tests/kraken/driver.html?testName=audio-dft) 16:51:57 INFO - PROCESS | 5873 | RSS: Main: 190021632 16:51:57 INFO - PROCESS | 5873 | 16:52:00 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60008/tests/kraken/driver.html?testName=audio-fft) 16:52:01 INFO - PROCESS | 5873 | RSS: Main: 185376768 16:52:01 INFO - PROCESS | 5873 | 16:52:03 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60008/tests/kraken/driver.html?testName=audio-oscillator) 16:52:04 INFO - PROCESS | 5873 | RSS: Main: 185425920 16:52:04 INFO - PROCESS | 5873 | 16:52:06 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:06 INFO - PROCESS | 5873 | RSS: Main: 185970688 16:52:06 INFO - PROCESS | 5873 | 16:52:10 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60008/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:10 INFO - PROCESS | 5873 | RSS: Main: 185835520 16:52:10 INFO - PROCESS | 5873 | 16:52:14 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60008/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:14 INFO - PROCESS | 5873 | RSS: Main: 183779328 16:52:14 INFO - PROCESS | 5873 | 16:52:17 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60008/tests/kraken/driver.html?testName=json-parse-financial) 16:52:18 INFO - PROCESS | 5873 | RSS: Main: 184778752 16:52:18 INFO - PROCESS | 5873 | 16:52:19 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:20 INFO - PROCESS | 5873 | RSS: Main: 185237504 16:52:20 INFO - PROCESS | 5873 | 16:52:22 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:22 INFO - PROCESS | 5873 | RSS: Main: 185835520 16:52:22 INFO - PROCESS | 5873 | 16:52:24 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:25 INFO - PROCESS | 5873 | RSS: Main: 186044416 16:52:25 INFO - PROCESS | 5873 | 16:52:28 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:28 INFO - PROCESS | 5873 | RSS: Main: 186859520 16:52:28 INFO - PROCESS | 5873 | 16:52:31 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:32 INFO - PROCESS | 5873 | RSS: Main: 185913344 16:52:32 INFO - PROCESS | 5873 | 16:52:33 INFO - PROCESS | 5873 | Cycle 1(1): loaded http://localhost:60008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60008/tests/kraken/driver.html?testName=ai-astar) 16:52:34 INFO - PROCESS | 5873 | RSS: Main: 186757120 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | __start_tp_report 16:52:34 INFO - PROCESS | 5873 | _x_x_mozilla_page_load 16:52:34 INFO - PROCESS | 5873 | _x_x_mozilla_page_load_details 16:52:34 INFO - PROCESS | 5873 | |i|pagename|runs| 16:52:34 INFO - PROCESS | 5873 | |0;ai-astar;113;104;114;111;111;111;111;111;112;110 16:52:34 INFO - PROCESS | 5873 | |1;audio-beat-detection;159;128;159;176;128;155;153;140;199;127 16:52:34 INFO - PROCESS | 5873 | |2;audio-dft;164;161;162;162;167;175;162;164;162;161 16:52:34 INFO - PROCESS | 5873 | |3;audio-fft;76;77;75;158;75;76;75;75;165;76 16:52:34 INFO - PROCESS | 5873 | |4;audio-oscillator;87;86;144;86;85;85;145;87;85;143 16:52:34 INFO - PROCESS | 5873 | |5;imaging-gaussian-blur;117;118;117;118;119;117;117;117;118;117 16:52:34 INFO - PROCESS | 5873 | |6;imaging-darkroom;147;148;146;147;147;148;146;148;147;146 16:52:34 INFO - PROCESS | 5873 | |7;imaging-desaturate;96;98;96;96;96;95;96;96;95;96 16:52:34 INFO - PROCESS | 5873 | |8;json-parse-financial;57;60;54;57;56;55;54;54;54;56 16:52:34 INFO - PROCESS | 5873 | |9;json-stringify-tinderbox;61;61;60;61;61;62;60;61;60;62 16:52:34 INFO - PROCESS | 5873 | |10;stanford-crypto-aes;79;80;79;86;85;87;81;82;106;82 16:52:34 INFO - PROCESS | 5873 | |11;stanford-crypto-ccm;130;129;123;121;122;128;135;131;136;130 16:52:34 INFO - PROCESS | 5873 | |12;stanford-crypto-pbkdf2;162;164;164;174;166;162;162;165;161;162 16:52:34 INFO - PROCESS | 5873 | |13;stanford-crypto-sha256-iterative;66;64;66;65;73;66;64;66;63;68 16:52:34 INFO - PROCESS | 5873 | __end_tp_report 16:52:34 INFO - PROCESS | 5873 | __start_cc_report 16:52:34 INFO - PROCESS | 5873 | _x_x_mozilla_cycle_collect,882 16:52:34 INFO - PROCESS | 5873 | __end_cc_report 16:52:34 INFO - PROCESS | 5873 | __startTimestamp1465516354140__endTimestamp 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | ------- Summary: start ------- 16:52:34 INFO - PROCESS | 5873 | Number of tests: 14 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.66 (2.4%) stddev-sans-first:2.70 16:52:34 INFO - PROCESS | 5873 | Values: 113.0 104.0 114.0 111.0 111.0 111.0 111.0 111.0 112.0 110.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.00 stddev:23.12 (14.7%) stddev-sans-first:24.40 16:52:34 INFO - PROCESS | 5873 | Values: 159.0 128.0 159.0 176.0 128.0 155.0 153.0 140.0 199.0 127.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.27 (2.6%) stddev-sans-first:4.53 16:52:34 INFO - PROCESS | 5873 | Values: 164.0 161.0 162.0 162.0 167.0 175.0 162.0 164.0 162.0 161.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:36.25 (48.0%) stddev-sans-first:37.94 16:52:34 INFO - PROCESS | 5873 | Values: 76.0 77.0 75.0 158.0 75.0 76.0 75.0 75.0 165.0 76.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:85.50 stddev:28.10 (32.9%) stddev-sans-first:29.18 16:52:34 INFO - PROCESS | 5873 | Values: 87.0 86.0 144.0 86.0 85.0 85.0 145.0 87.0 85.0 143.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 16:52:34 INFO - PROCESS | 5873 | Values: 117.0 118.0 117.0 118.0 119.0 117.0 117.0 117.0 118.0 117.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 16:52:34 INFO - PROCESS | 5873 | Values: 147.0 148.0 146.0 147.0 147.0 148.0 146.0 148.0 147.0 146.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 16:52:34 INFO - PROCESS | 5873 | Values: 96.0 98.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:1.95 (3.5%) stddev-sans-first:2.01 16:52:34 INFO - PROCESS | 5873 | Values: 57.0 60.0 54.0 57.0 56.0 55.0 54.0 54.0 54.0 56.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 16:52:34 INFO - PROCESS | 5873 | Values: 61.0 61.0 60.0 61.0 61.0 62.0 60.0 61.0 60.0 62.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:82.00 stddev:8.00 (9.8%) stddev-sans-first:8.22 16:52:34 INFO - PROCESS | 5873 | Values: 79.0 80.0 79.0 86.0 85.0 87.0 81.0 82.0 106.0 82.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:130.00 stddev:5.15 (4.0%) stddev-sans-first:5.43 16:52:34 INFO - PROCESS | 5873 | Values: 130.0 129.0 123.0 121.0 122.0 128.0 135.0 131.0 136.0 130.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:3.79 (2.3%) stddev-sans-first:3.94 16:52:34 INFO - PROCESS | 5873 | Values: 162.0 164.0 164.0 174.0 166.0 162.0 162.0 165.0 161.0 162.0 16:52:34 INFO - PROCESS | 5873 | 16:52:34 INFO - PROCESS | 5873 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:2.81 (4.3%) stddev-sans-first:2.98 16:52:34 INFO - PROCESS | 5873 | Values: 66.0 64.0 66.0 65.0 73.0 66.0 64.0 66.0 63.0 68.0 16:52:34 INFO - PROCESS | 5873 | -------- Summary: end -------- 16:52:34 INFO - PROCESS | 5873 | 16:52:35 INFO - TEST-INFO | 5873: exit 0 16:52:35 INFO - TEST-OK | kraken | took 62782ms 16:52:35 INFO - SUITE-END | took 1174s 16:52:35 INFO - Completed test suite (00:19:34) 16:52:35 INFO - javascript benchmark 16:52:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7217.180301937842, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.171863596829, 3098.2409309719123, 3099.7985130966485, 3135.8745650173996, 3136.341368312654, 5403.135498320265, 5413.891722165555, 5447.291852059232, 5493.862653433666, 5509.3664228613725, 5379.704116273603, 5411.485908838664, 5452.6183167178315, 5479.479449452306, 5532.75102620382, 4902.460729319772, 4946.356973593446, 5053.9241911371355, 5114.181730923053, 5164.251183578398, 492.40507537640474, 4925.729084900329, 4939.8024079036795, 4956.752162391884, 5127.3078134451935, 4957.380327459067, 4966.453690094087, 5029.195328747401, 5033.874153146164, 5040.218766091261, 5018.096742586333, 5022.271770593244, 5029.5221953914315, 5039.420466646346, 5068.138416469173, 4912.656114072016, 4963.429205641325, 4977.7262250576205, 4991.600671946236, 4992.126377883892, 5482.5613950883835, 5487.506124448819, 5497.8075767347955, 5569.415211402826, 5600.1599760035915, 5673.120666296731, 5861.384554621746, 5893.58744887858, 5940.049592065248, 5946.791862284843, 5860.150278209679, 5974.4324289192455, 5990.311114221877, 5993.101034844764, 6043.214382130339, 5587.413321601254, 5589.636673616202, 5592.99326121294, 5595.972020139914, 5596.440355964371, 5809.448102430262, 5966.194563733927, 6028.788992385245, 6075.3317135115985, 6089.1779609753, 5838.649681019152, 5842.386549412336, 5849.88300233993, 5854.912176317359, 5888.087346461305, 5917.289925208916, 5917.467427931507, 5919.852003699942, 5925.170476133345, 5931.199288096138, 5635.042042852725, 5840.240768700041, 5862.970685146547, 5882.176495290662, 5901.468867801918, 5819.127130930309, 5873.236479257669, 5877.970610146922, 5896.380880007623, 5926.762929482858, 4473.172463094338, 4474.753888536096, 4483.574060464251, 4502.639788816887, 4503.166914120898, 3928.0965377962657, 3954.8615798446917, 3976.483057202603, 4018.4976877890263, 4038.757674539478, 5570.442955704397, 5620.57845661577, 5625.0, 5631.8592035199445, 5693.089105743061, 5954.0, 5954.225950626477, 5974.880502389928, 5988.431099045583, 5995.370486098984, 5494.587905906993, 5549.056660367747, 5639.0977443609645, 5666.97166514173, 5701.771929122871, 5116.846494605168, 5129.79480820763, 5143.691378517301, 5143.71709555978, 5150.793968241228, 5941.435563621449, 6194.163787888578, 6197.783077592353, 6201.286852012076, 6212.161358216673, 5861.443162899518, 5868.559858010666, 5874.265716785402, 5916.31962324321, 5922.200502932049, 6061.848453788691, 6087.208662873798, 6091.177691011834, 6095.238095238095, 6099.664518451527, 5726.513246374105, 5802.216700745345, 5828.94171058284, 5840.737166827418, 5848.795292164924, 5857.4435428634215, 5926.614770039933, 5971.7611295547695, 5973.701314934323, 6027.276726792813, 5705.543556515386, 5805.535557155333, 5813.04084825999, 5832.24180856486, 5838.912416313674, 5689.118186681071, 5719.771209151754, 5736.913946290892, 5798.217240672455, 5819.127130930395, 5654.802081927113, 5666.886662266814, 5699.430056994267, 5720.141978703228, 5743.4256574342235, 5810.157527158453, 5819.127130930395, 5868.0, 5871.324797648325, 5891.263592050994, 5587.74855131512, 5656.830295091154, 5667.20659107717, 5721.227634269487, 5724.484796368347], "value": 5405.6173409603425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9170624406338, 601.1523751510371, 616.7625464196286, 620.9130721698963, 645.6287634610095, 39535.80232098839, 45040.54959450409, 45451.090978180415, 45488.090238195255, 45569.088618227695, 44663.33005004928, 45000.09999800002, 45244.0, 45359.0928181437, 45557.31664025034, 8865.069167737376, 9041.909580904205, 9044.0, 9046.502442365667, 9087.045860184684, 8928.062553431893, 9026.142516460959, 9048.502332371718, 9052.547372631376, 9055.909440905572, 9095.772605684877, 9128.178463938244, 9141.360104792668, 9143.451392916413, 9146.268298536135, 9035.774105647346, 9046.457212567235, 9047.185753282203, 9049.638014479413, 9067.365284430092, 8873.06832782555, 8944.284457243404, 8950.462972221687, 8958.0, 8980.191782739585, 34876.12809679753, 42883.35674964878, 43364.0, 43389.13221735547, 43502.34746478805, 3399.3201359728155, 3497.7995134451944, 3655.3785856404475, 3901.551321597996, 4242.787860606957, 31157.532637010463, 31581.684183158104, 31727.20681982946, 32343.0, 32761.18097047593, 4149.356849688273, 4193.580641935812, 4199.223143718422, 4228.682848786353, 4232.090100628349, 302448.95102097833, 303287.0, 304003.0, 304491.0, 305367.9999999978, 29945.251368715955, 31260.0, 31383.529247061313, 31434.685653143177, 31458.528122078187, 30763.0, 31400.21499462486, 31530.36939261248, 31666.683333166835, 31725.524117138262, 15114.0, 15238.771418428732, 15263.923680381527, 15264.847351526343, 15370.923145384202, 12971.027172962065, 13105.606831795061, 13117.0, 13160.670983225496, 13178.077534572489, 6711.563748356341, 6713.69788359525, 6719.160104986877, 6753.898691519631, 6797.2523022467485, 2680.9463810724064, 2759.310172456886, 2785.080923295308, 2793.064323451626, 2807.6771171315154, 1005.1757558801859, 1156.7333769522359, 1168.6727716239466, 1173.9024012548296, 1201.6478041670941, 32329.51505727416, 32408.35183296321, 32657.836710816293, 32815.835920820246, 32921.67078329234, 1116.1294190531398, 1127.5320741892187, 1128.2046157458972, 1129.6554550862065, 1140.4126874659557, 16242.350305987864, 16245.675086498204, 16479.83520164807, 16625.3349866004, 16725.83274167267, 575564.0, 579995.4003219819, 581948.0, 583544.0, 586019.0, 55811.44188558144, 56141.15788263179, 56405.0, 56542.151867722016, 56887.71556142275, 1332.2206509192038, 1396.790481427794, 1403.39653948803, 1409.3587417724912, 1412.1668215752754, 28808.279793005342, 30277.394452111275, 30729.539056913716, 30742.826441675785, 31031.68968310288, 50088.0, 50355.0, 50912.49087509078, 50945.0, 50948.490515094374, 524051.0, 525329.0, 528717.0, 528775.0, 530456.0, 24273.39316517101, 24381.878090609433, 24614.384640384134, 25738.613920791577, 26632.334191645365, 50879.0, 51045.74477127591, 51548.0, 51886.481135188165, 51929.480705192465, 41670.79164604157, 42444.57555424406, 42952.78523607487, 43070.56929430665, 43423.13153736971, 40703.59296406998, 41207.79396103, 41555.58444415638, 41760.37359439672, 42515.7874210627, 41212.1757564841, 41414.37878431886, 43083.353749694405, 44879.551204487536, 45085.32372014488, 34156.65843341634, 36083.81958090193, 36127.81936090303, 36649.0, 36684.633153668125, 26951.326216844736, 27421.862890685417, 27716.58425123665, 27723.841423786595, 27771.583426249028], "value": 18508.6907926377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.75575875680806, 380.82101412336203, 397.7553804410289, 401.5602914808285, 409.2755822194715, 14578.708425831504, 18184.636307273864, 18488.81511184888, 20213.797862021376, 20282.6957595636, 18405.0, 18793.530161745963, 19106.0, 19169.424917252505, 19429.02854857255, 5458.918116228259, 5569.164625306196, 5662.716864156796, 5676.3755986841625, 5768.913466298009, 5678.716064196794, 5764.884702305952, 5778.335491418498, 5788.04497257952, 5811.506021988136, 5432.375276843174, 5658.321001479808, 5667.3482549506925, 5716.28546431696, 5745.195672605839, 5600.243967064435, 5617.4382561743905, 5623.240862483594, 5630.5495560355075, 5672.574556908227, 5013.0, 5025.497450254982, 5168.198929165986, 5192.688438693653, 5195.350581177353, 19535.511612209666, 20517.897410513, 20727.8963605181, 22523.436914077116, 22627.0, 2369.7037870266217, 2387.6657267982496, 2486.651868738378, 2878.942421151565, 2930.750886174678, 10196.133328667072, 10202.540885660163, 10230.488475576192, 12022.939885300604, 14737.042092264075, 1906.7044608085769, 1950.5513731841613, 1986.7317912081828, 2028.20899849059, 2039.9800099950025, 74676.0, 75614.0, 75833.0, 76245.61877190579, 78204.60897695532, 10532.947335263274, 10552.206124958775, 10704.411257380918, 10755.354678719303, 10825.458727063615, 14688.237411510474, 14984.550463486114, 14992.250387480583, 15004.399824006918, 15022.924885375503, 7758.650860711282, 8103.554304513308, 8115.837683246302, 8186.222308880647, 8197.79505512367, 7927.445078844541, 7939.126696063428, 8019.0, 8108.43240973138, 8120.309773669304, 4521.88695282614, 4556.521565235669, 4601.125786100697, 4646.7444290564345, 4681.99337142516, 1892.8138000609317, 1912.0267983285846, 1929.4983304340692, 1929.990350048269, 1982.2764690887723, 898.6630013744846, 913.9223166030962, 971.048372594861, 1025.220832167558, 1078.8813230544633, 17539.56151096233, 18474.44576662702, 18762.155702993397, 18881.52796180079, 19286.324978625682, 1002.6440613582073, 1012.5342342522375, 1013.7769690668041, 1018.165104614224, 1045.46158728255, 10305.948470257601, 10727.463626818628, 10812.459377031275, 10828.62099826518, 11004.559817607205, 474941.0, 480000.0, 496358.0, 508448.0, 510522.0, 62307.37692623016, 62386.0, 79708.60145699234, 80693.19306806974, 87057.0, 945.5697657565792, 946.2335508238349, 963.0321526865455, 970.1608108985818, 990.0841721407813, 16840.242189101766, 16846.66306673884, 16863.578410539834, 17078.914605426893, 17341.132943353034, 37297.440538391405, 37335.626643733216, 38024.61975380211, 38621.4206786904, 39089.60910390974, 50574.49425505845, 50914.74542627263, 51897.0, 53623.463765363405, 61097.80668643215, 8292.212239837207, 8304.377171712025, 8320.791980200544, 8387.790305242417, 8526.701565445428, 9092.545372731205, 11956.402179891145, 12521.812172817234, 12609.747805044031, 12712.936435318134, 10929.180311476512, 10955.616553420592, 11150.944245278723, 11312.264702794291, 11509.654710358702, 11085.778284434427, 11272.0, 11276.718082048015, 11503.137264705014, 11740.178187526792, 8990.820183596423, 11261.71845703864, 11321.830172547254, 11485.47319589689, 11497.655070347902, 6693.531452798257, 7027.859442811217, 8369.121242269473, 8503.489790612583, 8616.267617252604, 10036.347637403545, 10909.890901090888, 10911.181661375587, 11010.174236932102, 11075.667729968114], "value": 8944.096762595136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.3711803924311, 1469.3828591991364, 1574.3623832347896, 1694.8474637282643, 1760.137532609022, 7900.881486777688, 8506.234438900497, 8511.191436813508, 9065.773355666111, 9072.138146876045, 8567.957160214206, 8765.649374025048, 8852.291816654668, 8853.424527405714, 8964.0, 2349.600567903456, 2391.294568102414, 2391.6412538119334, 2402.267308470916, 2408.1089996701244, 2313.838031337807, 2334.743178250391, 2384.95230095398, 2386.5942789725786, 2407.434252950555, 2348.9530209395803, 2360.728516220631, 2364.326167042393, 2383.5113801670705, 2387.236084452976, 2298.0, 2302.827287953402, 2307.538492301538, 2310.7111611048617, 2317.3974766560814, 2236.4520692430297, 2238.3396897915154, 2246.3485589179118, 2247.910083596654, 2254.7068881045525, 8885.600147993357, 8934.73195804127, 8936.151065648754, 8967.641294348217, 9052.140046695553, 5112.0, 5242.580593552507, 5394.514493695547, 5402.054640437907, 5402.756875940592, 3364.680355366236, 3521.964780352215, 3547.8048707321086, 3567.0547304964207, 3600.369935261319, 1138.2032577195914, 1174.5125772804276, 1221.151299846607, 1222.5171057432353, 2211.557688462298, 11968.940155299168, 12322.322272275022, 12394.690132746664, 12395.380230988505, 12448.25310481374, 4436.44544431946, 4648.0, 4662.160811054043, 4665.650076244296, 4709.152352576569, 9659.855102173473, 9691.563879625433, 9706.611735530641, 9766.75583110428, 9863.260255480867, 5151.896962060738, 5229.712365819916, 5244.134717771525, 5246.632735708464, 5283.128283833202, 4381.759003254788, 4810.7835147418455, 4831.879203019882, 4957.182064959241, 4966.1061009018, 3793.336166170909, 3813.790241536742, 3864.8260828262796, 3899.9610003900166, 3921.7254792164845, 1176.088531388181, 1179.5812486567145, 1200.0519589524179, 1201.08117290273, 1212.8120141378101, 965.0542468381026, 966.8936416994125, 980.6567701304486, 994.4530508220449, 995.6415690351467, 5831.912521312183, 6004.0693692477735, 6018.337982821886, 6039.909401358983, 6093.146959425684, 961.1205746741792, 990.4799980010408, 995.1740055753708, 1003.3227571389283, 1027.6762819711766, 4055.330870406409, 4164.12553363797, 4211.578842115764, 4220.6412454941055, 4251.723637963522, 10971.945140274247, 11222.214444988937, 11224.32654040744, 11254.831177532344, 11316.321020738782, 10659.573617055232, 10932.289401188897, 11195.720106997227, 11219.60731374398, 11273.379964101889, 8176.528224919452, 8250.958745206115, 8270.462419942685, 8313.750587482386, 8314.958425207957, 5891.49922256613, 5989.251343582052, 5994.340622531605, 6132.049532322497, 6152.938470615237, 9892.911779704371, 9897.50512474359, 9903.108720215216, 10090.747731306776, 10139.087482126644, 10070.093691567794, 10218.948905255724, 10230.590776368861, 10243.487825608541, 10253.794924101625, 7195.424366050599, 7795.922040779747, 7822.804429889071, 7836.92163078362, 8008.239217274349, 8549.487030778173, 8603.569821508774, 8612.440191387539, 8641.8703719443, 8643.265322447662, 7872.56700881457, 7911.406644501571, 7937.206279372017, 8075.111737708965, 8096.068952070352, 7736.1877002916135, 7846.0, 7848.332891704041, 7895.960520197592, 7928.048634163937, 6824.351686589965, 7048.506604537633, 7143.6428178591905, 7144.892826607709, 7169.856602868018, 4941.160002799605, 5105.693658380509, 5136.948630513647, 5178.249153872743, 5256.132738098324, 4907.484714104968, 4986.975065124651, 5127.333446651912, 5251.763670634907, 5444.047291724011], "value": 4693.820910836475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8321272938072, 330.46464727142035, 336.67342677602716, 338.3875185913497, 342.13439996808086, 5584.162375643646, 5589.552835773138, 5627.43725627437, 5702.657840529566, 5724.771009159634, 5517.310336207974, 5529.30883639545, 5533.750981205845, 5557.3886872444, 5566.471185237396, 4261.296886013804, 4309.138172365524, 4334.696571240014, 4350.890522916659, 4352.325389564622, 4310.245707001262, 4318.870433886988, 4321.027768752021, 4335.761533115678, 4396.6043056124945, 4353.238183317922, 4370.317427790308, 4375.824967001332, 4382.145481631083, 4391.5827996340295, 4208.263553878074, 4337.787728258595, 4341.283688191476, 4373.628241599468, 4395.230834603932, 3836.0985168485386, 3836.848945316394, 3887.630675085862, 3888.5333759948703, 3916.295066887959, 5503.367112782042, 5529.198266251411, 5546.4453554644615, 5571.387147413781, 5583.581231407661, 4911.189653707134, 5027.49725027498, 5037.345145131146, 5037.647364684473, 5057.0, 5821.708914554255, 5828.6502809831545, 5852.268466441695, 5862.97068514659, 5865.530757539429, 4260.0, 4279.486461624594, 4288.142371525676, 4294.849680261207, 4301.397804307399, 5774.393688662672, 6044.667543285118, 6075.939240607581, 6076.696165191723, 6118.449339559416, 4187.937180942288, 4235.216484950294, 4237.194932962727, 4258.339957306623, 4261.21167583998, 4295.603928723178, 4319.0, 4321.395004699345, 4323.589259020388, 4326.502452218036, 4793.089313030513, 4945.9752701236985, 4971.726555039508, 4981.775820088033, 5000.499950004971, 5908.527317814564, 5927.347991720907, 5941.376155503696, 5945.583809133319, 6043.546733994968, 1484.7327481053514, 1538.692261547695, 1566.295167174776, 1573.3156077106496, 1577.7317855964513, 991.8660980767504, 998.83519219328, 1002.6540843409012, 1006.6527048168371, 1014.60937539048, 5022.769421491685, 5039.924401133986, 5042.0, 5054.570361519239, 5054.696718196847, 5324.361076670747, 5348.598855085884, 5350.839474815762, 5378.547792096112, 5390.4879036491475, 5031.0, 5448.318960129984, 5565.860853478695, 5715.5713321500225, 5743.592819759102, 3201.551782750417, 3229.580154579937, 3239.586508051517, 3242.3353212591364, 3244.0754385000164, 6050.304215015241, 6105.0, 6205.0, 6206.875862482815, 6239.220097487814, 6091.903457377626, 6155.353687862799, 6158.846028849314, 6183.350748171467, 6191.721372538246, 6077.315191304541, 6156.538259630545, 6184.0, 6194.34959329273, 6194.690265486708, 5882.264716910387, 5976.282846058327, 5985.461308482258, 6021.397860213943, 6056.5154787616, 5973.223480947449, 5973.462388385066, 5983.0, 5998.88002239944, 6014.6391216527145, 6007.361382796805, 6014.789482368096, 6214.161088253028, 6218.471429928326, 6258.468030217483, 4372.737635741739, 4377.321515165155, 4394.340848872567, 4397.164538737629, 4414.006848459199, 6094.634321940698, 6097.512199023979, 6122.265328160649, 6138.508919286357, 6140.587664837201, 5681.517071048842, 5903.321118071477, 5932.466078052996, 5981.3420523743225, 6031.638101713911, 5881.617694849821, 5938.138969849434, 5939.1982082420045, 5942.316633587193, 5974.1636170935235, 5601.487598348342, 5729.369769325454, 5826.359100498857, 5841.299044114733, 5845.100342388656, 5954.315253745702, 5966.433188847052, 5985.610935289193, 5992.280926288873, 6000.489958353589, 5363.624546281723, 5790.739416726342, 5811.1573821794755, 5818.185454036523, 5847.918135145012], "value": 4456.983987682332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.8366484870602, 799.2806474173246, 808.1595141053305, 812.3420029775882, 854.4659587757651, 15251.466198683049, 16386.180690965448, 16644.58388540287, 16672.416465423714, 16727.414540491085, 14612.415503379878, 14789.482368117118, 15149.697006059872, 15180.848191518082, 15188.620284492865, 673.4511373230825, 801.2668408406316, 811.7848770075905, 815.7022686719364, 816.0411516468126, 787.1970589998199, 816.8611336072881, 817.3461231015194, 819.8073452738631, 820.4134044158426, 849.8427790858711, 852.9914700853005, 854.1543871567166, 854.4659587757651, 857.3655494933766, 848.7156802471179, 849.5412477262271, 851.2721623012297, 855.1021427501099, 856.3491746272815, 607.4563265877015, 610.5603965145089, 610.758750293636, 615.7998650438581, 616.4051690119056, 14842.332095055748, 14925.2537373132, 15000.099994000395, 15048.0, 15075.54773356801, 15154.545363639108, 15398.692026159413, 15519.922400387926, 15528.456504022304, 15547.766783498257, 11765.705857353549, 12074.939625301906, 12117.33354665493, 12290.938545307215, 12840.486380544768, 3886.4947556817433, 3890.9805450972563, 4054.148628787958, 4094.1197642506704, 4128.401381799622, 72472.0, 73167.0, 73307.0, 73478.63260683662, 73768.63115684387, 11511.366874821797, 11925.821112683318, 11952.581659642045, 12082.516699332104, 12086.576969806014, 19459.318923837596, 22520.887395562917, 22592.09631614717, 22631.547369052525, 22672.206472773374, 8670.566471676391, 8811.823763524693, 8904.554772261361, 9026.18764311215, 9053.0, 4856.902861942742, 4982.601391888713, 5002.74986250686, 5019.472955339636, 5083.949160508421, 3759.3045286622064, 3853.1523064925673, 3862.787546684903, 3865.9226815464094, 3866.497355343787, 652.0838222297584, 652.5334385914094, 659.7987613777748, 672.801523550544, 686.193722376206, 654.2541502686846, 687.6355531568277, 696.689972962027, 736.6059158350257, 798.2935102434387, 10138.493075346203, 10447.724172144362, 10512.264141510173, 10575.259731818698, 10607.893921060691, 567.9119736440858, 587.7883961773758, 623.2240860129077, 676.8037269191977, 727.7598392530558, 4714.905701885943, 5004.699718016931, 5006.899862002812, 5013.1227035268685, 5015.774290156952, 67519.3248067513, 77454.0, 88203.55898220467, 116872.0, 117674.0, 62075.689621552505, 64609.0, 70264.0, 87046.56476717576, 90055.54972225097, 54978.725106374215, 76351.61824190844, 85601.0, 86735.56632216925, 87645.56177219073, 9719.611215551298, 9808.705738827846, 9903.900960990299, 10002.44986525719, 10026.598936042477, 51758.0, 51972.0, 52611.0, 52767.20849187342, 54921.72539137279, 73861.63069184619, 74027.0, 74712.0, 77375.0, 77486.0, 12246.326452045223, 12311.69220769488, 12428.0, 12506.124571279923, 12686.429110690226, 13056.020798440344, 14118.647033824236, 14125.876905343841, 14212.21832799206, 14884.925575372054, 12867.292298923649, 13006.154599950973, 13234.205947643171, 13245.139065960682, 13263.469461221828, 12706.36468176569, 13082.084254102121, 13310.800337995131, 13331.400086995915, 13592.252426116658, 12241.632751017483, 12422.440990155645, 13337.866621333662, 13677.86322136766, 13787.241701706502, 11217.851249557702, 11433.0, 11865.703357416134, 11924.463399146885, 12068.871003911852, 11750.17748757613, 11932.522699091938, 12119.636410907335, 12176.452059657513, 12290.139690221598], "value": 7548.1661173972125, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 114.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 159.0, 176.0, 128.0, 155.0, 153.0, 140.0, 199.0, 127.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 162.0, 162.0, 167.0, 175.0, 162.0, 164.0, 162.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 158.0, 75.0, 76.0, 75.0, 75.0, 165.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 144.0, 86.0, 85.0, 85.0, 145.0, 87.0, 85.0, 143.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 54.0, 57.0, 56.0, 55.0, 54.0, 54.0, 54.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 60.0, 61.0, 60.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 86.0, 85.0, 87.0, 81.0, 82.0, 106.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 123.0, 121.0, 122.0, 128.0, 135.0, 131.0, 136.0, 130.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 174.0, 166.0, 162.0, 162.0, 165.0, 161.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 65.0, 73.0, 66.0, 64.0, 66.0, 63.0, 68.0], "value": 66.1, "unit": "score"}]}]} 16:52:35 INFO - Return code: 0 16:52:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:35 ERROR - # TBPL SUCCESS # 16:52:35 INFO - Running post-action listener: _resource_record_post_action 16:52:35 INFO - ##### 16:52:35 INFO - ##### Finished run-tests step (success) 16:52:35 INFO - ##### 16:52:35 INFO - Running post-run listener: _resource_record_post_run 16:52:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541810688; Read time: 12; Write time: 516644 16:52:35 INFO - TinderboxPrint: CPU usage
13.5% 16:52:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:52:35 INFO - TinderboxPrint: I/O write bytes / time
541,810,688 / 516,644 16:52:35 INFO - TinderboxPrint: CPU idle
8,226.1 (86.5%) 16:52:35 INFO - TinderboxPrint: CPU user
1,223.6 (12.9%) 16:52:35 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246435840; Read time: 0; Write time: 239944 16:52:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292675584; Read time: 12; Write time: 274648 16:52:36 INFO - Running post-run listener: _upload_blobber_files 16:52:36 INFO - Blob upload gear active. 16:52:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:36 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:52:36 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:52:36 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:52:36 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:52:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:52:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:37 INFO - (blobuploader) - INFO - Done attempting. 16:52:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:52:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:52:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:37 INFO - (blobuploader) - INFO - Done attempting. 16:52:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:41 INFO - (blobuploader) - INFO - Done attempting. 16:52:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:41 INFO - Return code: 0 16:52:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/029dcd334c5740e69a86dd938b696eb9909d8116180a21bf0d3e63d7e64f1986426f39434ab05294f145599bc497b87f685db4bfcfb50d2405f58abc23a9161d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80b609189fec17838651bad485d3ba6caa52116dc4f3ab362c8894a028c0e36ba641194ca2d19b9f8d79f87ce96e03e75a2b2b930c617415350cb09f5ddaab65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f297e98f50d35b10f9eb01f07f103bea6eca4612d94f750e99ac96bb16c59f8ec4f64ec93423e3878626d7ec74bf4fafe42ca6dc8e256f05961fe96f323b7ff0"} 16:52:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:41 INFO - Contents: 16:52:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/029dcd334c5740e69a86dd938b696eb9909d8116180a21bf0d3e63d7e64f1986426f39434ab05294f145599bc497b87f685db4bfcfb50d2405f58abc23a9161d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80b609189fec17838651bad485d3ba6caa52116dc4f3ab362c8894a028c0e36ba641194ca2d19b9f8d79f87ce96e03e75a2b2b930c617415350cb09f5ddaab65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f297e98f50d35b10f9eb01f07f103bea6eca4612d94f750e99ac96bb16c59f8ec4f64ec93423e3878626d7ec74bf4fafe42ca6dc8e256f05961fe96f323b7ff0"} 16:52:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:41 INFO - Copying logs to upload dir... 16:52:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.801089 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-09 16:52:41.153954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:41.157725) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/029dcd334c5740e69a86dd938b696eb9909d8116180a21bf0d3e63d7e64f1986426f39434ab05294f145599bc497b87f685db4bfcfb50d2405f58abc23a9161d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80b609189fec17838651bad485d3ba6caa52116dc4f3ab362c8894a028c0e36ba641194ca2d19b9f8d79f87ce96e03e75a2b2b930c617415350cb09f5ddaab65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f297e98f50d35b10f9eb01f07f103bea6eca4612d94f750e99ac96bb16c59f8ec4f64ec93423e3878626d7ec74bf4fafe42ca6dc8e256f05961fe96f323b7ff0"} build_url:https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/X5ScYxYoQauPA__11W7O1g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/029dcd334c5740e69a86dd938b696eb9909d8116180a21bf0d3e63d7e64f1986426f39434ab05294f145599bc497b87f685db4bfcfb50d2405f58abc23a9161d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/80b609189fec17838651bad485d3ba6caa52116dc4f3ab362c8894a028c0e36ba641194ca2d19b9f8d79f87ce96e03e75a2b2b930c617415350cb09f5ddaab65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f297e98f50d35b10f9eb01f07f103bea6eca4612d94f750e99ac96bb16c59f8ec4f64ec93423e3878626d7ec74bf4fafe42ca6dc8e256f05961fe96f323b7ff0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:41.185359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:41.185749) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465515124.527689-1175502577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:52:41.271625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:52:41.272026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:52:41.272372) ========= ========= Total master_lag: 0.18 =========