builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1466573160.91 results: success (0) buildid: 20160621193053 builduid: 7703d35387e5418f8ceb45ca8542e06f revision: 587331c6f44b49dd2126eb5cc7a2e9799d3dc084 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:00.907412) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:00.907906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:00.908223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:00.938211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:00.938790) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 22:26:01-- 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% 43.1M=0s 2016-06-21 22:26:01 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090350 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:01.043240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:01.043591) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015592 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:01.094923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 22:26:01.095734) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 587331c6f44b49dd2126eb5cc7a2e9799d3dc084 --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 587331c6f44b49dd2126eb5cc7a2e9799d3dc084 --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=a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 22:26:01,252 truncating revision to first 12 chars 2016-06-21 22:26:01,253 Setting DEBUG logging. 2016-06-21 22:26:01,253 attempt 1/10 2016-06-21 22:26:01,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/587331c6f44b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 22:26:02,263 unpacking tar archive at: mozilla-inbound-587331c6f44b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 22:26:02.481757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:02.482111) ========= script_repo_revision: 587331c6f44b49dd2126eb5cc7a2e9799d3dc084 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:02.482613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:02.482922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 22:26:02.493955) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-21 22:26:02.494311) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:26:02 INFO - MultiFileLogger online at 20160621 22:26:02 in /builds/slave/test 22:26:02 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 22:26:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:26:02 INFO - {'append_to_log': False, 22:26:02 INFO - 'base_work_dir': '/builds/slave/test', 22:26:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:26:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:26:02 INFO - 'branch': 'Mozilla-Inbound', 22:26:02 INFO - 'buildbot_json_path': 'buildprops.json', 22:26:02 INFO - 'config_files': ('talos/linux_config.py',), 22:26:02 INFO - 'default_actions': ('clobber', 22:26:02 INFO - 'read-buildbot-config', 22:26:02 INFO - 'download-and-extract', 22:26:02 INFO - 'populate-webroot', 22:26:02 INFO - 'create-virtualenv', 22:26:02 INFO - 'install', 22:26:02 INFO - 'run-tests'), 22:26:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:26:02 INFO - 'download_minidump_stackwalk': True, 22:26:02 INFO - 'download_symbols': 'ondemand', 22:26:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:26:02 INFO - 'tooltool.py': '/tools/tooltool.py', 22:26:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:26:02 INFO - '/tools/misc-python/virtualenv.py')}, 22:26:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:26:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:26:02 INFO - 'installer_path': 'installer.exe', 22:26:02 INFO - 'log_level': 'info', 22:26:02 INFO - 'log_name': 'talos', 22:26:02 INFO - 'log_to_console': True, 22:26:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:26:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:26:02 INFO - 'opt_config_files': (), 22:26:02 INFO - 'pip_index': False, 22:26:02 INFO - 'sps_profile': False, 22:26:02 INFO - 'sps_profile_interval': 0, 22:26:02 INFO - 'suite': 'dromaeojs-e10s', 22:26:02 INFO - 'system_bits': '32', 22:26:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:26:02 INFO - 'title': 'talos-linux64-ix-064', 22:26:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:26:02 INFO - 'use_talos_json': True, 22:26:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:26:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:26:02 INFO - 'work_dir': 'build'} 22:26:02 INFO - ##### 22:26:02 INFO - ##### Running clobber step. 22:26:02 INFO - ##### 22:26:02 INFO - Running pre-action listener: _resource_record_pre_action 22:26:02 INFO - Running main action method: clobber 22:26:02 INFO - rmtree: /builds/slave/test/build 22:26:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:26:03 INFO - Running post-action listener: _resource_record_post_action 22:26:03 INFO - ##### 22:26:03 INFO - ##### Finished clobber step (success) 22:26:03 INFO - ##### 22:26:03 INFO - ##### 22:26:03 INFO - ##### Running read-buildbot-config step. 22:26:03 INFO - ##### 22:26:03 INFO - Running pre-action listener: _resource_record_pre_action 22:26:03 INFO - Running main action method: read_buildbot_config 22:26:03 INFO - Using buildbot properties: 22:26:03 INFO - { 22:26:03 INFO - "project": "", 22:26:03 INFO - "product": "firefox", 22:26:03 INFO - "script_repo_revision": "production", 22:26:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:26:03 INFO - "repository": "", 22:26:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:26:03 INFO - "buildid": "20160621193053", 22:26:03 INFO - "pgo_build": "True", 22:26:03 INFO - "basedir": "/builds/slave/test", 22:26:03 INFO - "buildnumber": 751, 22:26:03 INFO - "slavename": "talos-linux64-ix-064", 22:26:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:26:03 INFO - "platform": "ubuntu64_hw", 22:26:03 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:26:03 INFO - "branch": "mozilla-inbound", 22:26:03 INFO - "repo_path": "integration/mozilla-inbound", 22:26:03 INFO - "revision": "587331c6f44b49dd2126eb5cc7a2e9799d3dc084", 22:26:03 INFO - "stage_platform": "linux64-pgo", 22:26:03 INFO - "builduid": "7703d35387e5418f8ceb45ca8542e06f", 22:26:03 INFO - "slavebuilddir": "test" 22:26:03 INFO - } 22:26:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:26:03 INFO - Running post-action listener: _resource_record_post_action 22:26:03 INFO - ##### 22:26:03 INFO - ##### Finished read-buildbot-config step (success) 22:26:03 INFO - ##### 22:26:03 INFO - ##### 22:26:03 INFO - ##### Running download-and-extract step. 22:26:03 INFO - ##### 22:26:03 INFO - Running pre-action listener: _resource_record_pre_action 22:26:03 INFO - Running main action method: download_and_extract 22:26:03 INFO - mkdir: /builds/slave/test/build/tests 22:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:03 INFO - https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:26:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:26:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:26:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:03 INFO - Downloaded 1361 bytes. 22:26:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:26:03 INFO - Using the following test package requirements: 22:26:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:26:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:26:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:26:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'jsshell-linux-x86_64.zip'], 22:26:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:26:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:26:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:26:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:26:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:26:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:26:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:26:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:03 INFO - https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:26:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:26:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:26:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:04 INFO - Downloaded 24227203 bytes. 22:26:04 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'] 22:26:04 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 22:26:06 INFO - Return code: 0 22:26:06 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 22:26:06 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')]} 22:26:06 INFO - https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:26:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:26:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:26:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:08 INFO - Downloaded 24227203 bytes. 22:26: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'] 22:26: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 22:26:09 INFO - Return code: 0 22:26:09 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')]} 22:26:09 INFO - https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:26:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:26:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:26:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:10 INFO - Downloaded 14405384 bytes. 22:26:10 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'] 22:26:10 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 22:26:11 INFO - Return code: 0 22:26:11 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')]} 22:26:11 INFO - https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:26:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:26:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:26:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M3hOqX7XT3-dogvOQ99pxw/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 22:26:12 INFO - Downloaded 60127550 bytes. 22:26:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:26:12 INFO - mkdir: /builds/slave/test/properties 22:26:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:26:12 INFO - Writing to file /builds/slave/test/properties/build_url 22:26:12 INFO - Contents: 22:26:12 INFO - build_url:https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:26:13 INFO - Running post-action listener: _resource_record_post_action 22:26:13 INFO - Running post-action listener: set_extra_try_arguments 22:26:13 INFO - ##### 22:26:13 INFO - ##### Finished download-and-extract step (success) 22:26:13 INFO - ##### 22:26:13 INFO - ##### 22:26:13 INFO - ##### Running populate-webroot step. 22:26:13 INFO - ##### 22:26:13 INFO - Running pre-action listener: _resource_record_pre_action 22:26:13 INFO - Running main action method: populate_webroot 22:26:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:26:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:26:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:26:13 INFO - '--tppagecycles', 22:26:13 INFO - '7'], 22:26:13 INFO - 'tests': ['tsvgm']}}, 22:26:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:26:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:26:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:26:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:26:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:26:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['damp', 'tps']}, 22:26:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'tests': ['damp', 'tps']}, 22:26:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['dromaeo_dom']}, 22:26:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:26:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['basic_compositor_video']}, 22:26:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:26:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['a11yr', 22:26:13 INFO - 'ts_paint', 22:26:13 INFO - 'tpaint', 22:26:13 INFO - 'sessionrestore', 22:26:13 INFO - 'sessionrestore_no_auto_restore', 22:26:13 INFO - 'tabpaint']}, 22:26:13 INFO - 'other-e10s': {'tests': ['a11yr', 22:26:13 INFO - 'ts_paint', 22:26:13 INFO - 'tpaint', 22:26:13 INFO - 'sessionrestore', 22:26:13 INFO - 'sessionrestore_no_auto_restore', 22:26:13 INFO - 'tabpaint']}, 22:26:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:26:13 INFO - 'ts_paint', 22:26:13 INFO - 'tpaint', 22:26:13 INFO - 'sessionrestore', 22:26:13 INFO - 'sessionrestore_no_auto_restore', 22:26:13 INFO - 'tabpaint']}, 22:26:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:26:13 INFO - 'ts_paint', 22:26:13 INFO - 'tpaint', 22:26:13 INFO - 'sessionrestore', 22:26:13 INFO - 'sessionrestore_no_auto_restore', 22:26:13 INFO - 'tabpaint']}, 22:26:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['a11yr', 22:26:13 INFO - 'ts_paint', 22:26:13 INFO - 'tpaint', 22:26:13 INFO - 'sessionrestore', 22:26:13 INFO - 'sessionrestore_no_auto_restore', 22:26:13 INFO - 'tabpaint']}, 22:26:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['a11yr', 22:26:13 INFO - 'ts_paint', 22:26:13 INFO - 'tpaint', 22:26:13 INFO - 'sessionrestore', 22:26:13 INFO - 'sessionrestore_no_auto_restore', 22:26:13 INFO - 'tabpaint']}, 22:26:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['tsvgx', 22:26:13 INFO - 'tsvgr_opacity', 22:26:13 INFO - 'tart', 22:26:13 INFO - 'tscrollx', 22:26:13 INFO - 'cart']}, 22:26:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:26:13 INFO - 'tsvgr_opacity', 22:26:13 INFO - 'tart', 22:26:13 INFO - 'tscrollx', 22:26:13 INFO - 'cart']}, 22:26:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'talos_options': ['--disable-e10s'], 22:26:13 INFO - 'tests': ['tp5o']}, 22:26:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'tests': ['tp5o']}, 22:26:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'talos_options': ['--disable-e10s', 22:26:13 INFO - '--xperf_path', 22:26:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:13 INFO - 'tests': ['tp5n']}, 22:26:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:26:13 INFO - 'talos_options': ['--xperf_path', 22:26:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:26:13 INFO - 'tests': ['tp5n']}}, 22:26:13 INFO - 'talos.zip': {'path': '', 22:26:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:26:13 INFO - Running post-action listener: _resource_record_post_action 22:26:13 INFO - ##### 22:26:13 INFO - ##### Finished populate-webroot step (success) 22:26:13 INFO - ##### 22:26:13 INFO - ##### 22:26:13 INFO - ##### Running create-virtualenv step. 22:26:13 INFO - ##### 22:26:13 INFO - Running pre-action listener: _resource_record_pre_action 22:26:13 INFO - Running main action method: create_virtualenv 22:26:13 INFO - Creating virtualenv /builds/slave/test/build/venv 22:26:13 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 22:26:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:26:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:26:13 INFO - Using real prefix '/usr' 22:26:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:26:14 INFO - Installing distribute.............................................................................................................................................................................................done. 22:26:16 INFO - Installing pip.................done. 22:26:16 INFO - Return code: 0 22:26:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:26:16 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')]} 22:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:16 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')]} 22:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:16 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:16 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 22:26:16 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 22:26:16 INFO - Using env: {'DISPLAY': ':0', 22:26:16 INFO - 'HOME': '/home/cltbld', 22:26:16 INFO - 'LANG': 'en_US.UTF-8', 22:26:16 INFO - 'LANGUAGE': 'en_US:en', 22:26:16 INFO - 'LOGNAME': 'cltbld', 22:26:16 INFO - 'MAIL': '/var/mail/cltbld', 22:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:16 INFO - 'MOZ_NO_REMOTE': '1', 22:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:16 INFO - 'NO_EM_RESTART': '1', 22:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:16 INFO - 'PWD': '/builds/slave/test', 22:26:16 INFO - 'SHELL': '/bin/bash', 22:26:16 INFO - 'SHLVL': '1', 22:26:16 INFO - 'TERM': 'linux', 22:26:16 INFO - 'TMOUT': '86400', 22:26:16 INFO - 'USER': 'cltbld', 22:26:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:16 INFO - '_': '/tools/buildbot/bin/python'} 22:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:16 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 22:26:16 INFO - Cleaning up... 22:26:16 INFO - Return code: 0 22:26:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:26:16 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')]} 22:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:16 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')]} 22:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:16 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:16 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 22:26:16 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 22:26:16 INFO - Using env: {'DISPLAY': ':0', 22:26:16 INFO - 'HOME': '/home/cltbld', 22:26:16 INFO - 'LANG': 'en_US.UTF-8', 22:26:16 INFO - 'LANGUAGE': 'en_US:en', 22:26:16 INFO - 'LOGNAME': 'cltbld', 22:26:16 INFO - 'MAIL': '/var/mail/cltbld', 22:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:16 INFO - 'MOZ_NO_REMOTE': '1', 22:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:16 INFO - 'NO_EM_RESTART': '1', 22:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:16 INFO - 'PWD': '/builds/slave/test', 22:26:16 INFO - 'SHELL': '/bin/bash', 22:26:16 INFO - 'SHLVL': '1', 22:26:16 INFO - 'TERM': 'linux', 22:26:16 INFO - 'TMOUT': '86400', 22:26:16 INFO - 'USER': 'cltbld', 22:26:16 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:16 INFO - '_': '/tools/buildbot/bin/python'} 22:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:16 INFO - Downloading/unpacking psutil>=3.1.1 22:26:16 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 22:26:16 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 22:26:16 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 22:26:16 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 22:26:16 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 22:26:16 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 22:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:26:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:26:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:26:18 INFO - Installing collected packages: psutil 22:26:18 INFO - Running setup.py install for psutil 22:26:18 INFO - building 'psutil._psutil_linux' extension 22:26:18 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 22:26:18 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 22:26:18 INFO - building 'psutil._psutil_posix' extension 22:26:18 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 22:26:19 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 22:26:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:26:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:26:19 INFO - Successfully installed psutil 22:26:19 INFO - Cleaning up... 22:26:19 INFO - Return code: 0 22:26:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:26:19 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')]} 22:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:19 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')]} 22:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:19 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:19 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 22:26:19 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 22:26:19 INFO - Using env: {'DISPLAY': ':0', 22:26:19 INFO - 'HOME': '/home/cltbld', 22:26:19 INFO - 'LANG': 'en_US.UTF-8', 22:26:19 INFO - 'LANGUAGE': 'en_US:en', 22:26:19 INFO - 'LOGNAME': 'cltbld', 22:26:19 INFO - 'MAIL': '/var/mail/cltbld', 22:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:19 INFO - 'MOZ_NO_REMOTE': '1', 22:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:19 INFO - 'NO_EM_RESTART': '1', 22:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:19 INFO - 'PWD': '/builds/slave/test', 22:26:19 INFO - 'SHELL': '/bin/bash', 22:26:19 INFO - 'SHLVL': '1', 22:26:19 INFO - 'TERM': 'linux', 22:26:19 INFO - 'TMOUT': '86400', 22:26:19 INFO - 'USER': 'cltbld', 22:26:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:19 INFO - '_': '/tools/buildbot/bin/python'} 22:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:26:19 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 22:26:19 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 22:26:19 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 22:26:19 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 22:26:19 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 22:26:19 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 22:26:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:26:21 INFO - Installing collected packages: mozsystemmonitor 22:26:21 INFO - Running setup.py install for mozsystemmonitor 22:26:21 INFO - Successfully installed mozsystemmonitor 22:26:21 INFO - Cleaning up... 22:26:21 INFO - Return code: 0 22:26:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:26:21 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')]} 22:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:21 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')]} 22:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:21 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:21 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 22:26:21 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 22:26:21 INFO - Using env: {'DISPLAY': ':0', 22:26:21 INFO - 'HOME': '/home/cltbld', 22:26:21 INFO - 'LANG': 'en_US.UTF-8', 22:26:21 INFO - 'LANGUAGE': 'en_US:en', 22:26:21 INFO - 'LOGNAME': 'cltbld', 22:26:21 INFO - 'MAIL': '/var/mail/cltbld', 22:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:21 INFO - 'MOZ_NO_REMOTE': '1', 22:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:21 INFO - 'NO_EM_RESTART': '1', 22:26:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:21 INFO - 'PWD': '/builds/slave/test', 22:26:21 INFO - 'SHELL': '/bin/bash', 22:26:21 INFO - 'SHLVL': '1', 22:26:21 INFO - 'TERM': 'linux', 22:26:21 INFO - 'TMOUT': '86400', 22:26:21 INFO - 'USER': 'cltbld', 22:26:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:21 INFO - '_': '/tools/buildbot/bin/python'} 22:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:21 INFO - Downloading/unpacking jsonschema==2.5.1 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:26:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:24 INFO - Downloading functools32-3.2.3-2.tar.gz 22:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:26:24 INFO - warning: no files found matching '*.txt' 22:26:24 INFO - no previously-included directories found matching 'build' 22:26:24 INFO - no previously-included directories found matching 'dist' 22:26:24 INFO - no previously-included directories found matching '.git*' 22:26:24 INFO - Installing collected packages: jsonschema, functools32 22:26:24 INFO - Running setup.py install for functools32 22:26:24 INFO - warning: no files found matching '*.txt' 22:26:24 INFO - no previously-included directories found matching 'build' 22:26:24 INFO - no previously-included directories found matching 'dist' 22:26:24 INFO - no previously-included directories found matching '.git*' 22:26:24 INFO - Successfully installed jsonschema functools32 22:26:24 INFO - Cleaning up... 22:26:24 INFO - Return code: 0 22:26:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:26:24 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')]} 22:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:24 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')]} 22:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:24 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:24 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 22:26:24 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 22:26:24 INFO - Using env: {'DISPLAY': ':0', 22:26:24 INFO - 'HOME': '/home/cltbld', 22:26:24 INFO - 'LANG': 'en_US.UTF-8', 22:26:24 INFO - 'LANGUAGE': 'en_US:en', 22:26:24 INFO - 'LOGNAME': 'cltbld', 22:26:24 INFO - 'MAIL': '/var/mail/cltbld', 22:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:24 INFO - 'MOZ_NO_REMOTE': '1', 22:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:24 INFO - 'NO_EM_RESTART': '1', 22:26:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:24 INFO - 'PWD': '/builds/slave/test', 22:26:24 INFO - 'SHELL': '/bin/bash', 22:26:24 INFO - 'SHLVL': '1', 22:26:24 INFO - 'TERM': 'linux', 22:26:24 INFO - 'TMOUT': '86400', 22:26:24 INFO - 'USER': 'cltbld', 22:26:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:24 INFO - '_': '/tools/buildbot/bin/python'} 22:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:24 INFO - Downloading/unpacking blobuploader==1.2.4 22:26:24 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 22:26:24 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 22:26:24 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 22:26:24 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 22:26:24 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 22:26:24 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 22:26:27 INFO - Downloading blobuploader-1.2.4.tar.gz 22:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:26:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:26:27 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 22:26:27 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 22:26:27 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 22:26:27 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 22:26:27 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 22:26:27 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 22:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:26:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:26:27 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 22:26:27 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 22:26:27 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 22:26:27 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 22:26:27 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 22:26:27 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 22:26:28 INFO - Downloading docopt-0.6.1.tar.gz 22:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:26:28 INFO - Installing collected packages: blobuploader, requests, docopt 22:26:28 INFO - Running setup.py install for blobuploader 22:26:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:26:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:26:28 INFO - Running setup.py install for requests 22:26:28 INFO - Running setup.py install for docopt 22:26:28 INFO - Successfully installed blobuploader requests docopt 22:26:28 INFO - Cleaning up... 22:26:28 INFO - Return code: 0 22:26:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:26: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')]} 22:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:28 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:28 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 22:26:28 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 22:26:28 INFO - Using env: {'DISPLAY': ':0', 22:26:28 INFO - 'HOME': '/home/cltbld', 22:26:28 INFO - 'LANG': 'en_US.UTF-8', 22:26:28 INFO - 'LANGUAGE': 'en_US:en', 22:26:28 INFO - 'LOGNAME': 'cltbld', 22:26:28 INFO - 'MAIL': '/var/mail/cltbld', 22:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:28 INFO - 'MOZ_NO_REMOTE': '1', 22:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:28 INFO - 'NO_EM_RESTART': '1', 22:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:28 INFO - 'PWD': '/builds/slave/test', 22:26:28 INFO - 'SHELL': '/bin/bash', 22:26:28 INFO - 'SHLVL': '1', 22:26:28 INFO - 'TERM': 'linux', 22:26:28 INFO - 'TMOUT': '86400', 22:26:28 INFO - 'USER': 'cltbld', 22:26:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:28 INFO - '_': '/tools/buildbot/bin/python'} 22:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:26:28 INFO - Running setup.py (path:/tmp/pip-WSEBhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:26:29 INFO - Running setup.py (path:/tmp/pip-9Gwg9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:26:29 INFO - Running setup.py (path:/tmp/pip-jZRb7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:26:29 INFO - Running setup.py (path:/tmp/pip-6mTBJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:26:29 INFO - Running setup.py (path:/tmp/pip-8oRuX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:26:29 INFO - Running setup.py (path:/tmp/pip-pprJj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:26:29 INFO - Running setup.py (path:/tmp/pip-_yUUnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:26:29 INFO - Running setup.py (path:/tmp/pip-U9jC6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:26:29 INFO - Running setup.py (path:/tmp/pip-CITs21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:26:29 INFO - Running setup.py (path:/tmp/pip-vd5jOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:26:29 INFO - Running setup.py (path:/tmp/pip-jeYR9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:26:29 INFO - Running setup.py (path:/tmp/pip-GLdwsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:26:29 INFO - Running setup.py (path:/tmp/pip-ut1gng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:26:29 INFO - Running setup.py (path:/tmp/pip-QXSYit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:26:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:29 INFO - Running setup.py (path:/tmp/pip-wfCDuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:26:30 INFO - Running setup.py (path:/tmp/pip-WAKKdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:26:30 INFO - Running setup.py (path:/tmp/pip-LDpcMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:26:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:26:30 INFO - Running setup.py install for manifestparser 22:26:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Running setup.py install for mozcrash 22:26:30 INFO - Running setup.py install for mozdebug 22:26:30 INFO - Running setup.py install for mozdevice 22:26:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Running setup.py install for mozfile 22:26:30 INFO - Running setup.py install for mozhttpd 22:26:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Running setup.py install for mozinfo 22:26:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Running setup.py install for mozInstall 22:26:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:26:30 INFO - Running setup.py install for mozleak 22:26:31 INFO - Running setup.py install for mozlog 22:26:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:26:31 INFO - Running setup.py install for moznetwork 22:26:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:26:31 INFO - Running setup.py install for mozprocess 22:26:31 INFO - Running setup.py install for mozprofile 22:26:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:26:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:26:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:26:31 INFO - Running setup.py install for mozrunner 22:26:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:26:31 INFO - Running setup.py install for mozscreenshot 22:26:31 INFO - Running setup.py install for moztest 22:26:31 INFO - Running setup.py install for mozversion 22:26:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:26:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:26:31 INFO - Cleaning up... 22:26:31 INFO - Return code: 0 22:26:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:26:31 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')]} 22:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:31 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')]} 22:26:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:31 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:31 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 22:26:31 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 22:26:31 INFO - Using env: {'DISPLAY': ':0', 22:26:31 INFO - 'HOME': '/home/cltbld', 22:26:31 INFO - 'LANG': 'en_US.UTF-8', 22:26:31 INFO - 'LANGUAGE': 'en_US:en', 22:26:31 INFO - 'LOGNAME': 'cltbld', 22:26:31 INFO - 'MAIL': '/var/mail/cltbld', 22:26:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:31 INFO - 'MOZ_NO_REMOTE': '1', 22:26:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:31 INFO - 'NO_EM_RESTART': '1', 22:26:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:31 INFO - 'PWD': '/builds/slave/test', 22:26:31 INFO - 'SHELL': '/bin/bash', 22:26:31 INFO - 'SHLVL': '1', 22:26:31 INFO - 'TERM': 'linux', 22:26:31 INFO - 'TMOUT': '86400', 22:26:31 INFO - 'USER': 'cltbld', 22:26:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:31 INFO - '_': '/tools/buildbot/bin/python'} 22:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:26:32 INFO - Running setup.py (path:/tmp/pip-UF_kyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:26:32 INFO - Running setup.py (path:/tmp/pip-hJ3Ej_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:26:32 INFO - Running setup.py (path:/tmp/pip-drb6nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:26:32 INFO - Running setup.py (path:/tmp/pip-nPZXgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:26:32 INFO - Running setup.py (path:/tmp/pip-niWGgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:26:32 INFO - Running setup.py (path:/tmp/pip-szF25W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:26:32 INFO - Running setup.py (path:/tmp/pip-_IE7rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:26:32 INFO - Running setup.py (path:/tmp/pip-DgihG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:26:32 INFO - Running setup.py (path:/tmp/pip-BJPXYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:26:32 INFO - Running setup.py (path:/tmp/pip-HT3jsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:26:32 INFO - Running setup.py (path:/tmp/pip-8IhFDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:26:32 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)) 22:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:26:33 INFO - Running setup.py (path:/tmp/pip-71R5yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:26:33 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)) 22:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:26:33 INFO - Running setup.py (path:/tmp/pip-afMmcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:26:33 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)) 22:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:26:33 INFO - Running setup.py (path:/tmp/pip-YZpLKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:26:33 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)) 22:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:33 INFO - Running setup.py (path:/tmp/pip-1Y_9jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:26:33 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)) 22:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:26:33 INFO - Running setup.py (path:/tmp/pip-T_DXQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:26:33 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)) 22:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:26:33 INFO - Running setup.py (path:/tmp/pip-HA8Ptv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:26:33 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)) 22:26:33 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)) 22:26:33 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)) 22:26:33 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)) 22:26:33 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)) 22:26:33 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)) 22:26:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:26:33 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 22:26:33 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 22:26:33 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 22:26:33 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 22:26:33 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 22:26:33 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 22:26:35 INFO - Downloading blessings-1.6.tar.gz 22:26:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:26:35 INFO - Installing collected packages: blessings 22:26:35 INFO - Running setup.py install for blessings 22:26:35 INFO - Successfully installed blessings 22:26:35 INFO - Cleaning up... 22:26:35 INFO - Return code: 0 22:26:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:26:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:26:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:26:35 INFO - Reading from file tmpfile_stdout 22:26:35 INFO - Current package versions: 22:26:35 INFO - argparse == 1.2.1 22:26:35 INFO - blessings == 1.6 22:26:35 INFO - blobuploader == 1.2.4 22:26:35 INFO - docopt == 0.6.1 22:26:35 INFO - functools32 == 3.2.3-2 22:26:35 INFO - jsonschema == 2.5.1 22:26:35 INFO - manifestparser == 1.1 22:26:35 INFO - mozInstall == 1.12 22:26:35 INFO - mozcrash == 0.17 22:26:35 INFO - mozdebug == 0.1 22:26:35 INFO - mozdevice == 0.48 22:26:35 INFO - mozfile == 1.2 22:26:35 INFO - mozhttpd == 0.7 22:26:35 INFO - mozinfo == 0.9 22:26:35 INFO - mozleak == 0.1 22:26:35 INFO - mozlog == 3.2 22:26:35 INFO - moznetwork == 0.27 22:26:35 INFO - mozprocess == 0.22 22:26:35 INFO - mozprofile == 0.28 22:26:35 INFO - mozrunner == 6.11 22:26:35 INFO - mozscreenshot == 0.1 22:26:35 INFO - mozsystemmonitor == 0.3 22:26:35 INFO - moztest == 0.7 22:26:35 INFO - mozversion == 1.4 22:26:35 INFO - psutil == 3.1.1 22:26:35 INFO - requests == 1.2.3 22:26:35 INFO - wsgiref == 0.1.2 22:26:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:26: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')]} 22:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:35 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:35 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 22:26:35 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 22:26:35 INFO - Using env: {'DISPLAY': ':0', 22:26:35 INFO - 'HOME': '/home/cltbld', 22:26:35 INFO - 'LANG': 'en_US.UTF-8', 22:26:35 INFO - 'LANGUAGE': 'en_US:en', 22:26:35 INFO - 'LOGNAME': 'cltbld', 22:26:35 INFO - 'MAIL': '/var/mail/cltbld', 22:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:35 INFO - 'MOZ_NO_REMOTE': '1', 22:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:35 INFO - 'NO_EM_RESTART': '1', 22:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:35 INFO - 'PWD': '/builds/slave/test', 22:26:35 INFO - 'SHELL': '/bin/bash', 22:26:35 INFO - 'SHLVL': '1', 22:26:35 INFO - 'TERM': 'linux', 22:26:35 INFO - 'TMOUT': '86400', 22:26:35 INFO - 'USER': 'cltbld', 22:26:35 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:35 INFO - '_': '/tools/buildbot/bin/python'} 22:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 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)) 22:26:36 INFO - Cleaning up... 22:26:36 INFO - Return code: 0 22:26:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:26:36 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')]} 22:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:36 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')]} 22:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:36 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:36 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 22:26:36 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 22:26:36 INFO - Using env: {'DISPLAY': ':0', 22:26:36 INFO - 'HOME': '/home/cltbld', 22:26:36 INFO - 'LANG': 'en_US.UTF-8', 22:26:36 INFO - 'LANGUAGE': 'en_US:en', 22:26:36 INFO - 'LOGNAME': 'cltbld', 22:26:36 INFO - 'MAIL': '/var/mail/cltbld', 22:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:36 INFO - 'MOZ_NO_REMOTE': '1', 22:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:36 INFO - 'NO_EM_RESTART': '1', 22:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:36 INFO - 'PWD': '/builds/slave/test', 22:26:36 INFO - 'SHELL': '/bin/bash', 22:26:36 INFO - 'SHLVL': '1', 22:26:36 INFO - 'TERM': 'linux', 22:26:36 INFO - 'TMOUT': '86400', 22:26:36 INFO - 'USER': 'cltbld', 22:26:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:36 INFO - '_': '/tools/buildbot/bin/python'} 22:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:26:36 INFO - Cleaning up... 22:26:36 INFO - Return code: 0 22:26:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:26:36 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')]} 22:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:36 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')]} 22:26:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26:36 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 0x7f4532ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', '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 22:26:36 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 22:26:36 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 22:26:36 INFO - Using env: {'DISPLAY': ':0', 22:26:36 INFO - 'HOME': '/home/cltbld', 22:26:36 INFO - 'LANG': 'en_US.UTF-8', 22:26:36 INFO - 'LANGUAGE': 'en_US:en', 22:26:36 INFO - 'LOGNAME': 'cltbld', 22:26:36 INFO - 'MAIL': '/var/mail/cltbld', 22:26:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:36 INFO - 'MOZ_NO_REMOTE': '1', 22:26:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:36 INFO - 'NO_EM_RESTART': '1', 22:26:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:36 INFO - 'PWD': '/builds/slave/test', 22:26:36 INFO - 'SHELL': '/bin/bash', 22:26:36 INFO - 'SHLVL': '1', 22:26:36 INFO - 'TERM': 'linux', 22:26:36 INFO - 'TMOUT': '86400', 22:26:36 INFO - 'USER': 'cltbld', 22:26:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:36 INFO - '_': '/tools/buildbot/bin/python'} 22:26:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:36 INFO - Downloading/unpacking flake8 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:26:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:26:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 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 22:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:26:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:26:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:26:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:26:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:26:39 INFO - no previously-included directories found matching 'docs/_build' 22:26:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:26:39 INFO - Running setup.py install for pep8 22:26:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:26:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:26:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:26:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:26:39 INFO - no previously-included directories found matching 'docs/_build' 22:26:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:26:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:26:39 INFO - Cleaning up... 22:26:39 INFO - Return code: 0 22:26:39 INFO - Running post-action listener: _resource_record_post_action 22:26:39 INFO - Running post-action listener: _start_resource_monitoring 22:26:39 INFO - Starting resource monitoring. 22:26:39 INFO - ##### 22:26:39 INFO - ##### Finished create-virtualenv step (success) 22:26:39 INFO - ##### 22:26:39 INFO - ##### 22:26:39 INFO - ##### Running install step. 22:26:39 INFO - ##### 22:26:39 INFO - Running pre-action listener: _resource_record_pre_action 22:26:39 INFO - Running main action method: install 22:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:26:39 INFO - Reading from file tmpfile_stdout 22:26:39 INFO - Detecting whether we're running mozinstall >=1.0... 22:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:26:39 INFO - Reading from file tmpfile_stdout 22:26:39 INFO - Output received: 22:26:39 INFO - Usage: mozinstall [options] installer 22:26:39 INFO - Options: 22:26:39 INFO - -h, --help show this help message and exit 22:26:39 INFO - -d DEST, --destination=DEST 22:26:39 INFO - Directory to install application into. [default: 22:26:39 INFO - "/builds/slave/test"] 22:26:39 INFO - --app=APP Application being installed. [default: firefox] 22:26:39 INFO - mkdir: /builds/slave/test/build/application 22:26:39 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'] 22:26:39 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 22:26:56 INFO - Reading from file tmpfile_stdout 22:26:56 INFO - Output received: 22:26:56 INFO - /builds/slave/test/build/application/firefox/firefox 22:26:56 INFO - Running post-action listener: _resource_record_post_action 22:26:56 INFO - ##### 22:26:56 INFO - ##### Finished install step (success) 22:26:56 INFO - ##### 22:26:56 INFO - ##### 22:26:56 INFO - ##### Running run-tests step. 22:26:56 INFO - ##### 22:26:56 INFO - Running pre-action listener: _resource_record_pre_action 22:26:56 INFO - Running main action method: run_tests 22:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:26:56 INFO - Python 2.7.3 22:26:56 INFO - Return code: 0 22:26:56 INFO - grabbing minidump binary from tooltool 22:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:56 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 0x1a0c2c0>, '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 0x1a0d1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:26:56 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 22:26:56 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 22:26:56 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 22:26:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:26:56 INFO - Return code: 0 22:26:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:26:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:26:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:26:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:26:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:26:57 INFO - Return code: 0 22:26:57 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/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 22:26:57 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/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 22:26:57 INFO - Using env: {'DISPLAY': ':0', 22:26:57 INFO - 'HOME': '/home/cltbld', 22:26:57 INFO - 'LANG': 'en_US.UTF-8', 22:26:57 INFO - 'LANGUAGE': 'en_US:en', 22:26:57 INFO - 'LOGNAME': 'cltbld', 22:26:57 INFO - 'MAIL': '/var/mail/cltbld', 22:26:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:26:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:57 INFO - 'MOZ_NO_REMOTE': '1', 22:26:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:57 INFO - 'NO_EM_RESTART': '1', 22:26:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:57 INFO - 'PWD': '/builds/slave/test', 22:26:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:26:57 INFO - 'SHELL': '/bin/bash', 22:26:57 INFO - 'SHLVL': '1', 22:26:57 INFO - 'TERM': 'linux', 22:26:57 INFO - 'TMOUT': '86400', 22:26:57 INFO - 'USER': 'cltbld', 22:26:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901', 22:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:57 INFO - '_': '/tools/buildbot/bin/python'} 22:26:57 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/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 22:26:57 INFO - mozversion application_buildid: 20160621193053 22:26:57 INFO - mozversion application_changeset: 587331c6f44b49dd2126eb5cc7a2e9799d3dc084 22:26:57 INFO - mozversion application_display_name: Nightly 22:26:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:26:57 INFO - mozversion application_name: Firefox 22:26:57 INFO - mozversion application_remotingname: firefox 22:26:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:26:57 INFO - mozversion application_vendor: Mozilla 22:26:57 INFO - mozversion application_version: 50.0a1 22:26:57 INFO - mozversion platform_buildid: 20160621193053 22:26:57 INFO - mozversion platform_changeset: 587331c6f44b49dd2126eb5cc7a2e9799d3dc084 22:26:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:26:57 INFO - mozversion platform_version: 50.0a1 22:26:57 INFO - using testdate: 1466573217 22:26:57 INFO - actual date: 1466573217 22:26:57 INFO - starting webserver on 'localhost:48139' 22:26:57 INFO - SUITE-START | Running 2 tests 22:26:57 INFO - TEST-START | dromaeo_css 22:26:57 INFO - operating with platform_type : linux_ 22:26:57 INFO - Initialising browser for dromaeo_css test... 22:26:57 INFO - TEST-INFO | started process 10155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp631X2C/profile http://localhost:48139/getInfo.html) 22:27:02 INFO - PROCESS | 10155 | __metrics Screen width/height:1600/1200 22:27:02 INFO - PROCESS | 10155 | colorDepth:24 22:27:02 INFO - PROCESS | 10155 | Browser inner width/height: 1024/697 22:27:02 INFO - PROCESS | 10155 | __metrics 22:27:03 ERROR - PROCESS | 10155 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 22:27:04 INFO - TEST-INFO | 10155: exit 0 22:27:04 INFO - Browser initialized. 22:27:04 INFO - Running cycle 1/1 for dromaeo_css test... 22:27:04 INFO - TEST-INFO | started process 10276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp631X2C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:16 INFO - PROCESS | 10276 | RSS: Main: 184737792 22:27:16 INFO - PROCESS | 10276 | 22:28:06 INFO - PROCESS | 10276 | 1466573286180 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] 22:30:14 INFO - PROCESS | 10276 | Cycle 1(1): loaded http://localhost:48139/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48139/tests/dromaeo/cssquery-ext.html) 22:30:15 INFO - PROCESS | 10276 | RSS: Main: 189259776 22:30:15 INFO - PROCESS | 10276 | 22:33:17 INFO - PROCESS | 10276 | Cycle 1(1): loaded http://localhost:48139/tests/dromaeo/cssquery-ext.html (next: http://localhost:48139/tests/dromaeo/cssquery-jquery.html) 22:33:18 INFO - PROCESS | 10276 | RSS: Main: 188080128 22:33:18 INFO - PROCESS | 10276 | 22:36:19 INFO - PROCESS | 10276 | Cycle 1(1): loaded http://localhost:48139/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48139/tests/dromaeo/cssquery-mootools.html) 22:36:20 INFO - PROCESS | 10276 | RSS: Main: 188964864 22:36:20 INFO - PROCESS | 10276 | 22:39:22 INFO - PROCESS | 10276 | Cycle 1(1): loaded http://localhost:48139/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48139/tests/dromaeo/cssquery-prototype.html) 22:39:22 INFO - PROCESS | 10276 | RSS: Main: 186327040 22:39:22 INFO - PROCESS | 10276 | 22:42:25 INFO - PROCESS | 10276 | Cycle 1(1): loaded http://localhost:48139/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48139/tests/dromaeo/cssquery-yui.html) 22:42:25 INFO - PROCESS | 10276 | RSS: Main: 188129280 22:42:25 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | Cycle 1(1): loaded http://localhost:48139/tests/dromaeo/cssquery-yui.html (next: http://localhost:48139/tests/dromaeo/cssquery-dojo.html) 22:45:28 INFO - PROCESS | 10276 | RSS: Main: 189247488 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | __start_tp_report 22:45:28 INFO - PROCESS | 10276 | _x_x_mozilla_page_load 22:45:28 INFO - PROCESS | 10276 | _x_x_mozilla_page_load_details 22:45:28 INFO - PROCESS | 10276 | |i|pagename|runs| 22:45:28 INFO - PROCESS | 10276 | |0;dojo.html;3134.8432578371076;3138.1213260287122;3138.7645926555488;3169.714725674689;3174.7618928580364;5428.972855135724;5430.945690543093;5472.425395333493;5516.475934786194;5532.694321865213;5437.02133615949;5517.806876759314;5541.27963364762;5563.388027316992;5631.2960879890015;4932.062908047477;4993.775280112385;5095.847124586268;5130.486951304877;5183.352080989876;490.5050093142658;4888.877778055541;4945.653804233705;5011.2483127530795;5091.872703182432;4941.110600091982;4957.578605818491;4974.179260422026;4977.129002424597;4988.551030407244;5038.924416133761;5044.369453818273;5048.495150484959;5057.848264552069;5067.417247016567;4870.732109733964;4890.584300334476;4922.187839006559;4932.112219800434;4935.457099719028;5383.2732581101445;5434.510894019557;5470.835874923759;5471.2887324647545;5520.530754885839;5817.709114544298;5863.5016023638045;5935.821925342247;5956.970215148896;5980.102984552308;5956.076808094752;5968.940310596882;6030.758769649209;6041.456268935817;6078.544109191828;5598.552115830724;5603.551715862762;5607.80372686954;5608.859778505529;5613.663180209201;5939.584229103922;5975.43233392827;6025.487833534199;6116.204893363834;6138.232720909887;5856.209411729362;5858.150568167677;5860.912086318709;5874.118882167709;5903.439173278532;5949.464548190597;5950.67271300074;5951.1073338999495;5953.553483488756;5966.403359663999;5737.053386191315;5783.913241301384;5845.298564172326;5868.823935281948;5919.378465261086;5833.212516310244;5895.705214739246;5897.262842144732;5904.61619994699;5915.733791979371;4478.283474644107;4478.731276123443;4518.254488009507;4521.502634710179;4546.931796023062;3961.3463778476803;3984.920301593952;3990.4014397840556;3994.8402063917697;4014.0968282136287;5525.336959564797;5530.723463826873;5553.055980483327;5558.499735023867;5566.053770858964;5876.41235876409;5883.17635531026;5908.822735317947;5908.852278692981;5911.556633252438;5502.064649009678;5567.610267281251;5629.43705629442;5653.293338332708;5656.632318899258;5080.74596270185;5101.387833460009;5102.863455853832;5104.897902041938;5133.820316288912;6023.5181185505935;6141.36327073057;6154.3845615438095;6167.167432396569;6206.782762603378;5844.3571207168025;5888.4700376964565;5931.822045338647;5949.970250148722;5959.523238141025;6166.105914642441;6169.352218017223;6170.043643235305;6171.1668924694595;6173.41352571505;5688.175214593944;5714.742836572281;5828.154917536848;5842.38654941225;5848.5028772553105;5821.738021788945;5889.352171261244;5914.674692891932;5930.733117009831;5966.343702192842;5738.569607279387;5742.5118864895285;5782.479576838105;5786.537077033743;5805.535557155333;5595.8880822384135;5721.971390143189;5749.942500575108;5758.884822303614;5821.417858214145;5656.745446454837;5698.230738850202;5732.7706891723865;5751.424857514216;5768.163616275533;5778.451047150514;5827.1841942127285;5835.183074369506;5863.384344643751;5899.587028907935;5536;5654.575906806924;5677.3471050829685;5714.314282286152;5727.656340619576 22:45:28 INFO - PROCESS | 10276 | |1;ext.html;566.5099688769216;619.4765423217381;624.2664868779186;644.7421031587364;653.45436560472;37954;41150.17699646005;41294.7935260324;41385.37921931173;41413.79293103534;41691.16617667645;41906.58093419065;42176.36735448971;42238;42352.36471452931;8765.737027889158;8878.378513504025;8909.331800114986;8909.376343655947;8917.73246802597;8726.738197854043;8789.64841406343;8817.647294108228;8821.206091451768;8828.779280518007;8878.60046297915;8919.24186444153;8928.330375221853;8935.821283574325;8956.104389561056;8861.867071993893;8878.955605221998;8903.33225008127;8906.55467226636;8917.509536975464;8780.692675756318;8793.868091978626;8884;8886;8891.33315001371;39661.80169099165;39672.80163599193;39693.80153099245;39703;39804.800975995226;2856.243095579673;3215.0676303872083;3250.821204833733;3297.0768184908266;3317.137544238491;29957.70042299571;31699.683003169903;31929.201769955936;32411.51382729261;33195;4221.704480686353;4239.302694136298;4284.764337961411;4294.592013758688;4359.476862776487;321461;323064;324006;324414;324993.3750331257;58491;58878.116828247614;58894.70552647209;58901.41098589045;59062.704686477155;34867.82566087204;35828.104297392776;35885.282294353965;63319.36680633227;63654;14891.553253402199;14917.254137293092;14926.10443373401;14983.40066397332;15051.322690478955;10696.304740191863;10847;10878.075363594184;10912.454377281263;10967.945160274148;19183.616327673368;19234.23063077489;19298.22807087701;19395.418137455898;19447.513812154808;7189.532680375759;7239.638018099074;7451.180370159278;7532.585707786015;7542.773716788395;958.6692591056075;1066.184368957748;1069.5507886687453;1082.983755243672;1131.660501849442;32042.359152816814;32252.35495290128;32525.837370812995;32617.184570385456;32810.67189328124;1090.5310716392028;1094.9926068017285;1100.0539535999035;1126.4086354663866;1182.9053675705923;15985;16082.517524474284;16313;16446.34214631425;16598.41905533325;561044;563911;564367;569125;569439;54104.45895541073;54313.185302220496;54484.45515544873;54524.45475545273;54609.45390546044;1288.7293668329569;1340.9664758380923;1342.4630147940902;1376.6489545165919;1378.3797291218991;29122.708772912;29869.5519567211;30108.397832043676;30458.84770576133;30557.388852223277;47595.524044759106;47759.28361074517;48183;48203.999999998596;48535.271970921174;367803;371478;372619;373068;373876;26888.59667104956;27150.592741109293;27256.863715681295;27770.861145694143;28642.28146311228;47276.527234728586;47631.52368476271;48013;48442.5155748438;49432.50567494423;40802.79598601988;41499.58500414957;41526.584734152275;41704.165916682105;41792;39567.40648890327;40487.595124048385;40676;40902.59097408988;41091.17817643571;38348.6165138345;39941.20117597574;40539.18921621492;40712.38931415972;41079.58920410758;36070.45894311535;36879.631203688696;37321.626783731816;37472.06543312913;38345.61654383532;27736.722632773413;27774.166774996782;27824.721752782214;27917.72082279151;28222.15333539997 22:45:28 INFO - PROCESS | 10276 | |2;jquery.html;380.57565814117265;386.87426586359425;392.05710266808336;395.1287411258175;411.05047340643097;13570.457181712743;18337.81662183378;18810.905945470287;19849.106790194423;19994.50013749657;16627.593687672776;16637.83362166378;16946.06796626185;19330.710039349422;19783;5199.714015729133;5757.654540727559;5898.646081235118;5942.702864856761;5969.403059694039;5839.357670656224;5845.620034697731;5873.559483038768;5877.7648894044405;5906.527477801787;5230.476952304758;5522.530584900288;5559.63862348946;5844.766209351621;5846.152307915349;5675.2905886764365;5680.0627896397045;5685.886282274373;5728.770849166029;5786.710664466781;5556.944180605672;5578.107502799533;5697.287839020122;5713.228714123582;5739.282589676291;12528.123031387806;12837.358132093452;12864.163829351062;12876.613701588967;13348.599542013755;2379.6073647848084;2430.1373012580634;2450.963235551468;2479.970812112971;2492.327071690633;10538.841917371246;10746.140308775357;12782.169159004728;14050.508232211925;14872.182029988346;1854.7774267088037;1975.585127123306;1975.940721778349;1982.2467462364355;2017.465371676507;74470.62764686196;77780.61109694415;78790.21209787886;79458;80715.3856922864;10306.690799276033;10599;10678.51946662402;10781.9460902695;10876.857929917403;14628.926855365868;14668.926655366655;14778.408863645334;14789;14980;7275.927240727631;7415.88876166858;7533.397328213729;7592.582407967615;7613.200613935568;7149.535280206874;7232.819179520554;7337.376323012603;7337.59643219628;7341.3392794648735;4516.712736869977;4581.129585378767;4582.725036497821;4661.067786442657;4669.533046695371;1836.9357072502398;1859.9535011624819;1889.9460656891167;1899.4491597436588;1938.6413513500047;960.3181740963994;989.9356541824758;1003.7039073473343;1023.6621914768109;1076.800791853494;19062.2375104997;19601.90199049024;19713;20185.495362616053;20440.386788396372;977.9706608801747;1013.1034034879185;1015.4313584392763;1021.0963297481634;1033.178622994721;10717.517711702993;11186.511614002584;11232.606858759904;11243.05545156414;11277.26697764659;461442;466084;470886;477066;480428;94299;95566.52216738871;96316;96889.5155524232;97669.51165244129;960.865478832964;965.0638880286111;966.1160038564775;977.9657711980188;991.2516050381915;17113.82886171172;17292.699504237786;17729.37947171843;17774.91112544429;17987.820121798613;29541.85229073841;31334.529982049833;39926.80036599799;41716.3742543856;43022.35466467943;57570.13644795248;60329;61145.38854611397;61720;62572.374276256654;8792.076831932554;8810.427322224035;8990.246901854076;9023.684171053981;9068.591913364047;12546;13584.796228056784;13638.863611363759;14049.22729249901;14095.224762637743;12213.389330533615;12314;12315.876841231473;12350.75298494043;12497.93751031239;11716.179867409199;12206.6948326289;12244.938775306067;12307.20003199789;12374.319412432402;12110.697232568904;12260;12474.625761227178;12560.685982850502;12646.810297845355;8760.255378292917;8913.509756963429;8961.955190224007;9060.411073280216;9145.405548639317;9332.486713230837;11845.407729613657;12237.87762122403;12311.56909508163;12553.184043037174 22:45:28 INFO - PROCESS | 10276 | |3;mootools.html;1429.8141241638587;1479.9482018129365;1570.364002578956;1724.4654157211257;1745.171043754216;7806.336461400773;8387.28708059815;8472.40693151478;9010.504422256781;9026.142516460934;8600.526971016607;8705.521196334199;8728.258098061673;8771.692990745309;8793.505104132297;2208.481006963358;2256.8758718270487;2258.6499092640665;2259.5029093599383;2282.6005449046434;2203.1407750977132;2205.2061257947125;2256.187772401934;2268.5689718953427;2272.0343853862123;2300.114455934469;2301.9424514387106;2307.3078076577044;2310.07596961216;2330.8018818400374;2208.3706143748955;2214.5570885822817;2224.7663995280586;2241.1147596699293;2250.9099636014703;2275.3515248154363;2291.9770802292096;2295.4490922178725;2295.6556516522487;2301.746807851135;8815.250703690193;8924.375293729441;8927.732168034969;8958.776030599287;8988.55057247135;5016.996600679879;5119;5125.4623612915975;5127.256547800585;5129.307543481619;3072.2319420144963;3219.17910932713;3350.3131857969056;3369.376665316924;3373.8481768320485;1036.6112707734599;1048.1352883870836;1057.9471026448723;1077.8922107789238;1082.101855459974;11841.111916606204;11887.702807429883;12009.339486328248;12010;12085.093617978599;4478.932816007762;4602;4626.930596041062;4662.7202367858035;4731.787069581877;10244.282900196915;10250.436226007641;10254.48727563619;10276.794464110675;10288.176945844314;5065.442801291855;5138.794448222104;5139.511746384088;5143.305653736773;5170.043541944752;4249.213895429355;4598.908021839611;4749.95250047502;4758.07217592573;4849;3854.9807250963568;3857.594952529944;3946.565877753445;3981.9203615927518;4031.3348297531165;1229.2685851918272;1274.3819247664876;1285.7042880137622;1289.3037759609892;1317.7693903567028;990.4651488196438;994.2990191914682;996.7607774134156;998.55065220651;1005.3415013166388;5957.642541447527;5963.373845746221;5971.701414929236;6050.2437195350585;6067.484263837623;429.5511190805616;432.19611522568;432.6409080463208;433.47982421094184;436.96941214115344;4139.91720165595;4222.514410842792;4228.450301460791;4234.851780187679;4287.4855017397485;10443.68668939933;10837.891621083845;10898.400587967579;10933.56265749377;10966.890331096747;10674;10679.679609611723;10845.023947844731;10850.891491085145;10870.347779133119;7972.242636949481;8003.279704826594;8074.111847696749;8077.555734434545;8081.959590202011;5816.272965879265;6049.274087109575;6099.725512352044;6285;6372.936270637234;9931.205503559553;9941.155001824925;10148.340357876714;10209;10213;10090.445025523666;10098.141657958862;10342.896571034495;10346.534405951901;10467.371957682564;6917.619530925847;7327.37717294036;7593.734219302298;7678.078630564368;7841.098273698598;8338.29124524398;8372.748817535483;8373.288270497076;8382.706605268786;8466.153384661484;7510.098788145458;7722.150563437905;7772.300492955661;7853.09689385728;7930.762077137695;7462.813429664302;7566.583837888969;7598.734044308423;7610.124835643972;7747.806304842424;6899.48253880971;6922.203946546211;6991.335823096798;7018.2630823762765;7059.682314295972;5043.2435134730085;5046.949530504795;5060.51925067118;5156.56169225605;5173.534381905646;5084.898302034013;5181.48185181494;5183.611229157753;5294.470552944675;5353.571714262772 22:45:28 INFO - PROCESS | 10276 | |4;prototype.html;324.2639208995582;331.1258278145695;335.1470507558264;335.989920302391;342.44523871328454;5440.700761458123;5570.387257401688;5617.4382561743805;5629.240052592899;5633.464820842024;5511.917321240185;5577.470140336672;5581.302337207849;5592.7762889484475;5600.383957764653;4339.240632889239;4350.8042138103865;4357.912841743163;4361.934570981438;4409.4047303613925;4199.7480151190875;4299.4195783569285;4319.179355922381;4327.437433133704;4437.090396468732;4281.529031806499;4289.528151903303;4298.527162012192;4339.544347843478;4343.543927887574;4326.43756311679;4354.303311470149;4375.680889128751;4380.8685739427865;4413.249747542925;3781.3760729479877;3835.5013848199833;3835.5397352317623;3889.124946886956;3899.2396482685886;5440.292761940922;5451.236826844245;5451.64564303323;5461.344638643388;5476;4982.17794063979;4995.300657907859;5004.549590536869;5014.44841067486;5017.799288028475;5749.59752817303;5749.798757043525;5867.266591676041;5890.49930755882;5905.970470147622;4207.349369896945;4244.893877653052;4247.5964783345535;4252.000779816741;4253.78767051392;5777.393373695743;5899.5870289079785;6112.297085835142;6118.816435506942;6134.355892631299;4295.398644189816;4326.783660816946;4328.761918094472;4343.956560434355;4349.695521313541;4399.406080179199;4409.228385032607;4424.646028317727;4436.401085853433;4440;4914.189158788759;4989.226669866177;4991.725455100004;4996.4503904570465;5029.64792464524;5725.227094342211;5828.271466066742;5829.562782791308;5854.326752423526;5870.207521984477;1505.7139143562688;1508.5775982724854;1509.3660662521768;1528.8700460460987;1533.9846601534066;928.972130836076;975.3903810118676;979.1628157925014;982.3467394182788;982.7788747531891;4949.975250123726;5022.698638081727;5117.257997590328;5142.2286657001005;5158.742062896915;5286.259923610698;5335.279737235501;5364.91952620711;5366.409694933554;5369.24830523727;4910.705357678551;5028.5977121830165;5028.874278143003;5041.319421878073;5101.285819985205;2826.2369160327007;2854.52900271457;2881.7694584433193;2897.4060317634835;2910.8544572771275;5467.305135408036;5513.7794488220825;5523.917141242885;5537.723113844291;5601.815292036109;5059.494050594911;5385.219143224211;5403.7577453527565;5415.350157981067;5416.620836541404;5460.433596209775;5481.780728770805;5514.36584792754;5553.3058367703225;5554.916791225753;5253.238280449237;5260.342457192851;5340.813071542478;5381.2197231402015;5807.664237225377;5933.881322373615;6067.392141082529;6067.666278354733;6106.69466526663;6118.388161183846;6174.536909731698;6369.407648087978;6382.712777924911;6416.358364163546;6424.807255782334;4222.619964203236;4236.131593023361;4241.109367032957;4260.126674031878;4268.359746038119;5843.532517398683;6071.939280607137;6075.572240523385;6127.662978536045;6157.353477884758;5875.414817480295;5919.348871624032;5931;5944.286685597756;5952.142971373678;5884.9705751470965;5896.6756828374855;5898.852528686645;5938.881222375615;5961.701914904324;5608.242887210175;5762.798302059576;5826.155207494805;5832.854178645568;5844.357120716632;5950.910736338872;5959.284885813557;5967.731452084579;6010.398960103955;6026.306974697965;5740.655560666373;5792.218050563289;5797.623154494944;5892.322382926019;5914.102089975795 22:45:28 INFO - PROCESS | 10276 | |5;yui.html;686.2622680618337;696.095076400679;734.489529776805;742.8254360225346;751.6955632968643;14549.636259093528;15345.462908798194;15829.208539573034;15871.68256634868;15897.12565808883;14659.12045277284;14681.412743490275;14709.705805883903;14811.703765924674;14851.77722334163;681.700051977131;799.5162926429499;801.7274126796888;817.0318172965026;823.3166471828368;829.1128492513013;832.5129799067522;834.9123342049088;835.0980940584154;836.1346006882877;853.9786505337386;854.2567965869671;862.0904945282724;862.594580547145;866.3588944181292;841.7811369044032;843.0768308701962;843.1947490146895;848.4273115646945;850.8978922529274;621.139721485741;625.5339771869986;625.7559551774812;626.9310375858697;626.996805111822;14420.495282665057;14512.201828899406;14513;14532.854671453362;14534.127952322895;14939.925300373428;15047;15380.692386152326;15531.689366212726;15875.126868022255;10815.459227038695;11101.44492775358;11111.611093611686;11128.443577821157;11244.212905096647;3645.6718895299286;3648.525691660094;3653.6346365363515;3692.833822477968;3747.1568896997956;76292;76338;76368.61815690942;77370.83943740849;81945.18054819434;10761.78476430467;10843.240973131962;10917.072048875934;11075.612353567587;11104.888951110546;21580.841915808607;21633.134674613153;21656.133754649953;21835.126594936024;21853.125874965142;8310.875336869953;8348.916510834813;8399.160083991552;8447.619857106445;8599.05410404855;4393.319035549495;4423.977880110643;4440.578145076212;4542.295944128666;4605.562471565196;3620.2940426616556;3732.9440058399146;3736.4768932349493;3737.2151848112203;3743.8502459901297;597.9402059794073;615.8922188616974;620.981370558884;621.2793159934454;623.5977794322728;651.635084352764;742.4097842215343;760.3574979142616;760.9758043603987;788.6017561131706;9165.90834091664;9751.853722194173;9756.707298781048;10213.467979802941;10240.539175737109;716.3839098375392;717.1859938969308;743.8820912124548;758.5410826449919;781.8201813582795;4403.383526306319;4410;4443.4445694288215;4502.594766471033;4507.459104907367;100380.49809750904;115561;123357;124482.37758811149;125047;109839.45080274707;112385.4380728091;112427;112531;113402.43298783453;95450;96209.51895240479;96675;97591.51204243934;97879.55301117529;8638.13618638131;8645.827083458169;8694.304455643407;8771.561421929006;8935.195832375117;52854.20718689146;53009.20486192633;53557.464425356804;53859.19211211757;54281;76482.61758691171;81086.18913811022;81101;82142.58928705318;83689;12422.813657795321;12567.497300107892;12669.303188324362;12691.80962285548;12884.098113131991;13325.200487970753;13367.866321336662;13369.66575835573;13526.79709804334;13574.796378054534;12044.277343359427;12267.57063502773;12733.490660373482;13119.212847229197;13349;11829.349385783864;11886.693739256016;11897.464614092214;11999.520019199133;12003;12198.756024879276;12217.266963982189;12218.633440996784;12420.813687794509;12561.685957851127;9968.800623987625;10591.20565957541;10642.255042146975;10649.787004260026;10797.136229101496;10197.694069177936;10203.336783109371;10317.329373590692;10461.895381046397;10558.894411055791 22:45:28 INFO - PROCESS | 10276 | __end_tp_report 22:45:28 INFO - PROCESS | 10276 | __start_cc_report 22:45:28 INFO - PROCESS | 10276 | _x_x_mozilla_cycle_collect,353 22:45:28 INFO - PROCESS | 10276 | __end_cc_report 22:45:28 INFO - PROCESS | 10276 | __startTimestamp1466574328477__endTimestamp 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | ------- Summary: start ------- 22:45:28 INFO - PROCESS | 10276 | Number of tests: 6 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | [#0] dojo.html Cycles:165 Average:5457.78 Median:5714.31 stddev:747.12 (13.1%) stddev-sans-first:726.85 22:45:28 INFO - PROCESS | 10276 | Values: 3134.8 3138.1 3138.8 3169.7 3174.8 5429.0 5430.9 5472.4 5516.5 5532.7 5437.0 5517.8 5541.3 5563.4 5631.3 4932.1 4993.8 5095.8 5130.5 5183.4 490.5 4888.9 4945.7 5011.2 5091.9 4941.1 4957.6 4974.2 4977.1 4988.6 5038.9 5044.4 5048.5 5057.8 5067.4 4870.7 4890.6 4922.2 4932.1 4935.5 5383.3 5434.5 5470.8 5471.3 5520.5 5817.7 5863.5 5935.8 5957.0 5980.1 5956.1 5968.9 6030.8 6041.5 6078.5 5598.6 5603.6 5607.8 5608.9 5613.7 5939.6 5975.4 6025.5 6116.2 6138.2 5856.2 5858.2 5860.9 5874.1 5903.4 5949.5 5950.7 5951.1 5953.6 5966.4 5737.1 5783.9 5845.3 5868.8 5919.4 5833.2 5895.7 5897.3 5904.6 5915.7 4478.3 4478.7 4518.3 4521.5 4546.9 3961.3 3984.9 3990.4 3994.8 4014.1 5525.3 5530.7 5553.1 5558.5 5566.1 5876.4 5883.2 5908.8 5908.9 5911.6 5502.1 5567.6 5629.4 5653.3 5656.6 5080.7 5101.4 5102.9 5104.9 5133.8 6023.5 6141.4 6154.4 6167.2 6206.8 5844.4 5888.5 5931.8 5950.0 5959.5 6166.1 6169.4 6170.0 6171.2 6173.4 5688.2 5714.7 5828.2 5842.4 5848.5 5821.7 5889.4 5914.7 5930.7 5966.3 5738.6 5742.5 5782.5 5786.5 5805.5 5595.9 5722.0 5749.9 5758.9 5821.4 5656.7 5698.2 5732.8 5751.4 5768.2 5778.5 5827.2 5835.2 5863.4 5899.6 5536.0 5654.6 5677.3 5714.3 5727.7 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | [#1] ext.html Cycles:180 Average:57594.09 Median:40214.40 stddev:115084.39 (286.2%) stddev-sans-first:115327.58 22:45:28 INFO - PROCESS | 10276 | Values: 566.5 619.5 624.3 644.7 653.5 37954.0 41150.2 41294.8 41385.4 41413.8 41691.2 41906.6 42176.4 42238.0 42352.4 8765.7 8878.4 8909.3 8909.4 8917.7 8726.7 8789.6 8817.6 8821.2 8828.8 8878.6 8919.2 8928.3 8935.8 8956.1 8861.9 8879.0 8903.3 8906.6 8917.5 8780.7 8793.9 8884.0 8886.0 8891.3 39661.8 39672.8 39693.8 39703.0 39804.8 2856.2 3215.1 3250.8 3297.1 3317.1 29957.7 31699.7 31929.2 32411.5 33195.0 4221.7 4239.3 4284.8 4294.6 4359.5 321461.0 323064.0 324006.0 324414.0 324993.4 58491.0 58878.1 58894.7 58901.4 59062.7 34867.8 35828.1 35885.3 63319.4 63654.0 14891.6 14917.3 14926.1 14983.4 15051.3 10696.3 10847.0 10878.1 10912.5 10967.9 19183.6 19234.2 19298.2 19395.4 19447.5 7189.5 7239.6 7451.2 7532.6 7542.8 958.7 1066.2 1069.6 1083.0 1131.7 32042.4 32252.4 32525.8 32617.2 32810.7 1090.5 1095.0 1100.1 1126.4 1182.9 15985.0 16082.5 16313.0 16446.3 16598.4 561044.0 563911.0 564367.0 569125.0 569439.0 54104.5 54313.2 54484.5 54524.5 54609.5 1288.7 1341.0 1342.5 1376.6 1378.4 29122.7 29869.6 30108.4 30458.8 30557.4 47595.5 47759.3 48183.0 48204.0 48535.3 367803.0 371478.0 372619.0 373068.0 373876.0 26888.6 27150.6 27256.9 27770.9 28642.3 47276.5 47631.5 48013.0 48442.5 49432.5 40802.8 41499.6 41526.6 41704.2 41792.0 39567.4 40487.6 40676.0 40902.6 41091.2 38348.6 39941.2 40539.2 40712.4 41079.6 36070.5 36879.6 37321.6 37472.1 38345.6 27736.7 27774.2 27824.7 27917.7 28222.2 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | [#2] jquery.html Cycles:180 Average:28234.66 Median:16017.09 stddev:77893.26 (486.3%) stddev-sans-first:78083.70 22:45:28 INFO - PROCESS | 10276 | Values: 380.6 386.9 392.1 395.1 411.1 13570.5 18337.8 18810.9 19849.1 19994.5 16627.6 16637.8 16946.1 19330.7 19783.0 5199.7 5757.7 5898.6 5942.7 5969.4 5839.4 5845.6 5873.6 5877.8 5906.5 5230.5 5522.5 5559.6 5844.8 5846.2 5675.3 5680.1 5685.9 5728.8 5786.7 5556.9 5578.1 5697.3 5713.2 5739.3 12528.1 12837.4 12864.2 12876.6 13348.6 2379.6 2430.1 2451.0 2480.0 2492.3 10538.8 10746.1 12782.2 14050.5 14872.2 1854.8 1975.6 1975.9 1982.2 2017.5 74470.6 77780.6 78790.2 79458.0 80715.4 10306.7 10599.0 10678.5 10781.9 10876.9 14628.9 14668.9 14778.4 14789.0 14980.0 7275.9 7415.9 7533.4 7592.6 7613.2 7149.5 7232.8 7337.4 7337.6 7341.3 4516.7 4581.1 4582.7 4661.1 4669.5 1836.9 1860.0 1889.9 1899.4 1938.6 960.3 989.9 1003.7 1023.7 1076.8 19062.2 19601.9 19713.0 20185.5 20440.4 978.0 1013.1 1015.4 1021.1 1033.2 10717.5 11186.5 11232.6 11243.1 11277.3 461442.0 466084.0 470886.0 477066.0 480428.0 94299.0 95566.5 96316.0 96889.5 97669.5 960.9 965.1 966.1 978.0 991.3 17113.8 17292.7 17729.4 17774.9 17987.8 29541.9 31334.5 39926.8 41716.4 43022.4 57570.1 60329.0 61145.4 61720.0 62572.4 8792.1 8810.4 8990.2 9023.7 9068.6 12546.0 13584.8 13638.9 14049.2 14095.2 12213.4 12314.0 12315.9 12350.8 12497.9 11716.2 12206.7 12244.9 12307.2 12374.3 12110.7 12260.0 12474.6 12560.7 12646.8 8760.3 8913.5 8962.0 9060.4 9145.4 9332.5 11845.4 12237.9 12311.6 12553.2 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | [#3] mootools.html Cycles:180 Average:5740.58 Median:4538.92 stddev:3289.95 (72.5%) stddev-sans-first:3283.23 22:45:28 INFO - PROCESS | 10276 | Values: 1429.8 1479.9 1570.4 1724.5 1745.2 7806.3 8387.3 8472.4 9010.5 9026.1 8600.5 8705.5 8728.3 8771.7 8793.5 2208.5 2256.9 2258.6 2259.5 2282.6 2203.1 2205.2 2256.2 2268.6 2272.0 2300.1 2301.9 2307.3 2310.1 2330.8 2208.4 2214.6 2224.8 2241.1 2250.9 2275.4 2292.0 2295.4 2295.7 2301.7 8815.3 8924.4 8927.7 8958.8 8988.6 5017.0 5119.0 5125.5 5127.3 5129.3 3072.2 3219.2 3350.3 3369.4 3373.8 1036.6 1048.1 1057.9 1077.9 1082.1 11841.1 11887.7 12009.3 12010.0 12085.1 4478.9 4602.0 4626.9 4662.7 4731.8 10244.3 10250.4 10254.5 10276.8 10288.2 5065.4 5138.8 5139.5 5143.3 5170.0 4249.2 4598.9 4750.0 4758.1 4849.0 3855.0 3857.6 3946.6 3981.9 4031.3 1229.3 1274.4 1285.7 1289.3 1317.8 990.5 994.3 996.8 998.6 1005.3 5957.6 5963.4 5971.7 6050.2 6067.5 429.6 432.2 432.6 433.5 437.0 4139.9 4222.5 4228.5 4234.9 4287.5 10443.7 10837.9 10898.4 10933.6 10966.9 10674.0 10679.7 10845.0 10850.9 10870.3 7972.2 8003.3 8074.1 8077.6 8082.0 5816.3 6049.3 6099.7 6285.0 6372.9 9931.2 9941.2 10148.3 10209.0 10213.0 10090.4 10098.1 10342.9 10346.5 10467.4 6917.6 7327.4 7593.7 7678.1 7841.1 8338.3 8372.7 8373.3 8382.7 8466.2 7510.1 7722.2 7772.3 7853.1 7930.8 7462.8 7566.6 7598.7 7610.1 7747.8 6899.5 6922.2 6991.3 7018.3 7059.7 5043.2 5046.9 5060.5 5156.6 5173.5 5084.9 5181.5 5183.6 5294.5 5353.6 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | [#4] prototype.html Cycles:180 Average:4820.10 Median:5394.49 stddev:1407.08 (26.1%) stddev-sans-first:1369.97 22:45:28 INFO - PROCESS | 10276 | Values: 324.3 331.1 335.1 336.0 342.4 5440.7 5570.4 5617.4 5629.2 5633.5 5511.9 5577.5 5581.3 5592.8 5600.4 4339.2 4350.8 4357.9 4361.9 4409.4 4199.7 4299.4 4319.2 4327.4 4437.1 4281.5 4289.5 4298.5 4339.5 4343.5 4326.4 4354.3 4375.7 4380.9 4413.2 3781.4 3835.5 3835.5 3889.1 3899.2 5440.3 5451.2 5451.6 5461.3 5476.0 4982.2 4995.3 5004.5 5014.4 5017.8 5749.6 5749.8 5867.3 5890.5 5906.0 4207.3 4244.9 4247.6 4252.0 4253.8 5777.4 5899.6 6112.3 6118.8 6134.4 4295.4 4326.8 4328.8 4344.0 4349.7 4399.4 4409.2 4424.6 4436.4 4440.0 4914.2 4989.2 4991.7 4996.5 5029.6 5725.2 5828.3 5829.6 5854.3 5870.2 1505.7 1508.6 1509.4 1528.9 1534.0 929.0 975.4 979.2 982.3 982.8 4950.0 5022.7 5117.3 5142.2 5158.7 5286.3 5335.3 5364.9 5366.4 5369.2 4910.7 5028.6 5028.9 5041.3 5101.3 2826.2 2854.5 2881.8 2897.4 2910.9 5467.3 5513.8 5523.9 5537.7 5601.8 5059.5 5385.2 5403.8 5415.4 5416.6 5460.4 5481.8 5514.4 5553.3 5554.9 5253.2 5260.3 5340.8 5381.2 5807.7 5933.9 6067.4 6067.7 6106.7 6118.4 6174.5 6369.4 6382.7 6416.4 6424.8 4222.6 4236.1 4241.1 4260.1 4268.4 5843.5 6071.9 6075.6 6127.7 6157.4 5875.4 5919.3 5931.0 5944.3 5952.1 5885.0 5896.7 5898.9 5938.9 5961.7 5608.2 5762.8 5826.2 5832.9 5844.4 5950.9 5959.3 5967.7 6010.4 6026.3 5740.7 5792.2 5797.6 5892.3 5914.1 22:45:28 INFO - PROCESS | 10276 | 22:45:28 INFO - PROCESS | 10276 | [#5] yui.html Cycles:180 Average:21570.52 Median:4070.24 stddev:32382.18 (795.6%) stddev-sans-first:32435.06 22:45:28 INFO - PROCESS | 10276 | Values: 686.3 696.1 734.5 742.8 751.7 14549.6 15345.5 15829.2 15871.7 15897.1 14659.1 14681.4 14709.7 14811.7 14851.8 681.7 799.5 801.7 817.0 823.3 829.1 832.5 834.9 835.1 836.1 854.0 854.3 862.1 862.6 866.4 841.8 843.1 843.2 848.4 850.9 621.1 625.5 625.8 626.9 627.0 14420.5 14512.2 14513.0 14532.9 14534.1 14939.9 15047.0 15380.7 15531.7 15875.1 10815.5 11101.4 11111.6 11128.4 11244.2 3645.7 3648.5 3653.6 3692.8 3747.2 76292.0 76338.0 76368.6 77370.8 81945.2 10761.8 10843.2 10917.1 11075.6 11104.9 21580.8 21633.1 21656.1 21835.1 21853.1 8310.9 8348.9 8399.2 8447.6 8599.1 4393.3 4424.0 4440.6 4542.3 4605.6 3620.3 3732.9 3736.5 3737.2 3743.9 597.9 615.9 621.0 621.3 623.6 651.6 742.4 760.4 761.0 788.6 9165.9 9751.9 9756.7 10213.5 10240.5 716.4 717.2 743.9 758.5 781.8 4403.4 4410.0 4443.4 4502.6 4507.5 100380.5 115561.0 123357.0 124482.4 125047.0 109839.5 112385.4 112427.0 112531.0 113402.4 95450.0 96209.5 96675.0 97591.5 97879.6 8638.1 8645.8 8694.3 8771.6 8935.2 52854.2 53009.2 53557.5 53859.2 54281.0 76482.6 81086.2 81101.0 82142.6 83689.0 12422.8 12567.5 12669.3 12691.8 12884.1 13325.2 13367.9 13369.7 13526.8 13574.8 12044.3 12267.6 12733.5 13119.2 13349.0 11829.3 11886.7 11897.5 11999.5 12003.0 12198.8 12217.3 12218.6 12420.8 12561.7 9968.8 10591.2 10642.3 10649.8 10797.1 10197.7 10203.3 10317.3 10461.9 10558.9 22:45:28 INFO - PROCESS | 10276 | -------- Summary: end -------- 22:45:28 INFO - PROCESS | 10276 | 22:45:29 INFO - TEST-INFO | 10276: exit 0 22:45:29 INFO - TEST-OK | dromaeo_css | took 1111266ms 22:45:29 INFO - TEST-START | kraken 22:45:29 INFO - operating with platform_type : linux_ 22:45:29 INFO - Initialising browser for kraken test... 22:45:29 INFO - TEST-INFO | started process 10509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGeuIHv/profile http://localhost:48139/getInfo.html) 22:45:34 INFO - PROCESS | 10509 | __metrics Screen width/height:1600/1200 22:45:34 INFO - PROCESS | 10509 | colorDepth:24 22:45:34 INFO - PROCESS | 10509 | Browser inner width/height: 1024/697 22:45:34 INFO - PROCESS | 10509 | __metrics 22:45:34 ERROR - PROCESS | 10509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 22:45:35 INFO - TEST-INFO | 10509: exit 0 22:45:35 INFO - Browser initialized. 22:45:35 INFO - Running cycle 1/1 for kraken test... 22:45:35 INFO - TEST-INFO | started process 10631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGeuIHv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:45:47 INFO - PROCESS | 10631 | RSS: Main: 184709120 22:45:47 INFO - PROCESS | 10631 | 22:45:50 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48139/tests/kraken/driver.html?testName=audio-beat-detection) 22:45:51 INFO - PROCESS | 10631 | RSS: Main: 190705664 22:45:51 INFO - PROCESS | 10631 | 22:45:53 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48139/tests/kraken/driver.html?testName=audio-dft) 22:45:54 INFO - PROCESS | 10631 | RSS: Main: 189530112 22:45:54 INFO - PROCESS | 10631 | 22:45:57 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48139/tests/kraken/driver.html?testName=audio-fft) 22:45:57 INFO - PROCESS | 10631 | RSS: Main: 184893440 22:45:57 INFO - PROCESS | 10631 | 22:46:00 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48139/tests/kraken/driver.html?testName=audio-oscillator) 22:46:00 INFO - PROCESS | 10631 | RSS: Main: 185294848 22:46:00 INFO - PROCESS | 10631 | 22:46:03 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48139/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:46:03 INFO - PROCESS | 10631 | RSS: Main: 185786368 22:46:03 INFO - PROCESS | 10631 | 22:46:06 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48139/tests/kraken/driver.html?testName=imaging-darkroom) 22:46:07 INFO - PROCESS | 10631 | RSS: Main: 186593280 22:46:07 INFO - PROCESS | 10631 | 22:46:10 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48139/tests/kraken/driver.html?testName=imaging-desaturate) 22:46:11 INFO - PROCESS | 10631 | RSS: Main: 183816192 22:46:11 INFO - PROCESS | 10631 | 22:46:14 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48139/tests/kraken/driver.html?testName=json-parse-financial) 22:46:15 INFO - PROCESS | 10631 | RSS: Main: 185470976 22:46:15 INFO - PROCESS | 10631 | 22:46:16 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48139/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:46:17 INFO - PROCESS | 10631 | RSS: Main: 186011648 22:46:17 INFO - PROCESS | 10631 | 22:46:19 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:46:19 INFO - PROCESS | 10631 | RSS: Main: 186114048 22:46:19 INFO - PROCESS | 10631 | 22:46:21 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:46:22 INFO - PROCESS | 10631 | RSS: Main: 186327040 22:46:22 INFO - PROCESS | 10631 | 22:46:25 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:46:25 INFO - PROCESS | 10631 | RSS: Main: 186642432 22:46:25 INFO - PROCESS | 10631 | 22:46:28 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:46:29 INFO - PROCESS | 10631 | RSS: Main: 186208256 22:46:29 INFO - PROCESS | 10631 | 22:46:30 INFO - PROCESS | 10631 | Cycle 1(1): loaded http://localhost:48139/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48139/tests/kraken/driver.html?testName=ai-astar) 22:46:31 INFO - PROCESS | 10631 | RSS: Main: 186982400 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | __start_tp_report 22:46:31 INFO - PROCESS | 10631 | _x_x_mozilla_page_load 22:46:31 INFO - PROCESS | 10631 | _x_x_mozilla_page_load_details 22:46:31 INFO - PROCESS | 10631 | |i|pagename|runs| 22:46:31 INFO - PROCESS | 10631 | |0;ai-astar;102;110;106;109;110;113;113;109;112;110 22:46:31 INFO - PROCESS | 10631 | |1;audio-beat-detection;159;129;151;182;127;151;152;130;185;129 22:46:31 INFO - PROCESS | 10631 | |2;audio-dft;164;162;172;163;166;176;163;163;160;161 22:46:31 INFO - PROCESS | 10631 | |3;audio-fft;75;86;76;159;76;74;76;74;160;77 22:46:31 INFO - PROCESS | 10631 | |4;audio-oscillator;85;85;144;86;85;85;145;85;87;149 22:46:31 INFO - PROCESS | 10631 | |5;imaging-gaussian-blur;119;118;118;118;117;117;117;118;117;118 22:46:31 INFO - PROCESS | 10631 | |6;imaging-darkroom;148;147;149;148;148;147;148;148;148;150 22:46:31 INFO - PROCESS | 10631 | |7;imaging-desaturate;96;96;95;95;96;95;96;96;95;97 22:46:31 INFO - PROCESS | 10631 | |8;json-parse-financial;54;54;54;54;58;55;56;53;54;60 22:46:31 INFO - PROCESS | 10631 | |9;json-stringify-tinderbox;63;63;63;64;63;63;64;63;62;63 22:46:31 INFO - PROCESS | 10631 | |10;stanford-crypto-aes;81;86;79;79;80;80;85;81;103;80 22:46:31 INFO - PROCESS | 10631 | |11;stanford-crypto-ccm;121;134;126;130;128;123;132;132;125;123 22:46:31 INFO - PROCESS | 10631 | |12;stanford-crypto-pbkdf2;160;163;162;161;160;165;158;163;171;159 22:46:31 INFO - PROCESS | 10631 | |13;stanford-crypto-sha256-iterative;63;63;63;62;62;63;62;62;61;66 22:46:31 INFO - PROCESS | 10631 | __end_tp_report 22:46:31 INFO - PROCESS | 10631 | __start_cc_report 22:46:31 INFO - PROCESS | 10631 | _x_x_mozilla_cycle_collect,910 22:46:31 INFO - PROCESS | 10631 | __end_cc_report 22:46:31 INFO - PROCESS | 10631 | __startTimestamp1466574391055__endTimestamp 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | ------- Summary: start ------- 22:46:31 INFO - PROCESS | 10631 | Number of tests: 14 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.34 (3.0%) stddev-sans-first:2.22 22:46:31 INFO - PROCESS | 10631 | Values: 102.0 110.0 106.0 109.0 110.0 113.0 113.0 109.0 112.0 110.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:151.50 stddev:21.46 (14.2%) stddev-sans-first:22.48 22:46:31 INFO - PROCESS | 10631 | Values: 159.0 129.0 151.0 182.0 127.0 151.0 152.0 130.0 185.0 129.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#2] audio-dft Cycles:10 Average:165.00 Median:163.50 stddev:5.10 (3.1%) stddev-sans-first:5.40 22:46:31 INFO - PROCESS | 10631 | Values: 164.0 162.0 172.0 163.0 166.0 176.0 163.0 163.0 160.0 161.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:35.06 (46.1%) stddev-sans-first:36.55 22:46:31 INFO - PROCESS | 10631 | Values: 75.0 86.0 76.0 159.0 76.0 74.0 76.0 74.0 160.0 77.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:29.29 (34.5%) stddev-sans-first:30.29 22:46:31 INFO - PROCESS | 10631 | Values: 85.0 85.0 144.0 86.0 85.0 85.0 145.0 85.0 87.0 149.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 22:46:31 INFO - PROCESS | 10631 | Values: 119.0 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 22:46:31 INFO - PROCESS | 10631 | Values: 148.0 147.0 149.0 148.0 148.0 147.0 148.0 148.0 148.0 150.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:46:31 INFO - PROCESS | 10631 | Values: 96.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 97.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:2.20 (4.0%) stddev-sans-first:2.29 22:46:31 INFO - PROCESS | 10631 | Values: 54.0 54.0 54.0 54.0 58.0 55.0 56.0 53.0 54.0 60.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 22:46:31 INFO - PROCESS | 10631 | Values: 63.0 63.0 63.0 64.0 63.0 63.0 64.0 63.0 62.0 63.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:80.50 stddev:7.29 (9.1%) stddev-sans-first:7.68 22:46:31 INFO - PROCESS | 10631 | Values: 81.0 86.0 79.0 79.0 80.0 80.0 85.0 81.0 103.0 80.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:129.00 stddev:4.48 (3.5%) stddev-sans-first:4.11 22:46:31 INFO - PROCESS | 10631 | Values: 121.0 134.0 126.0 130.0 128.0 123.0 132.0 132.0 125.0 123.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:3.74 (2.3%) stddev-sans-first:3.88 22:46:31 INFO - PROCESS | 10631 | Values: 160.0 163.0 162.0 161.0 160.0 165.0 158.0 163.0 171.0 159.0 22:46:31 INFO - PROCESS | 10631 | 22:46:31 INFO - PROCESS | 10631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 22:46:31 INFO - PROCESS | 10631 | Values: 63.0 63.0 63.0 62.0 62.0 63.0 62.0 62.0 61.0 66.0 22:46:31 INFO - PROCESS | 10631 | -------- Summary: end -------- 22:46:31 INFO - PROCESS | 10631 | 22:46:32 INFO - TEST-INFO | 10631: exit 0 22:46:32 INFO - TEST-OK | kraken | took 62974ms 22:46:32 INFO - SUITE-END | took 1174s 22:46:32 INFO - Completed test suite (00:19:34) 22:46:32 INFO - javascript benchmark 22:46:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7215.453731656289, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3134.8432578371076, 3138.1213260287122, 3138.7645926555488, 3169.714725674689, 3174.7618928580364, 5428.972855135724, 5430.945690543093, 5472.425395333493, 5516.475934786194, 5532.694321865213, 5437.02133615949, 5517.806876759314, 5541.27963364762, 5563.388027316992, 5631.2960879890015, 4932.062908047477, 4993.775280112385, 5095.847124586268, 5130.486951304877, 5183.352080989876, 490.5050093142658, 4888.877778055541, 4945.653804233705, 5011.2483127530795, 5091.872703182432, 4941.110600091982, 4957.578605818491, 4974.179260422026, 4977.129002424597, 4988.551030407244, 5038.924416133761, 5044.369453818273, 5048.495150484959, 5057.848264552069, 5067.417247016567, 4870.732109733964, 4890.584300334476, 4922.187839006559, 4932.112219800434, 4935.457099719028, 5383.2732581101445, 5434.510894019557, 5470.835874923759, 5471.2887324647545, 5520.530754885839, 5817.709114544298, 5863.5016023638045, 5935.821925342247, 5956.970215148896, 5980.102984552308, 5956.076808094752, 5968.940310596882, 6030.758769649209, 6041.456268935817, 6078.544109191828, 5598.552115830724, 5603.551715862762, 5607.80372686954, 5608.859778505529, 5613.663180209201, 5939.584229103922, 5975.43233392827, 6025.487833534199, 6116.204893363834, 6138.232720909887, 5856.209411729362, 5858.150568167677, 5860.912086318709, 5874.118882167709, 5903.439173278532, 5949.464548190597, 5950.67271300074, 5951.1073338999495, 5953.553483488756, 5966.403359663999, 5737.053386191315, 5783.913241301384, 5845.298564172326, 5868.823935281948, 5919.378465261086, 5833.212516310244, 5895.705214739246, 5897.262842144732, 5904.61619994699, 5915.733791979371, 4478.283474644107, 4478.731276123443, 4518.254488009507, 4521.502634710179, 4546.931796023062, 3961.3463778476803, 3984.920301593952, 3990.4014397840556, 3994.8402063917697, 4014.0968282136287, 5525.336959564797, 5530.723463826873, 5553.055980483327, 5558.499735023867, 5566.053770858964, 5876.41235876409, 5883.17635531026, 5908.822735317947, 5908.852278692981, 5911.556633252438, 5502.064649009678, 5567.610267281251, 5629.43705629442, 5653.293338332708, 5656.632318899258, 5080.74596270185, 5101.387833460009, 5102.863455853832, 5104.897902041938, 5133.820316288912, 6023.5181185505935, 6141.36327073057, 6154.3845615438095, 6167.167432396569, 6206.782762603378, 5844.3571207168025, 5888.4700376964565, 5931.822045338647, 5949.970250148722, 5959.523238141025, 6166.105914642441, 6169.352218017223, 6170.043643235305, 6171.1668924694595, 6173.41352571505, 5688.175214593944, 5714.742836572281, 5828.154917536848, 5842.38654941225, 5848.5028772553105, 5821.738021788945, 5889.352171261244, 5914.674692891932, 5930.733117009831, 5966.343702192842, 5738.569607279387, 5742.5118864895285, 5782.479576838105, 5786.537077033743, 5805.535557155333, 5595.8880822384135, 5721.971390143189, 5749.942500575108, 5758.884822303614, 5821.417858214145, 5656.745446454837, 5698.230738850202, 5732.7706891723865, 5751.424857514216, 5768.163616275533, 5778.451047150514, 5827.1841942127285, 5835.183074369506, 5863.384344643751, 5899.587028907935, 5536.0, 5654.575906806924, 5677.3471050829685, 5714.314282286152, 5727.656340619576], "value": 5407.855215914393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.5099688769216, 619.4765423217381, 624.2664868779186, 644.7421031587364, 653.45436560472, 37954.0, 41150.17699646005, 41294.7935260324, 41385.37921931173, 41413.79293103534, 41691.16617667645, 41906.58093419065, 42176.36735448971, 42238.0, 42352.36471452931, 8765.737027889158, 8878.378513504025, 8909.331800114986, 8909.376343655947, 8917.73246802597, 8726.738197854043, 8789.64841406343, 8817.647294108228, 8821.206091451768, 8828.779280518007, 8878.60046297915, 8919.24186444153, 8928.330375221853, 8935.821283574325, 8956.104389561056, 8861.867071993893, 8878.955605221998, 8903.33225008127, 8906.55467226636, 8917.509536975464, 8780.692675756318, 8793.868091978626, 8884.0, 8886.0, 8891.33315001371, 39661.80169099165, 39672.80163599193, 39693.80153099245, 39703.0, 39804.800975995226, 2856.243095579673, 3215.0676303872083, 3250.821204833733, 3297.0768184908266, 3317.137544238491, 29957.70042299571, 31699.683003169903, 31929.201769955936, 32411.51382729261, 33195.0, 4221.704480686353, 4239.302694136298, 4284.764337961411, 4294.592013758688, 4359.476862776487, 321461.0, 323064.0, 324006.0, 324414.0, 324993.3750331257, 58491.0, 58878.116828247614, 58894.70552647209, 58901.41098589045, 59062.704686477155, 34867.82566087204, 35828.104297392776, 35885.282294353965, 63319.36680633227, 63654.0, 14891.553253402199, 14917.254137293092, 14926.10443373401, 14983.40066397332, 15051.322690478955, 10696.304740191863, 10847.0, 10878.075363594184, 10912.454377281263, 10967.945160274148, 19183.616327673368, 19234.23063077489, 19298.22807087701, 19395.418137455898, 19447.513812154808, 7189.532680375759, 7239.638018099074, 7451.180370159278, 7532.585707786015, 7542.773716788395, 958.6692591056075, 1066.184368957748, 1069.5507886687453, 1082.983755243672, 1131.660501849442, 32042.359152816814, 32252.35495290128, 32525.837370812995, 32617.184570385456, 32810.67189328124, 1090.5310716392028, 1094.9926068017285, 1100.0539535999035, 1126.4086354663866, 1182.9053675705923, 15985.0, 16082.517524474284, 16313.0, 16446.34214631425, 16598.41905533325, 561044.0, 563911.0, 564367.0, 569125.0, 569439.0, 54104.45895541073, 54313.185302220496, 54484.45515544873, 54524.45475545273, 54609.45390546044, 1288.7293668329569, 1340.9664758380923, 1342.4630147940902, 1376.6489545165919, 1378.3797291218991, 29122.708772912, 29869.5519567211, 30108.397832043676, 30458.84770576133, 30557.388852223277, 47595.524044759106, 47759.28361074517, 48183.0, 48203.999999998596, 48535.271970921174, 367803.0, 371478.0, 372619.0, 373068.0, 373876.0, 26888.59667104956, 27150.592741109293, 27256.863715681295, 27770.861145694143, 28642.28146311228, 47276.527234728586, 47631.52368476271, 48013.0, 48442.5155748438, 49432.50567494423, 40802.79598601988, 41499.58500414957, 41526.584734152275, 41704.165916682105, 41792.0, 39567.40648890327, 40487.595124048385, 40676.0, 40902.59097408988, 41091.17817643571, 38348.6165138345, 39941.20117597574, 40539.18921621492, 40712.38931415972, 41079.58920410758, 36070.45894311535, 36879.631203688696, 37321.626783731816, 37472.06543312913, 38345.61654383532, 27736.722632773413, 27774.166774996782, 27824.721752782214, 27917.72082279151, 28222.15333539997], "value": 19486.7776804402, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.57565814117265, 386.87426586359425, 392.05710266808336, 395.1287411258175, 411.05047340643097, 13570.457181712743, 18337.81662183378, 18810.905945470287, 19849.106790194423, 19994.50013749657, 16627.593687672776, 16637.83362166378, 16946.06796626185, 19330.710039349422, 19783.0, 5199.714015729133, 5757.654540727559, 5898.646081235118, 5942.702864856761, 5969.403059694039, 5839.357670656224, 5845.620034697731, 5873.559483038768, 5877.7648894044405, 5906.527477801787, 5230.476952304758, 5522.530584900288, 5559.63862348946, 5844.766209351621, 5846.152307915349, 5675.2905886764365, 5680.0627896397045, 5685.886282274373, 5728.770849166029, 5786.710664466781, 5556.944180605672, 5578.107502799533, 5697.287839020122, 5713.228714123582, 5739.282589676291, 12528.123031387806, 12837.358132093452, 12864.163829351062, 12876.613701588967, 13348.599542013755, 2379.6073647848084, 2430.1373012580634, 2450.963235551468, 2479.970812112971, 2492.327071690633, 10538.841917371246, 10746.140308775357, 12782.169159004728, 14050.508232211925, 14872.182029988346, 1854.7774267088037, 1975.585127123306, 1975.940721778349, 1982.2467462364355, 2017.465371676507, 74470.62764686196, 77780.61109694415, 78790.21209787886, 79458.0, 80715.3856922864, 10306.690799276033, 10599.0, 10678.51946662402, 10781.9460902695, 10876.857929917403, 14628.926855365868, 14668.926655366655, 14778.408863645334, 14789.0, 14980.0, 7275.927240727631, 7415.88876166858, 7533.397328213729, 7592.582407967615, 7613.200613935568, 7149.535280206874, 7232.819179520554, 7337.376323012603, 7337.59643219628, 7341.3392794648735, 4516.712736869977, 4581.129585378767, 4582.725036497821, 4661.067786442657, 4669.533046695371, 1836.9357072502398, 1859.9535011624819, 1889.9460656891167, 1899.4491597436588, 1938.6413513500047, 960.3181740963994, 989.9356541824758, 1003.7039073473343, 1023.6621914768109, 1076.800791853494, 19062.2375104997, 19601.90199049024, 19713.0, 20185.495362616053, 20440.386788396372, 977.9706608801747, 1013.1034034879185, 1015.4313584392763, 1021.0963297481634, 1033.178622994721, 10717.517711702993, 11186.511614002584, 11232.606858759904, 11243.05545156414, 11277.26697764659, 461442.0, 466084.0, 470886.0, 477066.0, 480428.0, 94299.0, 95566.52216738871, 96316.0, 96889.5155524232, 97669.51165244129, 960.865478832964, 965.0638880286111, 966.1160038564775, 977.9657711980188, 991.2516050381915, 17113.82886171172, 17292.699504237786, 17729.37947171843, 17774.91112544429, 17987.820121798613, 29541.85229073841, 31334.529982049833, 39926.80036599799, 41716.3742543856, 43022.35466467943, 57570.13644795248, 60329.0, 61145.38854611397, 61720.0, 62572.374276256654, 8792.076831932554, 8810.427322224035, 8990.246901854076, 9023.684171053981, 9068.591913364047, 12546.0, 13584.796228056784, 13638.863611363759, 14049.22729249901, 14095.224762637743, 12213.389330533615, 12314.0, 12315.876841231473, 12350.75298494043, 12497.93751031239, 11716.179867409199, 12206.6948326289, 12244.938775306067, 12307.20003199789, 12374.319412432402, 12110.697232568904, 12260.0, 12474.625761227178, 12560.685982850502, 12646.810297845355, 8760.255378292917, 8913.509756963429, 8961.955190224007, 9060.411073280216, 9145.405548639317, 9332.486713230837, 11845.407729613657, 12237.87762122403, 12311.56909508163, 12553.184043037174], "value": 9095.509543514563, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.8141241638587, 1479.9482018129365, 1570.364002578956, 1724.4654157211257, 1745.171043754216, 7806.336461400773, 8387.28708059815, 8472.40693151478, 9010.504422256781, 9026.142516460934, 8600.526971016607, 8705.521196334199, 8728.258098061673, 8771.692990745309, 8793.505104132297, 2208.481006963358, 2256.8758718270487, 2258.6499092640665, 2259.5029093599383, 2282.6005449046434, 2203.1407750977132, 2205.2061257947125, 2256.187772401934, 2268.5689718953427, 2272.0343853862123, 2300.114455934469, 2301.9424514387106, 2307.3078076577044, 2310.07596961216, 2330.8018818400374, 2208.3706143748955, 2214.5570885822817, 2224.7663995280586, 2241.1147596699293, 2250.9099636014703, 2275.3515248154363, 2291.9770802292096, 2295.4490922178725, 2295.6556516522487, 2301.746807851135, 8815.250703690193, 8924.375293729441, 8927.732168034969, 8958.776030599287, 8988.55057247135, 5016.996600679879, 5119.0, 5125.4623612915975, 5127.256547800585, 5129.307543481619, 3072.2319420144963, 3219.17910932713, 3350.3131857969056, 3369.376665316924, 3373.8481768320485, 1036.6112707734599, 1048.1352883870836, 1057.9471026448723, 1077.8922107789238, 1082.101855459974, 11841.111916606204, 11887.702807429883, 12009.339486328248, 12010.0, 12085.093617978599, 4478.932816007762, 4602.0, 4626.930596041062, 4662.7202367858035, 4731.787069581877, 10244.282900196915, 10250.436226007641, 10254.48727563619, 10276.794464110675, 10288.176945844314, 5065.442801291855, 5138.794448222104, 5139.511746384088, 5143.305653736773, 5170.043541944752, 4249.213895429355, 4598.908021839611, 4749.95250047502, 4758.07217592573, 4849.0, 3854.9807250963568, 3857.594952529944, 3946.565877753445, 3981.9203615927518, 4031.3348297531165, 1229.2685851918272, 1274.3819247664876, 1285.7042880137622, 1289.3037759609892, 1317.7693903567028, 990.4651488196438, 994.2990191914682, 996.7607774134156, 998.55065220651, 1005.3415013166388, 5957.642541447527, 5963.373845746221, 5971.701414929236, 6050.2437195350585, 6067.484263837623, 429.5511190805616, 432.19611522568, 432.6409080463208, 433.47982421094184, 436.96941214115344, 4139.91720165595, 4222.514410842792, 4228.450301460791, 4234.851780187679, 4287.4855017397485, 10443.68668939933, 10837.891621083845, 10898.400587967579, 10933.56265749377, 10966.890331096747, 10674.0, 10679.679609611723, 10845.023947844731, 10850.891491085145, 10870.347779133119, 7972.242636949481, 8003.279704826594, 8074.111847696749, 8077.555734434545, 8081.959590202011, 5816.272965879265, 6049.274087109575, 6099.725512352044, 6285.0, 6372.936270637234, 9931.205503559553, 9941.155001824925, 10148.340357876714, 10209.0, 10213.0, 10090.445025523666, 10098.141657958862, 10342.896571034495, 10346.534405951901, 10467.371957682564, 6917.619530925847, 7327.37717294036, 7593.734219302298, 7678.078630564368, 7841.098273698598, 8338.29124524398, 8372.748817535483, 8373.288270497076, 8382.706605268786, 8466.153384661484, 7510.098788145458, 7722.150563437905, 7772.300492955661, 7853.09689385728, 7930.762077137695, 7462.813429664302, 7566.583837888969, 7598.734044308423, 7610.124835643972, 7747.806304842424, 6899.48253880971, 6922.203946546211, 6991.335823096798, 7018.2630823762765, 7059.682314295972, 5043.2435134730085, 5046.949530504795, 5060.51925067118, 5156.56169225605, 5173.534381905646, 5084.898302034013, 5181.48185181494, 5183.611229157753, 5294.470552944675, 5353.571714262772], "value": 4504.65695142513, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.2639208995582, 331.1258278145695, 335.1470507558264, 335.989920302391, 342.44523871328454, 5440.700761458123, 5570.387257401688, 5617.4382561743805, 5629.240052592899, 5633.464820842024, 5511.917321240185, 5577.470140336672, 5581.302337207849, 5592.7762889484475, 5600.383957764653, 4339.240632889239, 4350.8042138103865, 4357.912841743163, 4361.934570981438, 4409.4047303613925, 4199.7480151190875, 4299.4195783569285, 4319.179355922381, 4327.437433133704, 4437.090396468732, 4281.529031806499, 4289.528151903303, 4298.527162012192, 4339.544347843478, 4343.543927887574, 4326.43756311679, 4354.303311470149, 4375.680889128751, 4380.8685739427865, 4413.249747542925, 3781.3760729479877, 3835.5013848199833, 3835.5397352317623, 3889.124946886956, 3899.2396482685886, 5440.292761940922, 5451.236826844245, 5451.64564303323, 5461.344638643388, 5476.0, 4982.17794063979, 4995.300657907859, 5004.549590536869, 5014.44841067486, 5017.799288028475, 5749.59752817303, 5749.798757043525, 5867.266591676041, 5890.49930755882, 5905.970470147622, 4207.349369896945, 4244.893877653052, 4247.5964783345535, 4252.000779816741, 4253.78767051392, 5777.393373695743, 5899.5870289079785, 6112.297085835142, 6118.816435506942, 6134.355892631299, 4295.398644189816, 4326.783660816946, 4328.761918094472, 4343.956560434355, 4349.695521313541, 4399.406080179199, 4409.228385032607, 4424.646028317727, 4436.401085853433, 4440.0, 4914.189158788759, 4989.226669866177, 4991.725455100004, 4996.4503904570465, 5029.64792464524, 5725.227094342211, 5828.271466066742, 5829.562782791308, 5854.326752423526, 5870.207521984477, 1505.7139143562688, 1508.5775982724854, 1509.3660662521768, 1528.8700460460987, 1533.9846601534066, 928.972130836076, 975.3903810118676, 979.1628157925014, 982.3467394182788, 982.7788747531891, 4949.975250123726, 5022.698638081727, 5117.257997590328, 5142.2286657001005, 5158.742062896915, 5286.259923610698, 5335.279737235501, 5364.91952620711, 5366.409694933554, 5369.24830523727, 4910.705357678551, 5028.5977121830165, 5028.874278143003, 5041.319421878073, 5101.285819985205, 2826.2369160327007, 2854.52900271457, 2881.7694584433193, 2897.4060317634835, 2910.8544572771275, 5467.305135408036, 5513.7794488220825, 5523.917141242885, 5537.723113844291, 5601.815292036109, 5059.494050594911, 5385.219143224211, 5403.7577453527565, 5415.350157981067, 5416.620836541404, 5460.433596209775, 5481.780728770805, 5514.36584792754, 5553.3058367703225, 5554.916791225753, 5253.238280449237, 5260.342457192851, 5340.813071542478, 5381.2197231402015, 5807.664237225377, 5933.881322373615, 6067.392141082529, 6067.666278354733, 6106.69466526663, 6118.388161183846, 6174.536909731698, 6369.407648087978, 6382.712777924911, 6416.358364163546, 6424.807255782334, 4222.619964203236, 4236.131593023361, 4241.109367032957, 4260.126674031878, 4268.359746038119, 5843.532517398683, 6071.939280607137, 6075.572240523385, 6127.662978536045, 6157.353477884758, 5875.414817480295, 5919.348871624032, 5931.0, 5944.286685597756, 5952.142971373678, 5884.9705751470965, 5896.6756828374855, 5898.852528686645, 5938.881222375615, 5961.701914904324, 5608.242887210175, 5762.798302059576, 5826.155207494805, 5832.854178645568, 5844.357120716632, 5950.910736338872, 5959.284885813557, 5967.731452084579, 6010.398960103955, 6026.306974697965, 5740.655560666373, 5792.218050563289, 5797.623154494944, 5892.322382926019, 5914.102089975795], "value": 4369.250558363639, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.2622680618337, 696.095076400679, 734.489529776805, 742.8254360225346, 751.6955632968643, 14549.636259093528, 15345.462908798194, 15829.208539573034, 15871.68256634868, 15897.12565808883, 14659.12045277284, 14681.412743490275, 14709.705805883903, 14811.703765924674, 14851.77722334163, 681.700051977131, 799.5162926429499, 801.7274126796888, 817.0318172965026, 823.3166471828368, 829.1128492513013, 832.5129799067522, 834.9123342049088, 835.0980940584154, 836.1346006882877, 853.9786505337386, 854.2567965869671, 862.0904945282724, 862.594580547145, 866.3588944181292, 841.7811369044032, 843.0768308701962, 843.1947490146895, 848.4273115646945, 850.8978922529274, 621.139721485741, 625.5339771869986, 625.7559551774812, 626.9310375858697, 626.996805111822, 14420.495282665057, 14512.201828899406, 14513.0, 14532.854671453362, 14534.127952322895, 14939.925300373428, 15047.0, 15380.692386152326, 15531.689366212726, 15875.126868022255, 10815.459227038695, 11101.44492775358, 11111.611093611686, 11128.443577821157, 11244.212905096647, 3645.6718895299286, 3648.525691660094, 3653.6346365363515, 3692.833822477968, 3747.1568896997956, 76292.0, 76338.0, 76368.61815690942, 77370.83943740849, 81945.18054819434, 10761.78476430467, 10843.240973131962, 10917.072048875934, 11075.612353567587, 11104.888951110546, 21580.841915808607, 21633.134674613153, 21656.133754649953, 21835.126594936024, 21853.125874965142, 8310.875336869953, 8348.916510834813, 8399.160083991552, 8447.619857106445, 8599.05410404855, 4393.319035549495, 4423.977880110643, 4440.578145076212, 4542.295944128666, 4605.562471565196, 3620.2940426616556, 3732.9440058399146, 3736.4768932349493, 3737.2151848112203, 3743.8502459901297, 597.9402059794073, 615.8922188616974, 620.981370558884, 621.2793159934454, 623.5977794322728, 651.635084352764, 742.4097842215343, 760.3574979142616, 760.9758043603987, 788.6017561131706, 9165.90834091664, 9751.853722194173, 9756.707298781048, 10213.467979802941, 10240.539175737109, 716.3839098375392, 717.1859938969308, 743.8820912124548, 758.5410826449919, 781.8201813582795, 4403.383526306319, 4410.0, 4443.4445694288215, 4502.594766471033, 4507.459104907367, 100380.49809750904, 115561.0, 123357.0, 124482.37758811149, 125047.0, 109839.45080274707, 112385.4380728091, 112427.0, 112531.0, 113402.43298783453, 95450.0, 96209.51895240479, 96675.0, 97591.51204243934, 97879.55301117529, 8638.13618638131, 8645.827083458169, 8694.304455643407, 8771.561421929006, 8935.195832375117, 52854.20718689146, 53009.20486192633, 53557.464425356804, 53859.19211211757, 54281.0, 76482.61758691171, 81086.18913811022, 81101.0, 82142.58928705318, 83689.0, 12422.813657795321, 12567.497300107892, 12669.303188324362, 12691.80962285548, 12884.098113131991, 13325.200487970753, 13367.866321336662, 13369.66575835573, 13526.79709804334, 13574.796378054534, 12044.277343359427, 12267.57063502773, 12733.490660373482, 13119.212847229197, 13349.0, 11829.349385783864, 11886.693739256016, 11897.464614092214, 11999.520019199133, 12003.0, 12198.756024879276, 12217.266963982189, 12218.633440996784, 12420.813687794509, 12561.685957851127, 9968.800623987625, 10591.20565957541, 10642.255042146975, 10649.787004260026, 10797.136229101496, 10197.694069177936, 10203.336783109371, 10317.329373590692, 10461.895381046397, 10558.894411055791], "value": 7479.593867954086, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 106.0, 109.0, 110.0, 113.0, 113.0, 109.0, 112.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 151.0, 182.0, 127.0, 151.0, 152.0, 130.0, 185.0, 129.0], "value": 149.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 172.0, 163.0, 166.0, 176.0, 163.0, 163.0, 160.0, 161.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 86.0, 76.0, 159.0, 76.0, 74.0, 76.0, 74.0, 160.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 144.0, 86.0, 85.0, 85.0, 145.0, 85.0, 87.0, 149.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 150.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 58.0, 55.0, 56.0, 53.0, 54.0, 60.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 79.0, 79.0, 80.0, 80.0, 85.0, 81.0, 103.0, 80.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 134.0, 126.0, 130.0, 128.0, 123.0, 132.0, 132.0, 125.0, 123.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 162.0, 161.0, 160.0, 165.0, 158.0, 163.0, 171.0, 159.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 61.0, 66.0], "value": 62.7, "unit": "score"}]}]} 22:46:32 INFO - Return code: 0 22:46:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:46:32 ERROR - # TBPL SUCCESS # 22:46:32 INFO - Running post-action listener: _resource_record_post_action 22:46:32 INFO - ##### 22:46:32 INFO - ##### Finished run-tests step (success) 22:46:32 INFO - ##### 22:46:32 INFO - Running post-run listener: _resource_record_post_run 22:46:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 217088; Write bytes: 298430464; Read time: 28; Write time: 184964 22:46:32 INFO - TinderboxPrint: CPU usage
13.5% 22:46:32 INFO - TinderboxPrint: I/O read bytes / time
217,088 / 28 22:46:32 INFO - TinderboxPrint: I/O write bytes / time
298,430,464 / 184,964 22:46:32 INFO - TinderboxPrint: CPU idle
8,222.7 (86.5%) 22:46:32 INFO - TinderboxPrint: CPU user
1,227.4 (12.9%) 22:46:32 INFO - TinderboxPrint: Swap in / out
0 / 0 22:46:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 9781248; Read time: 0; Write time: 5560 22:46:32 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 217088; Write bytes: 288649216; Read time: 28; Write time: 179404 22:46:32 INFO - Running post-run listener: _upload_blobber_files 22:46:32 INFO - Blob upload gear active. 22:46:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:46:32 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 22:46:32 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'] 22:46:32 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 22:46:33 INFO - (blobuploader) - INFO - Open directory for files ... 22:46:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:46:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:46:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:34 INFO - (blobuploader) - INFO - Done attempting. 22:46:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:46:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:38 INFO - (blobuploader) - INFO - Done attempting. 22:46:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:46:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:46:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:39 INFO - (blobuploader) - INFO - Done attempting. 22:46:39 INFO - (blobuploader) - INFO - Iteration through files over. 22:46:39 INFO - Return code: 0 22:46:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:46:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:46:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36482bdb35c97214117c897dc32620b8ebb26989eee7d460dc9aa1285c8e3d23ce0db8aab7fa35c91fddfaaf0314fd40ef06fc7e656292c42377f5b1caf20ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50209fba2f27b2d82e6fd99484d228ad190f603eead0b259e7e8a14ce1441356b3a778710b8ad7713745ada3fde6ec56466619ec0e2391fef08a3c4fd2f0a052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc5b1cf63767e7a77d7e9f4568bb0f9231728fd0567d89910d28bf9cc33ff01c9b8e8da7749a229229b6c6b9d79b8b1503c83d6f7fa446f0cebe3559d89f4b96"} 22:46:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:46:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:46:39 INFO - Contents: 22:46:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/36482bdb35c97214117c897dc32620b8ebb26989eee7d460dc9aa1285c8e3d23ce0db8aab7fa35c91fddfaaf0314fd40ef06fc7e656292c42377f5b1caf20ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50209fba2f27b2d82e6fd99484d228ad190f603eead0b259e7e8a14ce1441356b3a778710b8ad7713745ada3fde6ec56466619ec0e2391fef08a3c4fd2f0a052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc5b1cf63767e7a77d7e9f4568bb0f9231728fd0567d89910d28bf9cc33ff01c9b8e8da7749a229229b6c6b9d79b8b1503c83d6f7fa446f0cebe3559d89f4b96"} 22:46:39 INFO - Running post-run listener: copy_logs_to_upload_dir 22:46:39 INFO - Copying logs to upload dir... 22:46:39 INFO - mkdir: /builds/slave/test/build/upload/logs 22:46:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.470533 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-21 22:46:38.959410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 22:46:38.963018) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901 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/36482bdb35c97214117c897dc32620b8ebb26989eee7d460dc9aa1285c8e3d23ce0db8aab7fa35c91fddfaaf0314fd40ef06fc7e656292c42377f5b1caf20ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50209fba2f27b2d82e6fd99484d228ad190f603eead0b259e7e8a14ce1441356b3a778710b8ad7713745ada3fde6ec56466619ec0e2391fef08a3c4fd2f0a052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc5b1cf63767e7a77d7e9f4568bb0f9231728fd0567d89910d28bf9cc33ff01c9b8e8da7749a229229b6c6b9d79b8b1503c83d6f7fa446f0cebe3559d89f4b96"} build_url:https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/M3hOqX7XT3-dogvOQ99pxw/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/36482bdb35c97214117c897dc32620b8ebb26989eee7d460dc9aa1285c8e3d23ce0db8aab7fa35c91fddfaaf0314fd40ef06fc7e656292c42377f5b1caf20ada", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/50209fba2f27b2d82e6fd99484d228ad190f603eead0b259e7e8a14ce1441356b3a778710b8ad7713745ada3fde6ec56466619ec0e2391fef08a3c4fd2f0a052", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dc5b1cf63767e7a77d7e9f4568bb0f9231728fd0567d89910d28bf9cc33ff01c9b8e8da7749a229229b6c6b9d79b8b1503c83d6f7fa446f0cebe3559d89f4b96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 22:46:38.989420) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 22:46:38.989793) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1466573160.267844-1870901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 22:46:39.073903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 22:46:39.074410) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 22:46:39.074946) ========= ========= Total master_lag: 0.15 =========