builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1467044184.42 results: success (0) buildid: 20160627064426 builduid: 760ee2ce191049a2845a5ebce2bdb21b revision: 034fb275b74282c34caf311a9cbddd730cc0fe15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.417179) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.417628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.417901) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.432967) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.433395) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 09:16:24-- 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% 30.1M=0s 2016-06-27 09:16:24 (30.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.604344) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.604663) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017564 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.653846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:24.654222) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 034fb275b74282c34caf311a9cbddd730cc0fe15 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 034fb275b74282c34caf311a9cbddd730cc0fe15 --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=652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 09:16:24,761 truncating revision to first 12 chars 2016-06-27 09:16:24,761 Setting DEBUG logging. 2016-06-27 09:16:24,761 attempt 1/10 2016-06-27 09:16:24,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/034fb275b742?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 09:16:25,068 unpacking tar archive at: mozilla-aurora-034fb275b742/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:25.316297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:25.316602) ========= script_repo_revision: 034fb275b74282c34caf311a9cbddd730cc0fe15 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:25.317013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:25.317372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 09:16:25.328293) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-27 09:16:25.328793) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:16:25 INFO - MultiFileLogger online at 20160627 09:16:25 in /builds/slave/test 09:16:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:16:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:25 INFO - {'append_to_log': False, 09:16:25 INFO - 'base_work_dir': '/builds/slave/test', 09:16:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:16:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:25 INFO - 'branch': 'Mozilla-Aurora', 09:16:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:25 INFO - 'config_files': ('talos/linux_config.py',), 09:16:25 INFO - 'default_actions': ('clobber', 09:16:25 INFO - 'read-buildbot-config', 09:16:25 INFO - 'download-and-extract', 09:16:25 INFO - 'populate-webroot', 09:16:25 INFO - 'create-virtualenv', 09:16:25 INFO - 'install', 09:16:25 INFO - 'run-tests'), 09:16:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:25 INFO - 'download_minidump_stackwalk': True, 09:16:25 INFO - 'download_symbols': 'ondemand', 09:16:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:25 INFO - 'installer_path': 'installer.exe', 09:16:25 INFO - 'log_level': 'info', 09:16:25 INFO - 'log_name': 'talos', 09:16:25 INFO - 'log_to_console': True, 09:16:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:16:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:16:25 INFO - 'opt_config_files': (), 09:16:25 INFO - 'pip_index': False, 09:16:25 INFO - 'sps_profile': False, 09:16:25 INFO - 'sps_profile_interval': 0, 09:16:25 INFO - 'suite': 'dromaeojs-e10s', 09:16:25 INFO - 'system_bits': '32', 09:16:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:25 INFO - 'title': 'talos-linux64-ix-046', 09:16:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:25 INFO - 'use_talos_json': True, 09:16:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:25 INFO - 'work_dir': 'build'} 09:16:25 INFO - ##### 09:16:25 INFO - ##### Running clobber step. 09:16:25 INFO - ##### 09:16:25 INFO - Running pre-action listener: _resource_record_pre_action 09:16:25 INFO - Running main action method: clobber 09:16:25 INFO - rmtree: /builds/slave/test/build 09:16:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:25 INFO - Running post-action listener: _resource_record_post_action 09:16:25 INFO - ##### 09:16:25 INFO - ##### Finished clobber step (success) 09:16:25 INFO - ##### 09:16:25 INFO - ##### 09:16:25 INFO - ##### Running read-buildbot-config step. 09:16:25 INFO - ##### 09:16:25 INFO - Running pre-action listener: _resource_record_pre_action 09:16:25 INFO - Running main action method: read_buildbot_config 09:16:25 INFO - Using buildbot properties: 09:16:25 INFO - { 09:16:25 INFO - "project": "", 09:16:25 INFO - "product": "firefox", 09:16:25 INFO - "script_repo_revision": "production", 09:16:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:16:25 INFO - "repository": "", 09:16:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:16:25 INFO - "buildid": "20160627064426", 09:16:25 INFO - "pgo_build": "True", 09:16:25 INFO - "basedir": "/builds/slave/test", 09:16:25 INFO - "buildnumber": 418, 09:16:25 INFO - "slavename": "talos-linux64-ix-046", 09:16:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:16:25 INFO - "platform": "ubuntu64_hw", 09:16:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:16:25 INFO - "branch": "mozilla-aurora", 09:16:25 INFO - "repo_path": "releases/mozilla-aurora", 09:16:25 INFO - "revision": "034fb275b74282c34caf311a9cbddd730cc0fe15", 09:16:25 INFO - "stage_platform": "linux64-pgo", 09:16:25 INFO - "builduid": "760ee2ce191049a2845a5ebce2bdb21b", 09:16:25 INFO - "slavebuilddir": "test" 09:16:25 INFO - } 09:16:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 09:16:25 INFO - Running post-action listener: _resource_record_post_action 09:16:25 INFO - ##### 09:16:25 INFO - ##### Finished read-buildbot-config step (success) 09:16:25 INFO - ##### 09:16:25 INFO - ##### 09:16:25 INFO - ##### Running download-and-extract step. 09:16:25 INFO - ##### 09:16:25 INFO - Running pre-action listener: _resource_record_pre_action 09:16:25 INFO - Running main action method: download_and_extract 09:16:25 INFO - mkdir: /builds/slave/test/build/tests 09:16:25 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')]} 09:16:25 INFO - https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:16:26 INFO - Downloaded 1361 bytes. 09:16:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 09:16:26 INFO - Using the following test package requirements: 09:16:26 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:26 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:16:26 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:16:26 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'jsshell-linux-x86_64.zip'], 09:16:26 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:16:26 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 09:16:26 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:16:26 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:16:26 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:16:26 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 09:16:26 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:16:26 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:26 INFO - https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:16:27 INFO - Downloaded 24523744 bytes. 09:16:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:16:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:16:28 INFO - Return code: 0 09:16:28 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:16: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')]} 09:16:28 INFO - https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 09:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:16:30 INFO - Downloaded 24523744 bytes. 09:16:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:16:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:16:31 INFO - Return code: 0 09:16: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')]} 09:16:31 INFO - https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 09:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:16:33 INFO - Downloaded 10833369 bytes. 09:16:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:16:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:16:33 INFO - Return code: 0 09:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:33 INFO - https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:16:34 INFO - Downloaded 63606719 bytes. 09:16:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:16:34 INFO - mkdir: /builds/slave/test/properties 09:16:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:34 INFO - Contents: 09:16:34 INFO - build_url:https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 09:16:35 INFO - Running post-action listener: _resource_record_post_action 09:16:35 INFO - Running post-action listener: set_extra_try_arguments 09:16:35 INFO - ##### 09:16:35 INFO - ##### Finished download-and-extract step (success) 09:16:35 INFO - ##### 09:16:35 INFO - ##### 09:16:35 INFO - ##### Running populate-webroot step. 09:16:35 INFO - ##### 09:16:35 INFO - Running pre-action listener: _resource_record_pre_action 09:16:35 INFO - Running main action method: populate_webroot 09:16:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:35 INFO - '--tppagecycles', 09:16:35 INFO - '7'], 09:16:35 INFO - 'tests': ['tsvgm']}}, 09:16:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['damp', 'tps']}, 09:16:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'tests': ['damp', 'tps']}, 09:16:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['dromaeo_dom']}, 09:16:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['a11yr', 09:16:35 INFO - 'ts_paint', 09:16:35 INFO - 'tpaint', 09:16:35 INFO - 'sessionrestore', 09:16:35 INFO - 'sessionrestore_no_auto_restore', 09:16:35 INFO - 'tabpaint']}, 09:16:35 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:35 INFO - 'ts_paint', 09:16:35 INFO - 'tpaint', 09:16:35 INFO - 'sessionrestore', 09:16:35 INFO - 'sessionrestore_no_auto_restore', 09:16:35 INFO - 'tabpaint']}, 09:16:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:35 INFO - 'ts_paint', 09:16:35 INFO - 'tpaint', 09:16:35 INFO - 'sessionrestore', 09:16:35 INFO - 'sessionrestore_no_auto_restore', 09:16:35 INFO - 'tabpaint']}, 09:16:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:35 INFO - 'ts_paint', 09:16:35 INFO - 'tpaint', 09:16:35 INFO - 'sessionrestore', 09:16:35 INFO - 'sessionrestore_no_auto_restore', 09:16:35 INFO - 'tabpaint']}, 09:16:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['a11yr', 09:16:35 INFO - 'ts_paint', 09:16:35 INFO - 'tpaint', 09:16:35 INFO - 'sessionrestore', 09:16:35 INFO - 'sessionrestore_no_auto_restore', 09:16:35 INFO - 'tabpaint']}, 09:16:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['a11yr', 09:16:35 INFO - 'ts_paint', 09:16:35 INFO - 'tpaint', 09:16:35 INFO - 'sessionrestore', 09:16:35 INFO - 'sessionrestore_no_auto_restore', 09:16:35 INFO - 'tabpaint']}, 09:16:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['tsvgx', 09:16:35 INFO - 'tsvgr_opacity', 09:16:35 INFO - 'tart', 09:16:35 INFO - 'tscrollx', 09:16:35 INFO - 'cart']}, 09:16:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:35 INFO - 'tsvgr_opacity', 09:16:35 INFO - 'tart', 09:16:35 INFO - 'tscrollx', 09:16:35 INFO - 'cart']}, 09:16:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'talos_options': ['--disable-e10s'], 09:16:35 INFO - 'tests': ['tp5o']}, 09:16:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'tests': ['tp5o']}, 09:16:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'talos_options': ['--disable-e10s', 09:16:35 INFO - '--xperf_path', 09:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:35 INFO - 'tests': ['tp5n']}, 09:16:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:35 INFO - 'talos_options': ['--xperf_path', 09:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:35 INFO - 'tests': ['tp5n']}}, 09:16:35 INFO - 'talos.zip': {'path': '', 09:16:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:35 INFO - Running post-action listener: _resource_record_post_action 09:16:35 INFO - ##### 09:16:35 INFO - ##### Finished populate-webroot step (success) 09:16:35 INFO - ##### 09:16:35 INFO - ##### 09:16:35 INFO - ##### Running create-virtualenv step. 09:16:35 INFO - ##### 09:16:35 INFO - Running pre-action listener: _resource_record_pre_action 09:16:35 INFO - Running main action method: create_virtualenv 09:16:35 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:35 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 09:16:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:35 INFO - Using real prefix '/usr' 09:16:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:38 INFO - Installing pip.................done. 09:16:38 INFO - Return code: 0 09:16:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:38 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')]} 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:38 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')]} 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:38 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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:38 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 09:16:38 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 09:16:38 INFO - Using env: {'DISPLAY': ':0', 09:16:38 INFO - 'HOME': '/home/cltbld', 09:16:38 INFO - 'LANG': 'en_US.UTF-8', 09:16:38 INFO - 'LANGUAGE': 'en_US:en', 09:16:38 INFO - 'LOGNAME': 'cltbld', 09:16:38 INFO - 'MAIL': '/var/mail/cltbld', 09:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:38 INFO - 'MOZ_NO_REMOTE': '1', 09:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:38 INFO - 'NO_EM_RESTART': '1', 09:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:38 INFO - 'PWD': '/builds/slave/test', 09:16:38 INFO - 'SHELL': '/bin/bash', 09:16:38 INFO - 'SHLVL': '1', 09:16:38 INFO - 'TERM': 'linux', 09:16:38 INFO - 'TMOUT': '86400', 09:16:38 INFO - 'USER': 'cltbld', 09:16:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:38 INFO - '_': '/tools/buildbot/bin/python'} 09:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:38 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 09:16:38 INFO - Cleaning up... 09:16:38 INFO - Return code: 0 09:16:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:38 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')]} 09:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:38 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')]} 09:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:38 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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:38 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 09:16:38 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 09:16:38 INFO - Using env: {'DISPLAY': ':0', 09:16:38 INFO - 'HOME': '/home/cltbld', 09:16:38 INFO - 'LANG': 'en_US.UTF-8', 09:16:38 INFO - 'LANGUAGE': 'en_US:en', 09:16:38 INFO - 'LOGNAME': 'cltbld', 09:16:38 INFO - 'MAIL': '/var/mail/cltbld', 09:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:38 INFO - 'MOZ_NO_REMOTE': '1', 09:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:38 INFO - 'NO_EM_RESTART': '1', 09:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:38 INFO - 'PWD': '/builds/slave/test', 09:16:38 INFO - 'SHELL': '/bin/bash', 09:16:38 INFO - 'SHLVL': '1', 09:16:38 INFO - 'TERM': 'linux', 09:16:38 INFO - 'TMOUT': '86400', 09:16:38 INFO - 'USER': 'cltbld', 09:16:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:38 INFO - '_': '/tools/buildbot/bin/python'} 09:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:38 INFO - Downloading/unpacking psutil>=3.1.1 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16: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 09:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:40 INFO - Installing collected packages: psutil 09:16:40 INFO - Running setup.py install for psutil 09:16:40 INFO - building 'psutil._psutil_linux' extension 09:16:40 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 09:16:40 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 09:16:40 INFO - building 'psutil._psutil_posix' extension 09:16:40 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 09:16:40 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 09:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:40 INFO - Successfully installed psutil 09:16:40 INFO - Cleaning up... 09:16:41 INFO - Return code: 0 09:16:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:41 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')]} 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 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')]} 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:41 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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:41 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 09:16:41 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 09:16:41 INFO - Using env: {'DISPLAY': ':0', 09:16:41 INFO - 'HOME': '/home/cltbld', 09:16:41 INFO - 'LANG': 'en_US.UTF-8', 09:16:41 INFO - 'LANGUAGE': 'en_US:en', 09:16:41 INFO - 'LOGNAME': 'cltbld', 09:16:41 INFO - 'MAIL': '/var/mail/cltbld', 09:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:41 INFO - 'MOZ_NO_REMOTE': '1', 09:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:41 INFO - 'NO_EM_RESTART': '1', 09:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:41 INFO - 'PWD': '/builds/slave/test', 09:16:41 INFO - 'SHELL': '/bin/bash', 09:16:41 INFO - 'SHLVL': '1', 09:16:41 INFO - 'TERM': 'linux', 09:16:41 INFO - 'TMOUT': '86400', 09:16:41 INFO - 'USER': 'cltbld', 09:16:41 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:41 INFO - '_': '/tools/buildbot/bin/python'} 09:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:43 INFO - Installing collected packages: mozsystemmonitor 09:16:43 INFO - Running setup.py install for mozsystemmonitor 09:16:43 INFO - Successfully installed mozsystemmonitor 09:16:43 INFO - Cleaning up... 09:16:43 INFO - Return code: 0 09:16:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:16:43 INFO - Using env: {'DISPLAY': ':0', 09:16:43 INFO - 'HOME': '/home/cltbld', 09:16:43 INFO - 'LANG': 'en_US.UTF-8', 09:16:43 INFO - 'LANGUAGE': 'en_US:en', 09:16:43 INFO - 'LOGNAME': 'cltbld', 09:16:43 INFO - 'MAIL': '/var/mail/cltbld', 09:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:43 INFO - 'MOZ_NO_REMOTE': '1', 09:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:43 INFO - 'NO_EM_RESTART': '1', 09:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:43 INFO - 'PWD': '/builds/slave/test', 09:16:43 INFO - 'SHELL': '/bin/bash', 09:16:43 INFO - 'SHLVL': '1', 09:16:43 INFO - 'TERM': 'linux', 09:16:43 INFO - 'TMOUT': '86400', 09:16:43 INFO - 'USER': 'cltbld', 09:16:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:43 INFO - '_': '/tools/buildbot/bin/python'} 09:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:43 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:45 INFO - warning: no files found matching '*.txt' 09:16:45 INFO - no previously-included directories found matching 'build' 09:16:45 INFO - no previously-included directories found matching 'dist' 09:16:45 INFO - no previously-included directories found matching '.git*' 09:16:45 INFO - Installing collected packages: jsonschema, functools32 09:16:45 INFO - Running setup.py install for functools32 09:16:45 INFO - warning: no files found matching '*.txt' 09:16:45 INFO - no previously-included directories found matching 'build' 09:16:45 INFO - no previously-included directories found matching 'dist' 09:16:45 INFO - no previously-included directories found matching '.git*' 09:16:45 INFO - Successfully installed jsonschema functools32 09:16:45 INFO - Cleaning up... 09:16:46 INFO - Return code: 0 09:16:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:46 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')]} 09:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:46 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')]} 09:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:46 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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:46 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 09:16:46 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 09:16:46 INFO - Using env: {'DISPLAY': ':0', 09:16:46 INFO - 'HOME': '/home/cltbld', 09:16:46 INFO - 'LANG': 'en_US.UTF-8', 09:16:46 INFO - 'LANGUAGE': 'en_US:en', 09:16:46 INFO - 'LOGNAME': 'cltbld', 09:16:46 INFO - 'MAIL': '/var/mail/cltbld', 09:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:46 INFO - 'MOZ_NO_REMOTE': '1', 09:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:46 INFO - 'NO_EM_RESTART': '1', 09:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:46 INFO - 'PWD': '/builds/slave/test', 09:16:46 INFO - 'SHELL': '/bin/bash', 09:16:46 INFO - 'SHLVL': '1', 09:16:46 INFO - 'TERM': 'linux', 09:16:46 INFO - 'TMOUT': '86400', 09:16:46 INFO - 'USER': 'cltbld', 09:16:46 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:46 INFO - '_': '/tools/buildbot/bin/python'} 09:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:46 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:46 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 09:16:46 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 09:16:46 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 09:16:46 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 09:16:46 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 09:16:46 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 09:16:48 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:48 INFO - Downloading docopt-0.6.1.tar.gz 09:16:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:48 INFO - Running setup.py install for blobuploader 09:16:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:49 INFO - Running setup.py install for requests 09:16:49 INFO - Running setup.py install for docopt 09:16:49 INFO - Successfully installed blobuploader requests docopt 09:16:49 INFO - Cleaning up... 09:16:49 INFO - Return code: 0 09:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:49 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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:49 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 09:16:49 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 09:16:49 INFO - Using env: {'DISPLAY': ':0', 09:16:49 INFO - 'HOME': '/home/cltbld', 09:16:49 INFO - 'LANG': 'en_US.UTF-8', 09:16:49 INFO - 'LANGUAGE': 'en_US:en', 09:16:49 INFO - 'LOGNAME': 'cltbld', 09:16:49 INFO - 'MAIL': '/var/mail/cltbld', 09:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:49 INFO - 'MOZ_NO_REMOTE': '1', 09:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:49 INFO - 'NO_EM_RESTART': '1', 09:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:49 INFO - 'PWD': '/builds/slave/test', 09:16:49 INFO - 'SHELL': '/bin/bash', 09:16:49 INFO - 'SHLVL': '1', 09:16:49 INFO - 'TERM': 'linux', 09:16:49 INFO - 'TMOUT': '86400', 09:16:49 INFO - 'USER': 'cltbld', 09:16:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:49 INFO - '_': '/tools/buildbot/bin/python'} 09:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Running setup.py (path:/tmp/pip-eCaJgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:49 INFO - Running setup.py (path:/tmp/pip-iXHvk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:49 INFO - Running setup.py (path:/tmp/pip-UOUViB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:49 INFO - Running setup.py (path:/tmp/pip-4X3iVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:50 INFO - Running setup.py (path:/tmp/pip-MsDJRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:50 INFO - Running setup.py (path:/tmp/pip-gJ45QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Running setup.py (path:/tmp/pip-Mt_zyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Running setup.py (path:/tmp/pip-2hKwZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Running setup.py (path:/tmp/pip-4jPfjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Running setup.py (path:/tmp/pip-L6SLXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Running setup.py (path:/tmp/pip-0zgpsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:50 INFO - Running setup.py (path:/tmp/pip-WfPz3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:50 INFO - Running setup.py (path:/tmp/pip-X9J3ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:50 INFO - Running setup.py (path:/tmp/pip-gVFfXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:50 INFO - Running setup.py (path:/tmp/pip-0mX1Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:50 INFO - Running setup.py (path:/tmp/pip-N_IyTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:50 INFO - Running setup.py (path:/tmp/pip-jNMJ_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:50 INFO - Running setup.py install for manifestparser 09:16:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozcrash 09:16:51 INFO - Running setup.py install for mozdebug 09:16:51 INFO - Running setup.py install for mozdevice 09:16:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozfile 09:16:51 INFO - Running setup.py install for mozhttpd 09:16:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozinfo 09:16:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozInstall 09:16:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for mozleak 09:16:51 INFO - Running setup.py install for mozlog 09:16:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:51 INFO - Running setup.py install for moznetwork 09:16:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozprocess 09:16:52 INFO - Running setup.py install for mozprofile 09:16:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozrunner 09:16:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Running setup.py install for mozscreenshot 09:16:52 INFO - Running setup.py install for moztest 09:16:52 INFO - Running setup.py install for mozversion 09:16:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:52 INFO - Cleaning up... 09:16:52 INFO - Return code: 0 09:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:52 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')]} 09:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:52 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')]} 09:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:52 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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:52 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 09:16:52 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 09:16:52 INFO - Using env: {'DISPLAY': ':0', 09:16:52 INFO - 'HOME': '/home/cltbld', 09:16:52 INFO - 'LANG': 'en_US.UTF-8', 09:16:52 INFO - 'LANGUAGE': 'en_US:en', 09:16:52 INFO - 'LOGNAME': 'cltbld', 09:16:52 INFO - 'MAIL': '/var/mail/cltbld', 09:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:52 INFO - 'MOZ_NO_REMOTE': '1', 09:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:52 INFO - 'NO_EM_RESTART': '1', 09:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:52 INFO - 'PWD': '/builds/slave/test', 09:16:52 INFO - 'SHELL': '/bin/bash', 09:16:52 INFO - 'SHLVL': '1', 09:16:52 INFO - 'TERM': 'linux', 09:16:52 INFO - 'TMOUT': '86400', 09:16:52 INFO - 'USER': 'cltbld', 09:16:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:52 INFO - '_': '/tools/buildbot/bin/python'} 09:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:52 INFO - Running setup.py (path:/tmp/pip-pPDVHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:53 INFO - Running setup.py (path:/tmp/pip-kC_1fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:53 INFO - Running setup.py (path:/tmp/pip-IprTek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:53 INFO - Running setup.py (path:/tmp/pip-TQEH2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:53 INFO - Running setup.py (path:/tmp/pip-EnLicT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:53 INFO - Running setup.py (path:/tmp/pip-JEU1m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:53 INFO - Running setup.py (path:/tmp/pip-PBXIdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:53 INFO - Running setup.py (path:/tmp/pip-PtH1qQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:53 INFO - Running setup.py (path:/tmp/pip-wxkKfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:53 INFO - Running setup.py (path:/tmp/pip-EUgu7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:53 INFO - Running setup.py (path:/tmp/pip-SEFFdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:53 INFO - Running setup.py (path:/tmp/pip-ZXowzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:53 INFO - Running setup.py (path:/tmp/pip-8a4f0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:53 INFO - Running setup.py (path:/tmp/pip-7VsvHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:53 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)) 09:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:53 INFO - Running setup.py (path:/tmp/pip-fEsxV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:54 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)) 09:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:54 INFO - Running setup.py (path:/tmp/pip-mQrSrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:54 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)) 09:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:54 INFO - Running setup.py (path:/tmp/pip-AqOdHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 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)) 09:16:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:56 INFO - Downloading blessings-1.6.tar.gz 09:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:56 INFO - Installing collected packages: blessings 09:16:56 INFO - Running setup.py install for blessings 09:16:56 INFO - Successfully installed blessings 09:16:56 INFO - Cleaning up... 09:16:56 INFO - Return code: 0 09:16:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:56 INFO - Reading from file tmpfile_stdout 09:16:56 INFO - Current package versions: 09:16:56 INFO - argparse == 1.2.1 09:16:56 INFO - blessings == 1.6 09:16:56 INFO - blobuploader == 1.2.4 09:16:56 INFO - docopt == 0.6.1 09:16:56 INFO - functools32 == 3.2.3-2 09:16:56 INFO - jsonschema == 2.5.1 09:16:56 INFO - manifestparser == 1.1 09:16:56 INFO - mozInstall == 1.12 09:16:56 INFO - mozcrash == 0.17 09:16:56 INFO - mozdebug == 0.1 09:16:56 INFO - mozdevice == 0.48 09:16:56 INFO - mozfile == 1.2 09:16:56 INFO - mozhttpd == 0.7 09:16:56 INFO - mozinfo == 0.9 09:16:56 INFO - mozleak == 0.1 09:16:56 INFO - mozlog == 3.2 09:16:56 INFO - moznetwork == 0.27 09:16:56 INFO - mozprocess == 0.22 09:16:56 INFO - mozprofile == 0.28 09:16:56 INFO - mozrunner == 6.11 09:16:56 INFO - mozscreenshot == 0.1 09:16:56 INFO - mozsystemmonitor == 0.3 09:16:56 INFO - moztest == 0.7 09:16:56 INFO - mozversion == 1.4 09:16:56 INFO - psutil == 3.1.1 09:16:56 INFO - requests == 1.2.3 09:16:56 INFO - wsgiref == 0.1.2 09:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:56 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 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:56 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 09:16:56 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 09:16:56 INFO - Using env: {'DISPLAY': ':0', 09:16:56 INFO - 'HOME': '/home/cltbld', 09:16:56 INFO - 'LANG': 'en_US.UTF-8', 09:16:56 INFO - 'LANGUAGE': 'en_US:en', 09:16:56 INFO - 'LOGNAME': 'cltbld', 09:16:56 INFO - 'MAIL': '/var/mail/cltbld', 09:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:56 INFO - 'MOZ_NO_REMOTE': '1', 09:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:56 INFO - 'NO_EM_RESTART': '1', 09:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:56 INFO - 'PWD': '/builds/slave/test', 09:16:56 INFO - 'SHELL': '/bin/bash', 09:16:56 INFO - 'SHLVL': '1', 09:16:56 INFO - 'TERM': 'linux', 09:16:56 INFO - 'TMOUT': '86400', 09:16:56 INFO - 'USER': 'cltbld', 09:16:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:56 INFO - '_': '/tools/buildbot/bin/python'} 09:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 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)) 09:16:56 INFO - Cleaning up... 09:16:56 INFO - Return code: 0 09:16:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:16:56 INFO - Using env: {'DISPLAY': ':0', 09:16:56 INFO - 'HOME': '/home/cltbld', 09:16:56 INFO - 'LANG': 'en_US.UTF-8', 09:16:56 INFO - 'LANGUAGE': 'en_US:en', 09:16:56 INFO - 'LOGNAME': 'cltbld', 09:16:56 INFO - 'MAIL': '/var/mail/cltbld', 09:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:56 INFO - 'MOZ_NO_REMOTE': '1', 09:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:56 INFO - 'NO_EM_RESTART': '1', 09:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:56 INFO - 'PWD': '/builds/slave/test', 09:16:56 INFO - 'SHELL': '/bin/bash', 09:16:56 INFO - 'SHLVL': '1', 09:16:56 INFO - 'TERM': 'linux', 09:16:56 INFO - 'TMOUT': '86400', 09:16:56 INFO - 'USER': 'cltbld', 09:16:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:56 INFO - '_': '/tools/buildbot/bin/python'} 09:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:56 INFO - Cleaning up... 09:16:56 INFO - Return code: 0 09:16:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16: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')]} 09:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc8aaff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x211b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, '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': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', '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 09:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:16:56 INFO - Using env: {'DISPLAY': ':0', 09:16:56 INFO - 'HOME': '/home/cltbld', 09:16:56 INFO - 'LANG': 'en_US.UTF-8', 09:16:56 INFO - 'LANGUAGE': 'en_US:en', 09:16:56 INFO - 'LOGNAME': 'cltbld', 09:16:56 INFO - 'MAIL': '/var/mail/cltbld', 09:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:56 INFO - 'MOZ_NO_REMOTE': '1', 09:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:56 INFO - 'NO_EM_RESTART': '1', 09:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:56 INFO - 'PWD': '/builds/slave/test', 09:16:56 INFO - 'SHELL': '/bin/bash', 09:16:56 INFO - 'SHLVL': '1', 09:16:56 INFO - 'TERM': 'linux', 09:16:56 INFO - 'TMOUT': '86400', 09:16:56 INFO - 'USER': 'cltbld', 09:16:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:56 INFO - '_': '/tools/buildbot/bin/python'} 09:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:57 INFO - Downloading/unpacking flake8 09:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:16:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:16:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:59 INFO - no previously-included directories found matching 'docs/_build' 09:16:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:16:59 INFO - Running setup.py install for pep8 09:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:16:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:16:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:16:59 INFO - no previously-included directories found matching 'docs/_build' 09:16:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:16:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:16:59 INFO - Cleaning up... 09:17:00 INFO - Return code: 0 09:17:00 INFO - Running post-action listener: _resource_record_post_action 09:17:00 INFO - Running post-action listener: _start_resource_monitoring 09:17:00 INFO - Starting resource monitoring. 09:17:00 INFO - ##### 09:17:00 INFO - ##### Finished create-virtualenv step (success) 09:17:00 INFO - ##### 09:17:00 INFO - ##### 09:17:00 INFO - ##### Running install step. 09:17:00 INFO - ##### 09:17:00 INFO - Running pre-action listener: _resource_record_pre_action 09:17:00 INFO - Running main action method: install 09:17:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:00 INFO - Reading from file tmpfile_stdout 09:17:00 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:17:00 INFO - Reading from file tmpfile_stdout 09:17:00 INFO - Output received: 09:17:00 INFO - Usage: mozinstall [options] installer 09:17:00 INFO - Options: 09:17:00 INFO - -h, --help show this help message and exit 09:17:00 INFO - -d DEST, --destination=DEST 09:17:00 INFO - Directory to install application into. [default: 09:17:00 INFO - "/builds/slave/test"] 09:17:00 INFO - --app=APP Application being installed. [default: firefox] 09:17:00 INFO - mkdir: /builds/slave/test/build/application 09:17:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:17:16 INFO - Reading from file tmpfile_stdout 09:17:16 INFO - Output received: 09:17:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:17:16 INFO - Running post-action listener: _resource_record_post_action 09:17:16 INFO - ##### 09:17:16 INFO - ##### Finished install step (success) 09:17:16 INFO - ##### 09:17:16 INFO - ##### 09:17:16 INFO - ##### Running run-tests step. 09:17:16 INFO - ##### 09:17:16 INFO - Running pre-action listener: _resource_record_pre_action 09:17:16 INFO - Running main action method: run_tests 09:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:17:16 INFO - Python 2.7.3 09:17:16 INFO - Return code: 0 09:17:16 INFO - grabbing minidump binary from tooltool 09:17: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')]} 09:17:16 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 0x21aa1c0>, '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 0x21ab0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ab550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:17:16 INFO - Return code: 0 09:17:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:17:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:17:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:17:17 INFO - Return code: 0 09:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 09:17:17 INFO - Using env: {'DISPLAY': ':0', 09:17:17 INFO - 'HOME': '/home/cltbld', 09:17:17 INFO - 'LANG': 'en_US.UTF-8', 09:17:17 INFO - 'LANGUAGE': 'en_US:en', 09:17:17 INFO - 'LOGNAME': 'cltbld', 09:17:17 INFO - 'MAIL': '/var/mail/cltbld', 09:17:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:17:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:17 INFO - 'MOZ_NO_REMOTE': '1', 09:17:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:17:17 INFO - 'NO_EM_RESTART': '1', 09:17:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:17 INFO - 'PWD': '/builds/slave/test', 09:17:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:17:17 INFO - 'SHELL': '/bin/bash', 09:17:17 INFO - 'SHLVL': '1', 09:17:17 INFO - 'TERM': 'linux', 09:17:17 INFO - 'TMOUT': '86400', 09:17:17 INFO - 'USER': 'cltbld', 09:17:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043', 09:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:17 INFO - '_': '/tools/buildbot/bin/python'} 09:17:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 09:17:17 INFO - mozversion application_buildid: 20160627064426 09:17:17 INFO - mozversion application_changeset: 034fb275b74282c34caf311a9cbddd730cc0fe15 09:17:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:17:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:17:17 INFO - mozversion application_name: Firefox 09:17:17 INFO - mozversion application_remotingname: firefox-dev 09:17:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:17 INFO - mozversion application_vendor: Mozilla 09:17:17 INFO - mozversion application_version: 49.0a2 09:17:17 INFO - mozversion platform_buildid: 20160627064426 09:17:17 INFO - mozversion platform_changeset: 034fb275b74282c34caf311a9cbddd730cc0fe15 09:17:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:17:17 INFO - mozversion platform_version: 49.0a2 09:17:17 INFO - using testdate: 1467044237 09:17:17 INFO - actual date: 1467044237 09:17:17 INFO - starting webserver on 'localhost:37523' 09:17:17 INFO - SUITE-START | Running 2 tests 09:17:17 INFO - TEST-START | dromaeo_css 09:17:17 INFO - operating with platform_type : linux_ 09:17:17 INFO - Initialising browser for dromaeo_css test... 09:17:17 INFO - TEST-INFO | started process 13491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUP347s/profile http://localhost:37523/getInfo.html) 09:17:21 INFO - PROCESS | 13491 | __metrics Screen width/height:1600/1200 09:17:21 INFO - PROCESS | 13491 | colorDepth:24 09:17:21 INFO - PROCESS | 13491 | Browser inner width/height: 1024/697 09:17:21 INFO - PROCESS | 13491 | __metrics 09:17:22 ERROR - PROCESS | 13491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:17:23 INFO - TEST-INFO | 13491: exit 0 09:17:23 INFO - Browser initialized. 09:17:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:23 INFO - TEST-INFO | started process 13620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUP347s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:35 INFO - PROCESS | 13620 | RSS: Main: 155688960 09:17:35 INFO - PROCESS | 13620 | 09:18:25 INFO - PROCESS | 13620 | 1467044305202 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] 09:20:33 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:37523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37523/tests/dromaeo/cssquery-ext.html) 09:20:34 INFO - PROCESS | 13620 | RSS: Main: 160043008 09:20:34 INFO - PROCESS | 13620 | 09:23:36 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:37523/tests/dromaeo/cssquery-ext.html (next: http://localhost:37523/tests/dromaeo/cssquery-jquery.html) 09:23:36 INFO - PROCESS | 13620 | RSS: Main: 157757440 09:23:36 INFO - PROCESS | 13620 | 09:26:38 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:37523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37523/tests/dromaeo/cssquery-mootools.html) 09:26:39 INFO - PROCESS | 13620 | RSS: Main: 157532160 09:26:39 INFO - PROCESS | 13620 | 09:29:40 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:37523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37523/tests/dromaeo/cssquery-prototype.html) 09:29:41 INFO - PROCESS | 13620 | RSS: Main: 156864512 09:29:41 INFO - PROCESS | 13620 | 09:32:43 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:37523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37523/tests/dromaeo/cssquery-yui.html) 09:32:44 INFO - PROCESS | 13620 | RSS: Main: 159027200 09:32:44 INFO - PROCESS | 13620 | 09:35:46 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:37523/tests/dromaeo/cssquery-yui.html (next: http://localhost:37523/tests/dromaeo/cssquery-dojo.html) 09:35:47 INFO - PROCESS | 13620 | RSS: Main: 159010816 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | __start_tp_report 09:35:47 INFO - PROCESS | 13620 | _x_x_mozilla_page_load 09:35:47 INFO - PROCESS | 13620 | _x_x_mozilla_page_load_details 09:35:47 INFO - PROCESS | 13620 | |i|pagename|runs| 09:35:47 INFO - PROCESS | 13620 | |0;dojo.html;3394.796312221267;3432.021873765977;3450.982745086275;3469.583649962005;3471;5694.886102277957;5733.111367738002;5740.540756739467;5808.854778630536;5810.070388737803;5736.45503677151;5763.164341170538;5810.273715785527;5825.242718446607;5831.970840145804;5212.791488340471;5257.526822585966;5278.261043453919;5305.973470132644;5356.1697936819855;5158.123119069748;5160.200168973796;5337.306150200468;5341.03861304965;5341.359036915575;5196.168613021917;5203.167493201088;5249.816256431026;5252.474752524755;5257.605679574028;5231.65994210377;5236.083685355066;5309.91146814902;5313.256144139824;5314.654547454403;5184.792608295664;5231.921521177185;5265.104932161542;5291.126964050927;5291.947080529184;5543.6396634218645;5548.5838562108;5554.833354999357;5600.719964001783;5677.290338707661;6181.258249010148;6202.96898515509;6205.472534834545;6242.1261023456755;6245.219347581552;6033.607815492023;6276.686165691697;6279.529035322369;6280.560360774748;6285.748570057192;5677.9495793278375;5716.714164291769;5737.7131143443075;5779.104238842986;5789.392113828072;6226.346233645492;6285.2457705075685;6302.212223472066;6305.054241863665;6312.905306420315;5797.2173756542325;5988.8802223956145;6046.2139921809885;6051.334353221142;6051.606645568112;6055.273367195965;6158;6173.32093469718;6193.1329613854095;6198.318184999646;6111.908321375183;6147;6147.72335244915;6157.076438534255;6163.476104531075;5979.701014949235;6130.295016073209;6135.967692822179;6157.630542167484;6187.752489900354;4624.375709279204;4697.600703940135;4697.671163018625;4710.717356958594;4740.857774266778;4220.282551966173;4244.045089854758;4248.830046798155;4251.234777740036;4262.722923009995;5935.109733539917;5989.131575921554;5995.490383317467;6007.038873780261;6036.456718895321;6034.39656034393;6203.2245969253845;6248.781292654735;6264;6292;6047.15339852421;6047.213862197887;6047.337396144008;6047.667378294148;6078.635281883101;5186.559142472932;5276.709780962007;5294.7617357219015;5328.174133009312;5372.059889519397;6430.196225471816;6450.225972883284;6454.354564543602;6461.903071453932;6466.030095485715;6082.11809287642;6245.406686364788;6249.0626406039455;6303.936960630335;6319.494440444845;6270.686465676789;6339.809805705836;6361.236651601837;6427.839304017437;6440.388163124496;6132.41742034506;6132.908006379818;6135.539834512519;6145.539084568764;6150.138980542817;6075.635461872125;6170.7223174958135;6233.96883015582;6238.064290356483;6243.843903902439;6081.391860813883;6135.938640613536;6145.8156255312415;6146.446819786241;6147.508199343953;6121.357257488078;6127.986433238494;6133.507474962901;6148.44663980244;6156.353582873913;5818.650880947157;5894.498967587631;5897.5281977440845;6045.093236014457;6073;6022.90965635507;6067.24159480065;6124.533510047256;6133.294671112879;6150.969245153746;5947.583669143119;5987.5808693391045;5992.460678538952;6009.639421634716;6015.849603759941 09:35:47 INFO - PROCESS | 13620 | |1;ext.html;599.5743022454058;641.7753786174842;644.7485480662542;646;665.4676258992805;45866.3120053199;47065.764671176636;47543.76228118859;47584;51515.742421287934;47826;48167.27749083767;48482;48486;48501.272480912725;9163.679271225508;9307.162355388014;9308.394954327981;9309.813803723922;9318.440893546374;9114.908850911506;9187.816243675123;9192.908070919271;9216.2626989841;9226.215771659417;9175.72472825813;9237.95381023094;9253.768655783591;9285.814283714322;9288.628454861797;9186.816263674722;9206.49364284964;9264.305177111677;9277.95361023194;9289;9200.125988031126;9293.67472138472;9297.302702297287;9306.488143152124;9307.76730581734;45208.547914520765;45456.318155227695;45684;45814.54185458136;45829.31256031162;3537.770044947096;3560.305740380627;3654.4335627977707;3743.775373477573;3784.2999045176457;34571.481427778606;34698.13254668628;34877.476837847455;34881.30237395263;35118.47322290167;4726.422385604719;4755.857324280277;4770.022145460172;4796.880077998043;4813.302071199691;260137;260881;261649;261759.9999999981;261871;66188.66905665441;66577.66711166414;66656.99999999903;66694;66835.33164668291;39727.40408893869;40553.18893622111;40584.59415405867;42182;42201.57798422038;18367.54081147982;18561.16474758639;18627.441176764718;18639.347622833135;18651.440456786317;14604.707905841824;14761.40954361835;14830.184339861411;14850.183239921693;14875.553733388017;21259.78740212609;21395.358139255848;21474.57050859005;21532.461688457915;21704.891475542838;7307.232740562271;7378.733762994511;7609.505382150253;7676.731314403969;7747.573883436465;993.8558908958161;1078.5308390850005;1121.899029087386;1164.4876254448016;1180.397997021508;32982.340353192805;33066.248388998465;33397.3320533588;33544.66455335464;33922.66077339245;1116.213069785799;1174.94712737927;1182.5565412970136;1242.0560374115557;1244.9315287659265;17485.213165407586;17581.120943952752;17627;17850;17917;612017;620989;670864;679306;683366;60598.69700651557;61396.69301653552;61405.69297153486;61475.38524614786;61594;1465.736167489862;1506.6082818467057;1507.8869084818682;1510.9168995705343;1523.2079318754186;32420.35159296848;32510.83744581262;33087.50368744519;33253.50119748254;33747.15632109217;54694;55340.16989745077;55347.723261383435;55484.72257638686;55496.72251638716;408858;409256;410344;411378;411536;30172.5474117884;30351.544726829557;30617;30833.691663083082;31030.534541981437;49467.257991129445;49564.50435495599;50174.2473862885;50385.49614503955;51117.23324150066;40546.59453405428;41074.38388424236;41974;42168.578314217695;43329;41696.79151604223;41846.16307673891;42781.64700941478;42892;43092.569074308856;42751.57248427476;42774.78612606917;43345;43350.78324608357;43464.78267608642;36281.63718362783;36482;37221.441678375384;37762.811185943894;37850.62149378471;28450;28575.857120714263;28638.713612863605;28804.567931480626;29000.274993125342 09:35:47 INFO - PROCESS | 13620 | |2;jquery.html;405.6471666990588;406.82099876054536;415.10337670631435;416.3525717509272;424.33167760776786;19197.61604767904;20084.09621567029;20532.589348213027;20581.69127463089;21049.579008419823;19033.428997130075;19139.712904306412;19902.606817522777;20075.297364592243;20115.19539218433;4917.33615961845;5193.896122077556;5205.349331333583;5270.314859068316;5286.867828304285;5107.7701503432245;5209.973950130263;5250.6324557281005;5337.3061502004875;5395.271638328834;5352.732363381835;5353.330833645794;5354.116570765819;5376.327959005124;5378.865528361783;5349.812756553502;5362.088444964346;5368.892622147555;5622;5642.57680673947;5383.75773090208;5523.171524271352;5530.059889818741;5542.8337149885565;5661.7735290588325;13853.238071906042;14084.647883802885;14285.571432856927;14350.928245358706;14397.85602143986;2101.842361822854;2261.547690461914;2400.939976500584;2498.3379404457833;2563.628273900274;10492.160627149886;10756.247062705614;11004.284721493077;11705.063594912472;14970.251487425585;1997.340877510418;2055.157385471964;2116.5237821490196;2142.2609199826034;2144.4102871710247;63638.681806591136;75236;80097.99999999942;83839;86947;10970.561177552809;11533.884661153448;11620.941895290469;11710.88289117115;11732.765344693058;16080.758788618181;16184.433544825875;16263.129740079805;16293.103879286753;16306.184690765414;8666.436681615674;8688.6524539019;8759.474431534129;8829.55852207387;8856.557172141496;8761.474311541328;8780.473171609723;8795.076516965755;8833.293336533063;8900.688475903313;4852.514748525119;4856.78144483492;4868.805247790119;4908.607311415079;4913.778879950411;1984.5137941204498;2026.2097781865084;2031.2890488328967;2039.5512987142804;2067.3487851326786;960.1406740966795;1029.1663752360612;1042.3537406807677;1076.9299995500267;1086.093112251279;19367;19973.400797976083;20297.492562685755;20324.59350813005;20432;1011.3881101933224;1041.375174895072;1055.2824079625775;1060.506864308085;1118.2116607791488;10870.782584348268;11162.944185279022;11258.66224013281;11366.374849383197;11455.770884582262;473394.07540841744;476516;480010;482852;487942;93391.53304233435;94085.58871616794;94903;94913;95977.520112399;1047.502436342731;1061.2518174686827;1075.1398880895254;1082.0153660169208;1086.0497065068066;16833;17550.648987019933;17744.733828992834;17812.91093544524;17928.103594819946;44265.557344426146;44998;45180.548194517636;45255.094898102514;45356.31965520586;60152.69923650354;60497.28865232347;60699.63355373274;62233;62303.37696622976;7931.603419829101;8153.306968907709;8578.313734901318;8820.11798820113;9215.769605759642;13956.651083722989;14012.369443375277;14194.290285485891;14489.927550362181;14669.413223471369;12181.817272740738;12250.326232057323;12473.812892806434;12667.176633518791;12969.805452918403;12381.938090309492;12599.87400125987;12602.36988150607;12728.48751981997;12890.806637900627;6431.5819471734185;11241.60654377093;11909.213617957375;12706.618801435972;12730.872691272969;7872.803179920319;8150.347972162332;8397;8508.702195423131;8556.358273129665;12433.502659893504;12532.122751407314;12610.49558017669;12713.300768457824;13034.543790967271 09:35:47 INFO - PROCESS | 13620 | |3;mootools.html;1532.310460292868;1573.8032745906762;1706.1980868991577;1788.2936240185136;1809.3848091648836;8040.798980025503;8494.235518803307;8611.224989750921;9203.58583863727;9205.723828285154;8532.957335213316;8836.690715824947;8856.025837157924;8869.95565022174;8885.866711999326;2362.870042147681;2393.258089992108;2403.663487111806;2405.242348660175;2409.674693916325;2284.120613563773;2340.20433052762;2352.5059737455153;2375.2399232245602;2376.3583832365252;2361.3034154924253;2361.586722323595;2375.1449478187837;2398.7241467231315;2403.7836594706473;2346.9295921122393;2350.471143992588;2366.349253955159;2366.4912043910554;2379.845310054858;2281.885905704708;2341.555104530134;2353.752855950118;2376.6910301660846;2386.248331775485;8840.513771742551;8956.910430895672;8958.820823583557;8965.058668839743;8989.595468203946;5350.9732451337495;5460.235567020621;5481.671099733989;5487.368952570426;5489.780408783644;3471.7049050830456;3479.80861052642;3542.3623747725655;3552.8045957472327;3592.389293820057;1188.791961406759;1198.6164427383242;1204.680759598707;1227.8096894981293;1235.8702336254653;12512.249265044036;12584.496620135184;12597.622071337966;12653.177543459646;12663.936680316632;4670.182718024332;4736.194846876039;4741.051789642085;4761.642876784255;4842.975785121052;10571.682849514527;10572.629957951434;10588;10602.522886470128;10627.309224900357;5247.895042099137;5291.603129765283;5311.362636483569;5315.681059136464;5503.036968530491;4502.549745025472;4814.759262036954;4937.23472861707;4955.231939049453;4958.727270000112;4141.378793180987;4179.101493178981;4184.727992680466;4218.240716671029;4218.873433796991;1258.930758808256;1290.1742884553894;1298.0524217321408;1302.9804552931714;1307.6992291772945;940.1773448232797;1020.8877023527406;1027.1012863744224;1045.362328979322;1053.1732589916878;6051.971164901977;6084.939150608526;6112.938870611326;6162.198914141133;6350.6189628621505;992;1027.4862568715641;1046.0742243114746;1048.1405247696816;1076.4563895232857;4032.0927791246736;4111.48606424197;4143.854965076208;4163.500379954425;4199.496060472763;10945.507452164671;11097.611583594535;11260.09919206478;11262.155338349492;11289.435528223556;10939.617113400993;11057.06014988719;11078.169137314733;11110.111191104692;11245.83131253032;7774;8211.71259005932;8234.711785087493;8403.453775504573;8553.358498112666;5703.401142879938;5797.623154494944;5823.563232757645;5868.823935281948;5925.05199168131;9899.455529945923;10046.24653151002;10444.060034596923;10447.94776026115;10488.68533943983;10377.16982641402;10392.220583456423;10523.94738026305;10600.840987385041;10687.984641459048;7449.5902725350625;7941.563214023284;8075.636596353295;8182.263596276363;8183;8744.475331480131;8771.210591046836;8772.91227087721;8779.034306226182;8801.163889430494;8023.6389362479995;8176.632051557814;8205.83588328242;8213.876791848008;8331.500109993178;7820.5307681537015;7902.920970790218;7923.7226697065325;8054.395920305883;8127.268545830903;7024.438044956493;7041.788746337618;7043.436525078084;7111.573305601681;7129.429645628234;5033.2701758245585;5037.345145131109;5044.1424957758;5061.519155680205;5084.542391184811;5066.290719299374;5130.230465430215;5233.659812112201;5276.788928442819;5405.432429594836 09:35:47 INFO - PROCESS | 13620 | |4;prototype.html;346.674126321258;351.9736019798515;353.09255214099755;354.3055611002435;356.0937414280655;5904.645721256722;5923.3188183358925;5924.703764811758;5945.732442040107;5953.791617293385;5758;5762.481376676098;5770;5773.220615216945;5776.295992682159;4332.935005974913;4440.80098373439;4459.754713490756;4473.798679059434;4486.798094085774;4421.911561768763;4471.530489298626;4474.239379305526;4491.932621010671;4495.348174514694;4433.866983990485;4452.755098469583;4452.910941781162;4467.151241264166;4478.8880277992985;4366.366876802862;4377.430933978594;4377.956220437787;4417.779111044451;4421.867343979686;3855.768653880776;3857.787821669807;3878.592747761501;3893.1824316893485;3907.9218415631526;5567.3040869891265;5579.330480342385;5603.551715862721;5607.467290607386;5670.68811215383;4891.779869905863;5067.695938243717;5085.949140508585;5086.694798312114;5099.592032637417;6038;6041.6375017499095;6043.214382130339;6084.47888027993;6088;4254.8086535770035;4306.7631280279575;4308.892277693051;4315.374270730757;4335.176316499855;6083.787067452662;6164.106204600308;6287.465565426898;6300.716467759008;6309.760035187488;4282.571742825755;4314.69797114199;4322.891927701832;4362.345648152803;4371.846985355561;4374.21264172452;4403.823847046082;4412.646988240997;4415.602595766396;4416.580424859633;4950.752462376867;5057.165567681292;5069.340985671839;5099.847004589868;5129.563987061141;6132.6933653317155;6138.294096178996;6147.631142131397;6157.784477543264;6161.7227224775;1537.7847101405812;1552.8974428156137;1559.1035154786043;1559.5789136932965;1560.3836484588523;934.2946075712794;975.4244995452717;975.9606019589115;981.2199301555138;998.630506712521;5385.461453854583;5390.434004429557;5392.245085688007;5403.675779453245;5429.864253393618;5585.804496842591;5589;5630.40880707528;5662.5753068520025;5688.488036076773;5363.061464243741;5366.436524164985;5595.38450770415;6063.302720187146;6065.969670151621;3383.6447173046968;3384.1539615096226;3411.3177364527196;3430.8627654894026;3434.935170097278;6286.622802631857;6565.868682626321;6594.538382313192;6618.881957773467;6637.236717777518;6365.96817015912;6426.6825300813225;6436.710348034349;6456.257530384066;6496.707648155844;6223.3465486123305;6438.484921206292;6500.219973603103;6533.346665333429;6611.66941652925;6304.590201636879;6310.2743184534365;6313.569275828931;6349.238091429058;6360.204974378203;5889.941100589111;6216.720247588779;6257.124002639725;6322;6322.430981211713;6352.333005034405;6496.317886622026;6508.494229721497;6519.315471875385;6523.282438931808;4383.53151694186;4384.605385515319;4404.515503294571;4414.205443020287;4432.933505997477;6153.507719382349;6213.316535181217;6309.400606942333;6312.242530896322;6372.171617689671;6070.908936366046;6089.081939189141;6134.754609815736;6137.478314343331;6153.569250152446;5988.28140623128;6140.263168419819;6156.384361563808;6169.84575385619;6175.814725558241;6040.365761595145;6067;6071.574989750675;6092.573519853568;6094;6221.657808820558;6241.500679945502;6243.219597550306;6246.875062498633;6268.561200715906;5783.94216057834;6044.854076802848;6066.575339726177;6068.393160684073;6071.967765479791 09:35:47 INFO - PROCESS | 13620 | |5;yui.html;745.8060904164915;777.304312640187;857.1899554920601;857.9957100214498;891.6968230801529;14424.278786060695;14599.562013139623;14733.18967456792;14767.630809229775;15542.145182014985;14747.557573272792;14764.18796966169;14780.6304842379;14787.482438114668;14854.1830199339;698.2842586348995;820.4789958376444;835.8996920369564;844.252836239929;847.6058632735777;848.3043903998692;854.3976496569934;855.6491838346279;856.8115014696788;858.9785255368635;896.919277265046;899.6131663384742;900.0954041188629;900.5092224737501;900.5362238447204;885.9512726800024;891.8483857744199;896.1038961038961;896.9506677132755;898.4429653614768;653.7548419342746;655.6131882189532;656.3043174235278;656.5961933410965;657.3787770556826;15633.452829150925;15645.687086258326;15723.449679261172;15729.449469268635;15789.21053947298;14425.495107671286;15751.527454176394;15845.166949942482;16368.345266189339;16383.59041023972;11841.703957401047;12730.681732956658;12821.487140514368;12894.548690795871;13658.180509169382;4812.614990800763;4874.975625121887;4880.755962201912;4913.31213630092;5014.022265658198;79300.60349698272;80688.59655701743;82204.58897705533;82603.5869820653;82895.9999999994;12061;12109.455074521667;12145.878541214475;12367.443465044094;12471.625851224479;21306.680399794015;21385;21422.678659820114;21492.247771328242;21503.462413439476;8774.649014039494;8810.911890881009;8855.778605534784;8906.688265910661;9090.727278181534;4859.538343857328;4878.414590249122;4898.853034408973;4958.8512344629;5260.789568417297;3754.662080412776;3854.9807250964127;3855.980720096438;3860.6718428933295;3863.4204869269834;673.7810211681223;675.4090171100287;688.3323176518769;729.806601250669;735.3381956239427;717.4045542199962;724.586985418317;743.1750756660103;746.7535713214626;795.4988357334842;9989;10010.749731256778;10488.370697758159;10627.096696780705;10790.730231744112;778.676849107614;807.0808422663854;807.6325272001226;807.7576726981882;827.3546633625662;4917.360743103373;4984.451710311862;5005.6996580205305;5024.371953505812;5033.47148549397;72354.27645723581;72614;73051;77493;84510;67650;79711.20288797037;85033.57483212545;97341.51329243308;107819;76397;78148.60925695335;95930.52034739782;96643.0335696634;96718.51640741751;10031.899681003388;10048.799024019625;10365.63720269787;10687.358758474516;10798.082163016232;38029.809850950565;43307.35038974481;43381.78309108434;45740.08519829651;46394.768026161;55324.44675553354;56037.71981140068;69512.52437378009;69616.6519167401;73495.63252183705;13535.120217185851;14140;14157.433702651779;14296;14432.278386080863;15741.134237616583;15799.289031993818;15988.68022639564;16009.35962561531;16609.086500242604;14265.786013210018;15221.238938053275;15729.213539323217;16461.176941152655;16580.419685310957;14469;14712.19082950448;15385.923070384577;15643.374265029272;15726;13777.586672399844;13935.512257070954;14320.355583998953;15219.162946037632;15387.61530961735;11742.354170520362;11803;12263.816042759545;12470.875291247334;12488.375581221084;11985;12252.203606765532;12450.564230251897;12530.624081277576;12563.12058155957 09:35:47 INFO - PROCESS | 13620 | __end_tp_report 09:35:47 INFO - PROCESS | 13620 | __start_cc_report 09:35:47 INFO - PROCESS | 13620 | _x_x_mozilla_cycle_collect,334 09:35:47 INFO - PROCESS | 13620 | __end_cc_report 09:35:47 INFO - PROCESS | 13620 | __startTimestamp1467045347088__endTimestamp 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | ------- Summary: start ------- 09:35:47 INFO - PROCESS | 13620 | Number of tests: 6 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | [#0] dojo.html Cycles:165 Average:5756.31 Median:6034.40 stddev:648.74 (10.8%) stddev-sans-first:623.72 09:35:47 INFO - PROCESS | 13620 | Values: 3394.8 3432.0 3451.0 3469.6 3471.0 5694.9 5733.1 5740.5 5808.9 5810.1 5736.5 5763.2 5810.3 5825.2 5832.0 5212.8 5257.5 5278.3 5306.0 5356.2 5158.1 5160.2 5337.3 5341.0 5341.4 5196.2 5203.2 5249.8 5252.5 5257.6 5231.7 5236.1 5309.9 5313.3 5314.7 5184.8 5231.9 5265.1 5291.1 5291.9 5543.6 5548.6 5554.8 5600.7 5677.3 6181.3 6203.0 6205.5 6242.1 6245.2 6033.6 6276.7 6279.5 6280.6 6285.7 5677.9 5716.7 5737.7 5779.1 5789.4 6226.3 6285.2 6302.2 6305.1 6312.9 5797.2 5988.9 6046.2 6051.3 6051.6 6055.3 6158.0 6173.3 6193.1 6198.3 6111.9 6147.0 6147.7 6157.1 6163.5 5979.7 6130.3 6136.0 6157.6 6187.8 4624.4 4697.6 4697.7 4710.7 4740.9 4220.3 4244.0 4248.8 4251.2 4262.7 5935.1 5989.1 5995.5 6007.0 6036.5 6034.4 6203.2 6248.8 6264.0 6292.0 6047.2 6047.2 6047.3 6047.7 6078.6 5186.6 5276.7 5294.8 5328.2 5372.1 6430.2 6450.2 6454.4 6461.9 6466.0 6082.1 6245.4 6249.1 6303.9 6319.5 6270.7 6339.8 6361.2 6427.8 6440.4 6132.4 6132.9 6135.5 6145.5 6150.1 6075.6 6170.7 6234.0 6238.1 6243.8 6081.4 6135.9 6145.8 6146.4 6147.5 6121.4 6128.0 6133.5 6148.4 6156.4 5818.7 5894.5 5897.5 6045.1 6073.0 6022.9 6067.2 6124.5 6133.3 6151.0 5947.6 5987.6 5992.5 6009.6 6015.8 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | [#1] ext.html Cycles:180 Average:61256.20 Median:42763.18 stddev:125652.50 (293.8%) stddev-sans-first:125922.46 09:35:47 INFO - PROCESS | 13620 | Values: 599.6 641.8 644.7 646.0 665.5 45866.3 47065.8 47543.8 47584.0 51515.7 47826.0 48167.3 48482.0 48486.0 48501.3 9163.7 9307.2 9308.4 9309.8 9318.4 9114.9 9187.8 9192.9 9216.3 9226.2 9175.7 9238.0 9253.8 9285.8 9288.6 9186.8 9206.5 9264.3 9278.0 9289.0 9200.1 9293.7 9297.3 9306.5 9307.8 45208.5 45456.3 45684.0 45814.5 45829.3 3537.8 3560.3 3654.4 3743.8 3784.3 34571.5 34698.1 34877.5 34881.3 35118.5 4726.4 4755.9 4770.0 4796.9 4813.3 260137.0 260881.0 261649.0 261760.0 261871.0 66188.7 66577.7 66657.0 66694.0 66835.3 39727.4 40553.2 40584.6 42182.0 42201.6 18367.5 18561.2 18627.4 18639.3 18651.4 14604.7 14761.4 14830.2 14850.2 14875.6 21259.8 21395.4 21474.6 21532.5 21704.9 7307.2 7378.7 7609.5 7676.7 7747.6 993.9 1078.5 1121.9 1164.5 1180.4 32982.3 33066.2 33397.3 33544.7 33922.7 1116.2 1174.9 1182.6 1242.1 1244.9 17485.2 17581.1 17627.0 17850.0 17917.0 612017.0 620989.0 670864.0 679306.0 683366.0 60598.7 61396.7 61405.7 61475.4 61594.0 1465.7 1506.6 1507.9 1510.9 1523.2 32420.4 32510.8 33087.5 33253.5 33747.2 54694.0 55340.2 55347.7 55484.7 55496.7 408858.0 409256.0 410344.0 411378.0 411536.0 30172.5 30351.5 30617.0 30833.7 31030.5 49467.3 49564.5 50174.2 50385.5 51117.2 40546.6 41074.4 41974.0 42168.6 43329.0 41696.8 41846.2 42781.6 42892.0 43092.6 42751.6 42774.8 43345.0 43350.8 43464.8 36281.6 36482.0 37221.4 37762.8 37850.6 28450.0 28575.9 28638.7 28804.6 29000.3 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | [#2] jquery.html Cycles:180 Average:28908.62 Median:11583.05 stddev:79279.97 (684.4%) stddev-sans-first:79473.49 09:35:47 INFO - PROCESS | 13620 | Values: 405.6 406.8 415.1 416.4 424.3 19197.6 20084.1 20532.6 20581.7 21049.6 19033.4 19139.7 19902.6 20075.3 20115.2 4917.3 5193.9 5205.3 5270.3 5286.9 5107.8 5210.0 5250.6 5337.3 5395.3 5352.7 5353.3 5354.1 5376.3 5378.9 5349.8 5362.1 5368.9 5622.0 5642.6 5383.8 5523.2 5530.1 5542.8 5661.8 13853.2 14084.6 14285.6 14350.9 14397.9 2101.8 2261.5 2400.9 2498.3 2563.6 10492.2 10756.2 11004.3 11705.1 14970.3 1997.3 2055.2 2116.5 2142.3 2144.4 63638.7 75236.0 80098.0 83839.0 86947.0 10970.6 11533.9 11620.9 11710.9 11732.8 16080.8 16184.4 16263.1 16293.1 16306.2 8666.4 8688.7 8759.5 8829.6 8856.6 8761.5 8780.5 8795.1 8833.3 8900.7 4852.5 4856.8 4868.8 4908.6 4913.8 1984.5 2026.2 2031.3 2039.6 2067.3 960.1 1029.2 1042.4 1076.9 1086.1 19367.0 19973.4 20297.5 20324.6 20432.0 1011.4 1041.4 1055.3 1060.5 1118.2 10870.8 11162.9 11258.7 11366.4 11455.8 473394.1 476516.0 480010.0 482852.0 487942.0 93391.5 94085.6 94903.0 94913.0 95977.5 1047.5 1061.3 1075.1 1082.0 1086.0 16833.0 17550.6 17744.7 17812.9 17928.1 44265.6 44998.0 45180.5 45255.1 45356.3 60152.7 60497.3 60699.6 62233.0 62303.4 7931.6 8153.3 8578.3 8820.1 9215.8 13956.7 14012.4 14194.3 14489.9 14669.4 12181.8 12250.3 12473.8 12667.2 12969.8 12381.9 12599.9 12602.4 12728.5 12890.8 6431.6 11241.6 11909.2 12706.6 12730.9 7872.8 8150.3 8397.0 8508.7 8556.4 12433.5 12532.1 12610.5 12713.3 13034.5 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | [#3] mootools.html Cycles:180 Average:5928.48 Median:4218.56 stddev:3358.50 (79.6%) stddev-sans-first:3351.68 09:35:47 INFO - PROCESS | 13620 | Values: 1532.3 1573.8 1706.2 1788.3 1809.4 8040.8 8494.2 8611.2 9203.6 9205.7 8533.0 8836.7 8856.0 8870.0 8885.9 2362.9 2393.3 2403.7 2405.2 2409.7 2284.1 2340.2 2352.5 2375.2 2376.4 2361.3 2361.6 2375.1 2398.7 2403.8 2346.9 2350.5 2366.3 2366.5 2379.8 2281.9 2341.6 2353.8 2376.7 2386.2 8840.5 8956.9 8958.8 8965.1 8989.6 5351.0 5460.2 5481.7 5487.4 5489.8 3471.7 3479.8 3542.4 3552.8 3592.4 1188.8 1198.6 1204.7 1227.8 1235.9 12512.2 12584.5 12597.6 12653.2 12663.9 4670.2 4736.2 4741.1 4761.6 4843.0 10571.7 10572.6 10588.0 10602.5 10627.3 5247.9 5291.6 5311.4 5315.7 5503.0 4502.5 4814.8 4937.2 4955.2 4958.7 4141.4 4179.1 4184.7 4218.2 4218.9 1258.9 1290.2 1298.1 1303.0 1307.7 940.2 1020.9 1027.1 1045.4 1053.2 6052.0 6084.9 6112.9 6162.2 6350.6 992.0 1027.5 1046.1 1048.1 1076.5 4032.1 4111.5 4143.9 4163.5 4199.5 10945.5 11097.6 11260.1 11262.2 11289.4 10939.6 11057.1 11078.2 11110.1 11245.8 7774.0 8211.7 8234.7 8403.5 8553.4 5703.4 5797.6 5823.6 5868.8 5925.1 9899.5 10046.2 10444.1 10447.9 10488.7 10377.2 10392.2 10523.9 10600.8 10688.0 7449.6 7941.6 8075.6 8182.3 8183.0 8744.5 8771.2 8772.9 8779.0 8801.2 8023.6 8176.6 8205.8 8213.9 8331.5 7820.5 7902.9 7923.7 8054.4 8127.3 7024.4 7041.8 7043.4 7111.6 7129.4 5033.3 5037.3 5044.1 5061.5 5084.5 5066.3 5130.2 5233.7 5276.8 5405.4 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | [#4] prototype.html Cycles:180 Average:5089.66 Median:5771.61 stddev:1522.14 (26.4%) stddev-sans-first:1484.19 09:35:47 INFO - PROCESS | 13620 | Values: 346.7 352.0 353.1 354.3 356.1 5904.6 5923.3 5924.7 5945.7 5953.8 5758.0 5762.5 5770.0 5773.2 5776.3 4332.9 4440.8 4459.8 4473.8 4486.8 4421.9 4471.5 4474.2 4491.9 4495.3 4433.9 4452.8 4452.9 4467.2 4478.9 4366.4 4377.4 4378.0 4417.8 4421.9 3855.8 3857.8 3878.6 3893.2 3907.9 5567.3 5579.3 5603.6 5607.5 5670.7 4891.8 5067.7 5085.9 5086.7 5099.6 6038.0 6041.6 6043.2 6084.5 6088.0 4254.8 4306.8 4308.9 4315.4 4335.2 6083.8 6164.1 6287.5 6300.7 6309.8 4282.6 4314.7 4322.9 4362.3 4371.8 4374.2 4403.8 4412.6 4415.6 4416.6 4950.8 5057.2 5069.3 5099.8 5129.6 6132.7 6138.3 6147.6 6157.8 6161.7 1537.8 1552.9 1559.1 1559.6 1560.4 934.3 975.4 976.0 981.2 998.6 5385.5 5390.4 5392.2 5403.7 5429.9 5585.8 5589.0 5630.4 5662.6 5688.5 5363.1 5366.4 5595.4 6063.3 6066.0 3383.6 3384.2 3411.3 3430.9 3434.9 6286.6 6565.9 6594.5 6618.9 6637.2 6366.0 6426.7 6436.7 6456.3 6496.7 6223.3 6438.5 6500.2 6533.3 6611.7 6304.6 6310.3 6313.6 6349.2 6360.2 5889.9 6216.7 6257.1 6322.0 6322.4 6352.3 6496.3 6508.5 6519.3 6523.3 4383.5 4384.6 4404.5 4414.2 4432.9 6153.5 6213.3 6309.4 6312.2 6372.2 6070.9 6089.1 6134.8 6137.5 6153.6 5988.3 6140.3 6156.4 6169.8 6175.8 6040.4 6067.0 6071.6 6092.6 6094.0 6221.7 6241.5 6243.2 6246.9 6268.6 5783.9 6044.9 6066.6 6068.4 6072.0 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - PROCESS | 13620 | [#5] yui.html Cycles:180 Average:19584.95 Median:4836.08 stddev:25970.82 (537.0%) stddev-sans-first:26005.15 09:35:47 INFO - PROCESS | 13620 | Values: 745.8 777.3 857.2 858.0 891.7 14424.3 14599.6 14733.2 14767.6 15542.1 14747.6 14764.2 14780.6 14787.5 14854.2 698.3 820.5 835.9 844.3 847.6 848.3 854.4 855.6 856.8 859.0 896.9 899.6 900.1 900.5 900.5 886.0 891.8 896.1 897.0 898.4 653.8 655.6 656.3 656.6 657.4 15633.5 15645.7 15723.4 15729.4 15789.2 14425.5 15751.5 15845.2 16368.3 16383.6 11841.7 12730.7 12821.5 12894.5 13658.2 4812.6 4875.0 4880.8 4913.3 5014.0 79300.6 80688.6 82204.6 82603.6 82896.0 12061.0 12109.5 12145.9 12367.4 12471.6 21306.7 21385.0 21422.7 21492.2 21503.5 8774.6 8810.9 8855.8 8906.7 9090.7 4859.5 4878.4 4898.9 4958.9 5260.8 3754.7 3855.0 3856.0 3860.7 3863.4 673.8 675.4 688.3 729.8 735.3 717.4 724.6 743.2 746.8 795.5 9989.0 10010.7 10488.4 10627.1 10790.7 778.7 807.1 807.6 807.8 827.4 4917.4 4984.5 5005.7 5024.4 5033.5 72354.3 72614.0 73051.0 77493.0 84510.0 67650.0 79711.2 85033.6 97341.5 107819.0 76397.0 78148.6 95930.5 96643.0 96718.5 10031.9 10048.8 10365.6 10687.4 10798.1 38029.8 43307.4 43381.8 45740.1 46394.8 55324.4 56037.7 69512.5 69616.7 73495.6 13535.1 14140.0 14157.4 14296.0 14432.3 15741.1 15799.3 15988.7 16009.4 16609.1 14265.8 15221.2 15729.2 16461.2 16580.4 14469.0 14712.2 15385.9 15643.4 15726.0 13777.6 13935.5 14320.4 15219.2 15387.6 11742.4 11803.0 12263.8 12470.9 12488.4 11985.0 12252.2 12450.6 12530.6 12563.1 09:35:47 INFO - PROCESS | 13620 | -------- Summary: end -------- 09:35:47 INFO - PROCESS | 13620 | 09:35:47 INFO - TEST-INFO | 13620: exit 0 09:35:47 INFO - TEST-OK | dromaeo_css | took 1110294ms 09:35:47 INFO - TEST-START | kraken 09:35:47 INFO - operating with platform_type : linux_ 09:35:47 INFO - Initialising browser for kraken test... 09:35:47 INFO - TEST-INFO | started process 13866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54u7pL/profile http://localhost:37523/getInfo.html) 09:35:52 INFO - PROCESS | 13866 | __metrics Screen width/height:1600/1200 09:35:52 INFO - PROCESS | 13866 | colorDepth:24 09:35:52 INFO - PROCESS | 13866 | Browser inner width/height: 1024/697 09:35:52 INFO - PROCESS | 13866 | __metrics 09:35:52 ERROR - PROCESS | 13866 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:35:53 INFO - TEST-INFO | 13866: exit 0 09:35:53 INFO - Browser initialized. 09:35:53 INFO - Running cycle 1/1 for kraken test... 09:35:53 INFO - TEST-INFO | started process 13992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54u7pL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:05 INFO - PROCESS | 13992 | RSS: Main: 155824128 09:36:05 INFO - PROCESS | 13992 | 09:36:07 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37523/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:08 INFO - PROCESS | 13992 | RSS: Main: 160837632 09:36:08 INFO - PROCESS | 13992 | 09:36:11 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37523/tests/kraken/driver.html?testName=audio-dft) 09:36:12 INFO - PROCESS | 13992 | RSS: Main: 160661504 09:36:12 INFO - PROCESS | 13992 | 09:36:14 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37523/tests/kraken/driver.html?testName=audio-fft) 09:36:15 INFO - PROCESS | 13992 | RSS: Main: 161071104 09:36:15 INFO - PROCESS | 13992 | 09:36:17 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37523/tests/kraken/driver.html?testName=audio-oscillator) 09:36:18 INFO - PROCESS | 13992 | RSS: Main: 160931840 09:36:18 INFO - PROCESS | 13992 | 09:36:20 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:21 INFO - PROCESS | 13992 | RSS: Main: 160657408 09:36:21 INFO - PROCESS | 13992 | 09:36:24 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37523/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:24 INFO - PROCESS | 13992 | RSS: Main: 160342016 09:36:24 INFO - PROCESS | 13992 | 09:36:28 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37523/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:28 INFO - PROCESS | 13992 | RSS: Main: 161329152 09:36:28 INFO - PROCESS | 13992 | 09:36:31 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37523/tests/kraken/driver.html?testName=json-parse-financial) 09:36:32 INFO - PROCESS | 13992 | RSS: Main: 160804864 09:36:32 INFO - PROCESS | 13992 | 09:36:33 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:34 INFO - PROCESS | 13992 | RSS: Main: 160878592 09:36:34 INFO - PROCESS | 13992 | 09:36:35 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:36 INFO - PROCESS | 13992 | RSS: Main: 160993280 09:36:36 INFO - PROCESS | 13992 | 09:36:38 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:39 INFO - PROCESS | 13992 | RSS: Main: 161464320 09:36:39 INFO - PROCESS | 13992 | 09:36:41 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:42 INFO - PROCESS | 13992 | RSS: Main: 161738752 09:36:42 INFO - PROCESS | 13992 | 09:36:45 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:45 INFO - PROCESS | 13992 | RSS: Main: 161603584 09:36:45 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:37523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37523/tests/kraken/driver.html?testName=ai-astar) 09:36:47 INFO - PROCESS | 13992 | RSS: Main: 162533376 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | __start_tp_report 09:36:47 INFO - PROCESS | 13992 | _x_x_mozilla_page_load 09:36:47 INFO - PROCESS | 13992 | _x_x_mozilla_page_load_details 09:36:47 INFO - PROCESS | 13992 | |i|pagename|runs| 09:36:47 INFO - PROCESS | 13992 | |0;ai-astar;112;104;112;111;112;111;110;109;112;109 09:36:47 INFO - PROCESS | 13992 | |1;audio-beat-detection;153;126;152;174;130;155;154;124;175;124 09:36:47 INFO - PROCESS | 13992 | |2;audio-dft;162;162;161;163;165;162;163;164;166;164 09:36:47 INFO - PROCESS | 13992 | |3;audio-fft;74;75;75;175;77;77;75;75;160;74 09:36:47 INFO - PROCESS | 13992 | |4;audio-oscillator;84;84;152;84;91;84;137;85;84;138 09:36:47 INFO - PROCESS | 13992 | |5;imaging-gaussian-blur;118;117;117;118;118;117;116;117;117;117 09:36:47 INFO - PROCESS | 13992 | |6;imaging-darkroom;146;147;148;146;147;147;146;147;146;146 09:36:47 INFO - PROCESS | 13992 | |7;imaging-desaturate;95;96;95;95;95;95;96;96;95;95 09:36:47 INFO - PROCESS | 13992 | |8;json-parse-financial;51;51;52;52;51;52;53;55;54;52 09:36:47 INFO - PROCESS | 13992 | |9;json-stringify-tinderbox;60;60;60;60;60;59;59;61;60;60 09:36:47 INFO - PROCESS | 13992 | |10;stanford-crypto-aes;76;81;83;84;79;77;79;77;111;78 09:36:47 INFO - PROCESS | 13992 | |11;stanford-crypto-ccm;118;129;119;119;120;128;126;121;132;135 09:36:47 INFO - PROCESS | 13992 | |12;stanford-crypto-pbkdf2;156;153;157;158;156;153;159;156;158;157 09:36:47 INFO - PROCESS | 13992 | |13;stanford-crypto-sha256-iterative;62;63;62;63;66;63;67;62;63;61 09:36:47 INFO - PROCESS | 13992 | __end_tp_report 09:36:47 INFO - PROCESS | 13992 | __start_cc_report 09:36:47 INFO - PROCESS | 13992 | _x_x_mozilla_cycle_collect,867 09:36:47 INFO - PROCESS | 13992 | __end_cc_report 09:36:47 INFO - PROCESS | 13992 | __startTimestamp1467045407651__endTimestamp 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | ------- Summary: start ------- 09:36:47 INFO - PROCESS | 13992 | Number of tests: 14 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:2.49 (2.2%) stddev-sans-first:2.55 09:36:47 INFO - PROCESS | 13992 | Values: 112.0 104.0 112.0 111.0 112.0 111.0 110.0 109.0 112.0 109.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:153.50 stddev:19.65 (12.8%) stddev-sans-first:20.71 09:36:47 INFO - PROCESS | 13992 | Values: 153.0 126.0 152.0 174.0 130.0 155.0 154.0 124.0 175.0 124.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.55 (0.9%) stddev-sans-first:1.58 09:36:47 INFO - PROCESS | 13992 | Values: 162.0 162.0 161.0 163.0 165.0 162.0 163.0 164.0 166.0 164.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.07 (52.1%) stddev-sans-first:40.78 09:36:47 INFO - PROCESS | 13992 | Values: 74.0 75.0 75.0 175.0 77.0 77.0 75.0 75.0 160.0 74.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:27.99 (33.3%) stddev-sans-first:28.89 09:36:47 INFO - PROCESS | 13992 | Values: 84.0 84.0 152.0 84.0 91.0 84.0 137.0 85.0 84.0 138.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 09:36:47 INFO - PROCESS | 13992 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 116.0 117.0 117.0 117.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:36:47 INFO - PROCESS | 13992 | Values: 146.0 147.0 148.0 146.0 147.0 147.0 146.0 147.0 146.0 146.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:36:47 INFO - PROCESS | 13992 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.34 (2.6%) stddev-sans-first:1.33 09:36:47 INFO - PROCESS | 13992 | Values: 51.0 51.0 52.0 52.0 51.0 52.0 53.0 55.0 54.0 52.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:36:47 INFO - PROCESS | 13992 | Values: 60.0 60.0 60.0 60.0 60.0 59.0 59.0 61.0 60.0 60.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:79.00 stddev:10.35 (13.1%) stddev-sans-first:10.71 09:36:47 INFO - PROCESS | 13992 | Values: 76.0 81.0 83.0 84.0 79.0 77.0 79.0 77.0 111.0 78.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:127.00 stddev:6.11 (4.8%) stddev-sans-first:5.98 09:36:47 INFO - PROCESS | 13992 | Values: 118.0 129.0 119.0 119.0 120.0 128.0 126.0 121.0 132.0 135.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:157.00 stddev:2.00 (1.3%) stddev-sans-first:2.12 09:36:47 INFO - PROCESS | 13992 | Values: 156.0 153.0 157.0 158.0 156.0 153.0 159.0 156.0 158.0 157.0 09:36:47 INFO - PROCESS | 13992 | 09:36:47 INFO - PROCESS | 13992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.87 (3.0%) stddev-sans-first:1.94 09:36:47 INFO - PROCESS | 13992 | Values: 62.0 63.0 62.0 63.0 66.0 63.0 67.0 62.0 63.0 61.0 09:36:47 INFO - PROCESS | 13992 | -------- Summary: end -------- 09:36:47 INFO - PROCESS | 13992 | 09:36:48 INFO - TEST-INFO | 13992: exit 0 09:36:48 INFO - TEST-OK | kraken | took 60857ms 09:36:48 INFO - SUITE-END | took 1171s 09:36:48 INFO - Completed test suite (00:19:31) 09:36:48 INFO - javascript benchmark 09:36:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7601.264499606008, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3394.796312221267, 3432.021873765977, 3450.982745086275, 3469.583649962005, 3471.0, 5694.886102277957, 5733.111367738002, 5740.540756739467, 5808.854778630536, 5810.070388737803, 5736.45503677151, 5763.164341170538, 5810.273715785527, 5825.242718446607, 5831.970840145804, 5212.791488340471, 5257.526822585966, 5278.261043453919, 5305.973470132644, 5356.1697936819855, 5158.123119069748, 5160.200168973796, 5337.306150200468, 5341.03861304965, 5341.359036915575, 5196.168613021917, 5203.167493201088, 5249.816256431026, 5252.474752524755, 5257.605679574028, 5231.65994210377, 5236.083685355066, 5309.91146814902, 5313.256144139824, 5314.654547454403, 5184.792608295664, 5231.921521177185, 5265.104932161542, 5291.126964050927, 5291.947080529184, 5543.6396634218645, 5548.5838562108, 5554.833354999357, 5600.719964001783, 5677.290338707661, 6181.258249010148, 6202.96898515509, 6205.472534834545, 6242.1261023456755, 6245.219347581552, 6033.607815492023, 6276.686165691697, 6279.529035322369, 6280.560360774748, 6285.748570057192, 5677.9495793278375, 5716.714164291769, 5737.7131143443075, 5779.104238842986, 5789.392113828072, 6226.346233645492, 6285.2457705075685, 6302.212223472066, 6305.054241863665, 6312.905306420315, 5797.2173756542325, 5988.8802223956145, 6046.2139921809885, 6051.334353221142, 6051.606645568112, 6055.273367195965, 6158.0, 6173.32093469718, 6193.1329613854095, 6198.318184999646, 6111.908321375183, 6147.0, 6147.72335244915, 6157.076438534255, 6163.476104531075, 5979.701014949235, 6130.295016073209, 6135.967692822179, 6157.630542167484, 6187.752489900354, 4624.375709279204, 4697.600703940135, 4697.671163018625, 4710.717356958594, 4740.857774266778, 4220.282551966173, 4244.045089854758, 4248.830046798155, 4251.234777740036, 4262.722923009995, 5935.109733539917, 5989.131575921554, 5995.490383317467, 6007.038873780261, 6036.456718895321, 6034.39656034393, 6203.2245969253845, 6248.781292654735, 6264.0, 6292.0, 6047.15339852421, 6047.213862197887, 6047.337396144008, 6047.667378294148, 6078.635281883101, 5186.559142472932, 5276.709780962007, 5294.7617357219015, 5328.174133009312, 5372.059889519397, 6430.196225471816, 6450.225972883284, 6454.354564543602, 6461.903071453932, 6466.030095485715, 6082.11809287642, 6245.406686364788, 6249.0626406039455, 6303.936960630335, 6319.494440444845, 6270.686465676789, 6339.809805705836, 6361.236651601837, 6427.839304017437, 6440.388163124496, 6132.41742034506, 6132.908006379818, 6135.539834512519, 6145.539084568764, 6150.138980542817, 6075.635461872125, 6170.7223174958135, 6233.96883015582, 6238.064290356483, 6243.843903902439, 6081.391860813883, 6135.938640613536, 6145.8156255312415, 6146.446819786241, 6147.508199343953, 6121.357257488078, 6127.986433238494, 6133.507474962901, 6148.44663980244, 6156.353582873913, 5818.650880947157, 5894.498967587631, 5897.5281977440845, 6045.093236014457, 6073.0, 6022.90965635507, 6067.24159480065, 6124.533510047256, 6133.294671112879, 6150.969245153746, 5947.583669143119, 5987.5808693391045, 5992.460678538952, 6009.639421634716, 6015.849603759941], "value": 5713.440446654233, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.5743022454058, 641.7753786174842, 644.7485480662542, 646.0, 665.4676258992805, 45866.3120053199, 47065.764671176636, 47543.76228118859, 47584.0, 51515.742421287934, 47826.0, 48167.27749083767, 48482.0, 48486.0, 48501.272480912725, 9163.679271225508, 9307.162355388014, 9308.394954327981, 9309.813803723922, 9318.440893546374, 9114.908850911506, 9187.816243675123, 9192.908070919271, 9216.2626989841, 9226.215771659417, 9175.72472825813, 9237.95381023094, 9253.768655783591, 9285.814283714322, 9288.628454861797, 9186.816263674722, 9206.49364284964, 9264.305177111677, 9277.95361023194, 9289.0, 9200.125988031126, 9293.67472138472, 9297.302702297287, 9306.488143152124, 9307.76730581734, 45208.547914520765, 45456.318155227695, 45684.0, 45814.54185458136, 45829.31256031162, 3537.770044947096, 3560.305740380627, 3654.4335627977707, 3743.775373477573, 3784.2999045176457, 34571.481427778606, 34698.13254668628, 34877.476837847455, 34881.30237395263, 35118.47322290167, 4726.422385604719, 4755.857324280277, 4770.022145460172, 4796.880077998043, 4813.302071199691, 260137.0, 260881.0, 261649.0, 261759.9999999981, 261871.0, 66188.66905665441, 66577.66711166414, 66656.99999999903, 66694.0, 66835.33164668291, 39727.40408893869, 40553.18893622111, 40584.59415405867, 42182.0, 42201.57798422038, 18367.54081147982, 18561.16474758639, 18627.441176764718, 18639.347622833135, 18651.440456786317, 14604.707905841824, 14761.40954361835, 14830.184339861411, 14850.183239921693, 14875.553733388017, 21259.78740212609, 21395.358139255848, 21474.57050859005, 21532.461688457915, 21704.891475542838, 7307.232740562271, 7378.733762994511, 7609.505382150253, 7676.731314403969, 7747.573883436465, 993.8558908958161, 1078.5308390850005, 1121.899029087386, 1164.4876254448016, 1180.397997021508, 32982.340353192805, 33066.248388998465, 33397.3320533588, 33544.66455335464, 33922.66077339245, 1116.213069785799, 1174.94712737927, 1182.5565412970136, 1242.0560374115557, 1244.9315287659265, 17485.213165407586, 17581.120943952752, 17627.0, 17850.0, 17917.0, 612017.0, 620989.0, 670864.0, 679306.0, 683366.0, 60598.69700651557, 61396.69301653552, 61405.69297153486, 61475.38524614786, 61594.0, 1465.736167489862, 1506.6082818467057, 1507.8869084818682, 1510.9168995705343, 1523.2079318754186, 32420.35159296848, 32510.83744581262, 33087.50368744519, 33253.50119748254, 33747.15632109217, 54694.0, 55340.16989745077, 55347.723261383435, 55484.72257638686, 55496.72251638716, 408858.0, 409256.0, 410344.0, 411378.0, 411536.0, 30172.5474117884, 30351.544726829557, 30617.0, 30833.691663083082, 31030.534541981437, 49467.257991129445, 49564.50435495599, 50174.2473862885, 50385.49614503955, 51117.23324150066, 40546.59453405428, 41074.38388424236, 41974.0, 42168.578314217695, 43329.0, 41696.79151604223, 41846.16307673891, 42781.64700941478, 42892.0, 43092.569074308856, 42751.57248427476, 42774.78612606917, 43345.0, 43350.78324608357, 43464.78267608642, 36281.63718362783, 36482.0, 37221.441678375384, 37762.811185943894, 37850.62149378471, 28450.0, 28575.857120714263, 28638.713612863605, 28804.567931480626, 29000.274993125342], "value": 20986.94239316564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.6471666990588, 406.82099876054536, 415.10337670631435, 416.3525717509272, 424.33167760776786, 19197.61604767904, 20084.09621567029, 20532.589348213027, 20581.69127463089, 21049.579008419823, 19033.428997130075, 19139.712904306412, 19902.606817522777, 20075.297364592243, 20115.19539218433, 4917.33615961845, 5193.896122077556, 5205.349331333583, 5270.314859068316, 5286.867828304285, 5107.7701503432245, 5209.973950130263, 5250.6324557281005, 5337.3061502004875, 5395.271638328834, 5352.732363381835, 5353.330833645794, 5354.116570765819, 5376.327959005124, 5378.865528361783, 5349.812756553502, 5362.088444964346, 5368.892622147555, 5622.0, 5642.57680673947, 5383.75773090208, 5523.171524271352, 5530.059889818741, 5542.8337149885565, 5661.7735290588325, 13853.238071906042, 14084.647883802885, 14285.571432856927, 14350.928245358706, 14397.85602143986, 2101.842361822854, 2261.547690461914, 2400.939976500584, 2498.3379404457833, 2563.628273900274, 10492.160627149886, 10756.247062705614, 11004.284721493077, 11705.063594912472, 14970.251487425585, 1997.340877510418, 2055.157385471964, 2116.5237821490196, 2142.2609199826034, 2144.4102871710247, 63638.681806591136, 75236.0, 80097.99999999942, 83839.0, 86947.0, 10970.561177552809, 11533.884661153448, 11620.941895290469, 11710.88289117115, 11732.765344693058, 16080.758788618181, 16184.433544825875, 16263.129740079805, 16293.103879286753, 16306.184690765414, 8666.436681615674, 8688.6524539019, 8759.474431534129, 8829.55852207387, 8856.557172141496, 8761.474311541328, 8780.473171609723, 8795.076516965755, 8833.293336533063, 8900.688475903313, 4852.514748525119, 4856.78144483492, 4868.805247790119, 4908.607311415079, 4913.778879950411, 1984.5137941204498, 2026.2097781865084, 2031.2890488328967, 2039.5512987142804, 2067.3487851326786, 960.1406740966795, 1029.1663752360612, 1042.3537406807677, 1076.9299995500267, 1086.093112251279, 19367.0, 19973.400797976083, 20297.492562685755, 20324.59350813005, 20432.0, 1011.3881101933224, 1041.375174895072, 1055.2824079625775, 1060.506864308085, 1118.2116607791488, 10870.782584348268, 11162.944185279022, 11258.66224013281, 11366.374849383197, 11455.770884582262, 473394.07540841744, 476516.0, 480010.0, 482852.0, 487942.0, 93391.53304233435, 94085.58871616794, 94903.0, 94913.0, 95977.520112399, 1047.502436342731, 1061.2518174686827, 1075.1398880895254, 1082.0153660169208, 1086.0497065068066, 16833.0, 17550.648987019933, 17744.733828992834, 17812.91093544524, 17928.103594819946, 44265.557344426146, 44998.0, 45180.548194517636, 45255.094898102514, 45356.31965520586, 60152.69923650354, 60497.28865232347, 60699.63355373274, 62233.0, 62303.37696622976, 7931.603419829101, 8153.306968907709, 8578.313734901318, 8820.11798820113, 9215.769605759642, 13956.651083722989, 14012.369443375277, 14194.290285485891, 14489.927550362181, 14669.413223471369, 12181.817272740738, 12250.326232057323, 12473.812892806434, 12667.176633518791, 12969.805452918403, 12381.938090309492, 12599.87400125987, 12602.36988150607, 12728.48751981997, 12890.806637900627, 6431.5819471734185, 11241.60654377093, 11909.213617957375, 12706.618801435972, 12730.872691272969, 7872.803179920319, 8150.347972162332, 8397.0, 8508.702195423131, 8556.358273129665, 12433.502659893504, 12532.122751407314, 12610.49558017669, 12713.300768457824, 13034.543790967271], "value": 9345.866207930909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.310460292868, 1573.8032745906762, 1706.1980868991577, 1788.2936240185136, 1809.3848091648836, 8040.798980025503, 8494.235518803307, 8611.224989750921, 9203.58583863727, 9205.723828285154, 8532.957335213316, 8836.690715824947, 8856.025837157924, 8869.95565022174, 8885.866711999326, 2362.870042147681, 2393.258089992108, 2403.663487111806, 2405.242348660175, 2409.674693916325, 2284.120613563773, 2340.20433052762, 2352.5059737455153, 2375.2399232245602, 2376.3583832365252, 2361.3034154924253, 2361.586722323595, 2375.1449478187837, 2398.7241467231315, 2403.7836594706473, 2346.9295921122393, 2350.471143992588, 2366.349253955159, 2366.4912043910554, 2379.845310054858, 2281.885905704708, 2341.555104530134, 2353.752855950118, 2376.6910301660846, 2386.248331775485, 8840.513771742551, 8956.910430895672, 8958.820823583557, 8965.058668839743, 8989.595468203946, 5350.9732451337495, 5460.235567020621, 5481.671099733989, 5487.368952570426, 5489.780408783644, 3471.7049050830456, 3479.80861052642, 3542.3623747725655, 3552.8045957472327, 3592.389293820057, 1188.791961406759, 1198.6164427383242, 1204.680759598707, 1227.8096894981293, 1235.8702336254653, 12512.249265044036, 12584.496620135184, 12597.622071337966, 12653.177543459646, 12663.936680316632, 4670.182718024332, 4736.194846876039, 4741.051789642085, 4761.642876784255, 4842.975785121052, 10571.682849514527, 10572.629957951434, 10588.0, 10602.522886470128, 10627.309224900357, 5247.895042099137, 5291.603129765283, 5311.362636483569, 5315.681059136464, 5503.036968530491, 4502.549745025472, 4814.759262036954, 4937.23472861707, 4955.231939049453, 4958.727270000112, 4141.378793180987, 4179.101493178981, 4184.727992680466, 4218.240716671029, 4218.873433796991, 1258.930758808256, 1290.1742884553894, 1298.0524217321408, 1302.9804552931714, 1307.6992291772945, 940.1773448232797, 1020.8877023527406, 1027.1012863744224, 1045.362328979322, 1053.1732589916878, 6051.971164901977, 6084.939150608526, 6112.938870611326, 6162.198914141133, 6350.6189628621505, 992.0, 1027.4862568715641, 1046.0742243114746, 1048.1405247696816, 1076.4563895232857, 4032.0927791246736, 4111.48606424197, 4143.854965076208, 4163.500379954425, 4199.496060472763, 10945.507452164671, 11097.611583594535, 11260.09919206478, 11262.155338349492, 11289.435528223556, 10939.617113400993, 11057.06014988719, 11078.169137314733, 11110.111191104692, 11245.83131253032, 7774.0, 8211.71259005932, 8234.711785087493, 8403.453775504573, 8553.358498112666, 5703.401142879938, 5797.623154494944, 5823.563232757645, 5868.823935281948, 5925.05199168131, 9899.455529945923, 10046.24653151002, 10444.060034596923, 10447.94776026115, 10488.68533943983, 10377.16982641402, 10392.220583456423, 10523.94738026305, 10600.840987385041, 10687.984641459048, 7449.5902725350625, 7941.563214023284, 8075.636596353295, 8182.263596276363, 8183.0, 8744.475331480131, 8771.210591046836, 8772.91227087721, 8779.034306226182, 8801.163889430494, 8023.6389362479995, 8176.632051557814, 8205.83588328242, 8213.876791848008, 8331.500109993178, 7820.5307681537015, 7902.920970790218, 7923.7226697065325, 8054.395920305883, 8127.268545830903, 7024.438044956493, 7041.788746337618, 7043.436525078084, 7111.573305601681, 7129.429645628234, 5033.2701758245585, 5037.345145131109, 5044.1424957758, 5061.519155680205, 5084.542391184811, 5066.290719299374, 5130.230465430215, 5233.659812112201, 5276.788928442819, 5405.432429594836], "value": 4765.669970216476, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.674126321258, 351.9736019798515, 353.09255214099755, 354.3055611002435, 356.0937414280655, 5904.645721256722, 5923.3188183358925, 5924.703764811758, 5945.732442040107, 5953.791617293385, 5758.0, 5762.481376676098, 5770.0, 5773.220615216945, 5776.295992682159, 4332.935005974913, 4440.80098373439, 4459.754713490756, 4473.798679059434, 4486.798094085774, 4421.911561768763, 4471.530489298626, 4474.239379305526, 4491.932621010671, 4495.348174514694, 4433.866983990485, 4452.755098469583, 4452.910941781162, 4467.151241264166, 4478.8880277992985, 4366.366876802862, 4377.430933978594, 4377.956220437787, 4417.779111044451, 4421.867343979686, 3855.768653880776, 3857.787821669807, 3878.592747761501, 3893.1824316893485, 3907.9218415631526, 5567.3040869891265, 5579.330480342385, 5603.551715862721, 5607.467290607386, 5670.68811215383, 4891.779869905863, 5067.695938243717, 5085.949140508585, 5086.694798312114, 5099.592032637417, 6038.0, 6041.6375017499095, 6043.214382130339, 6084.47888027993, 6088.0, 4254.8086535770035, 4306.7631280279575, 4308.892277693051, 4315.374270730757, 4335.176316499855, 6083.787067452662, 6164.106204600308, 6287.465565426898, 6300.716467759008, 6309.760035187488, 4282.571742825755, 4314.69797114199, 4322.891927701832, 4362.345648152803, 4371.846985355561, 4374.21264172452, 4403.823847046082, 4412.646988240997, 4415.602595766396, 4416.580424859633, 4950.752462376867, 5057.165567681292, 5069.340985671839, 5099.847004589868, 5129.563987061141, 6132.6933653317155, 6138.294096178996, 6147.631142131397, 6157.784477543264, 6161.7227224775, 1537.7847101405812, 1552.8974428156137, 1559.1035154786043, 1559.5789136932965, 1560.3836484588523, 934.2946075712794, 975.4244995452717, 975.9606019589115, 981.2199301555138, 998.630506712521, 5385.461453854583, 5390.434004429557, 5392.245085688007, 5403.675779453245, 5429.864253393618, 5585.804496842591, 5589.0, 5630.40880707528, 5662.5753068520025, 5688.488036076773, 5363.061464243741, 5366.436524164985, 5595.38450770415, 6063.302720187146, 6065.969670151621, 3383.6447173046968, 3384.1539615096226, 3411.3177364527196, 3430.8627654894026, 3434.935170097278, 6286.622802631857, 6565.868682626321, 6594.538382313192, 6618.881957773467, 6637.236717777518, 6365.96817015912, 6426.6825300813225, 6436.710348034349, 6456.257530384066, 6496.707648155844, 6223.3465486123305, 6438.484921206292, 6500.219973603103, 6533.346665333429, 6611.66941652925, 6304.590201636879, 6310.2743184534365, 6313.569275828931, 6349.238091429058, 6360.204974378203, 5889.941100589111, 6216.720247588779, 6257.124002639725, 6322.0, 6322.430981211713, 6352.333005034405, 6496.317886622026, 6508.494229721497, 6519.315471875385, 6523.282438931808, 4383.53151694186, 4384.605385515319, 4404.515503294571, 4414.205443020287, 4432.933505997477, 6153.507719382349, 6213.316535181217, 6309.400606942333, 6312.242530896322, 6372.171617689671, 6070.908936366046, 6089.081939189141, 6134.754609815736, 6137.478314343331, 6153.569250152446, 5988.28140623128, 6140.263168419819, 6156.384361563808, 6169.84575385619, 6175.814725558241, 6040.365761595145, 6067.0, 6071.574989750675, 6092.573519853568, 6094.0, 6221.657808820558, 6241.500679945502, 6243.219597550306, 6246.875062498633, 6268.561200715906, 5783.94216057834, 6044.854076802848, 6066.575339726177, 6068.393160684073, 6071.967765479791], "value": 4599.980997240736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.8060904164915, 777.304312640187, 857.1899554920601, 857.9957100214498, 891.6968230801529, 14424.278786060695, 14599.562013139623, 14733.18967456792, 14767.630809229775, 15542.145182014985, 14747.557573272792, 14764.18796966169, 14780.6304842379, 14787.482438114668, 14854.1830199339, 698.2842586348995, 820.4789958376444, 835.8996920369564, 844.252836239929, 847.6058632735777, 848.3043903998692, 854.3976496569934, 855.6491838346279, 856.8115014696788, 858.9785255368635, 896.919277265046, 899.6131663384742, 900.0954041188629, 900.5092224737501, 900.5362238447204, 885.9512726800024, 891.8483857744199, 896.1038961038961, 896.9506677132755, 898.4429653614768, 653.7548419342746, 655.6131882189532, 656.3043174235278, 656.5961933410965, 657.3787770556826, 15633.452829150925, 15645.687086258326, 15723.449679261172, 15729.449469268635, 15789.21053947298, 14425.495107671286, 15751.527454176394, 15845.166949942482, 16368.345266189339, 16383.59041023972, 11841.703957401047, 12730.681732956658, 12821.487140514368, 12894.548690795871, 13658.180509169382, 4812.614990800763, 4874.975625121887, 4880.755962201912, 4913.31213630092, 5014.022265658198, 79300.60349698272, 80688.59655701743, 82204.58897705533, 82603.5869820653, 82895.9999999994, 12061.0, 12109.455074521667, 12145.878541214475, 12367.443465044094, 12471.625851224479, 21306.680399794015, 21385.0, 21422.678659820114, 21492.247771328242, 21503.462413439476, 8774.649014039494, 8810.911890881009, 8855.778605534784, 8906.688265910661, 9090.727278181534, 4859.538343857328, 4878.414590249122, 4898.853034408973, 4958.8512344629, 5260.789568417297, 3754.662080412776, 3854.9807250964127, 3855.980720096438, 3860.6718428933295, 3863.4204869269834, 673.7810211681223, 675.4090171100287, 688.3323176518769, 729.806601250669, 735.3381956239427, 717.4045542199962, 724.586985418317, 743.1750756660103, 746.7535713214626, 795.4988357334842, 9989.0, 10010.749731256778, 10488.370697758159, 10627.096696780705, 10790.730231744112, 778.676849107614, 807.0808422663854, 807.6325272001226, 807.7576726981882, 827.3546633625662, 4917.360743103373, 4984.451710311862, 5005.6996580205305, 5024.371953505812, 5033.47148549397, 72354.27645723581, 72614.0, 73051.0, 77493.0, 84510.0, 67650.0, 79711.20288797037, 85033.57483212545, 97341.51329243308, 107819.0, 76397.0, 78148.60925695335, 95930.52034739782, 96643.0335696634, 96718.51640741751, 10031.899681003388, 10048.799024019625, 10365.63720269787, 10687.358758474516, 10798.082163016232, 38029.809850950565, 43307.35038974481, 43381.78309108434, 45740.08519829651, 46394.768026161, 55324.44675553354, 56037.71981140068, 69512.52437378009, 69616.6519167401, 73495.63252183705, 13535.120217185851, 14140.0, 14157.433702651779, 14296.0, 14432.278386080863, 15741.134237616583, 15799.289031993818, 15988.68022639564, 16009.35962561531, 16609.086500242604, 14265.786013210018, 15221.238938053275, 15729.213539323217, 16461.176941152655, 16580.419685310957, 14469.0, 14712.19082950448, 15385.923070384577, 15643.374265029272, 15726.0, 13777.586672399844, 13935.512257070954, 14320.355583998953, 15219.162946037632, 15387.61530961735, 11742.354170520362, 11803.0, 12263.816042759545, 12470.875291247334, 12488.375581221084, 11985.0, 12252.203606765532, 12450.564230251897, 12530.624081277576, 12563.12058155957], "value": 7851.044089894185, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 112.0, 111.0, 112.0, 111.0, 110.0, 109.0, 112.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 152.0, 174.0, 130.0, 155.0, 154.0, 124.0, 175.0, 124.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 165.0, 162.0, 163.0, 164.0, 166.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 175.0, 77.0, 77.0, 75.0, 75.0, 160.0, 74.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 152.0, 84.0, 91.0, 84.0, 137.0, 85.0, 84.0, 138.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 51.0, 52.0, 53.0, 55.0, 54.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 61.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 83.0, 84.0, 79.0, 77.0, 79.0, 77.0, 111.0, 78.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 129.0, 119.0, 119.0, 120.0, 128.0, 126.0, 121.0, 132.0, 135.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 157.0, 158.0, 156.0, 153.0, 159.0, 156.0, 158.0, 157.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 66.0, 63.0, 67.0, 62.0, 63.0, 61.0], "value": 63.2, "unit": "score"}]}]} 09:36:48 INFO - Return code: 0 09:36:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:48 ERROR - # TBPL SUCCESS # 09:36:48 INFO - Running post-action listener: _resource_record_post_action 09:36:48 INFO - ##### 09:36:48 INFO - ##### Finished run-tests step (success) 09:36:48 INFO - ##### 09:36:48 INFO - Running post-run listener: _resource_record_post_run 09:36:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505712640; Read time: 8; Write time: 470180 09:36:49 INFO - TinderboxPrint: CPU usage
13.4% 09:36:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:36:49 INFO - TinderboxPrint: I/O write bytes / time
505,712,640 / 470,180 09:36:49 INFO - TinderboxPrint: CPU idle
8,211.9 (86.6%) 09:36:49 INFO - TinderboxPrint: CPU user
1,210.6 (12.8%) 09:36:49 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 223997952; Read time: 0; Write time: 259700 09:36:49 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252256256; Read time: 8; Write time: 193104 09:36:49 INFO - Running post-run listener: _upload_blobber_files 09:36:49 INFO - Blob upload gear active. 09:36:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:49 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 09:36:49 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:49 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:50 INFO - (blobuploader) - INFO - Done attempting. 09:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:51 INFO - (blobuploader) - INFO - Done attempting. 09:36:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:54 INFO - (blobuploader) - INFO - Done attempting. 09:36:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:54 INFO - Return code: 0 09:36:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e8119c7834782e01ed7c2104f7b3ea0667263834b8a53054b21326e4ffe448462c13723a27c16372ebd74f048229444ba8dea8f574b620179d3166253988f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d614526f3e671baf4f9fca69ef3b7fcb323d56771fa6cda3584e5214b544d21905cef90d1f1b1803ceb4f59d52a8b424fee71e74180a26102029ec7ee040f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c85e053fdee92ffccd129b7f6a54f225fd8bcef12fc9828fe16e6895c9407b4d0e472559431e1961f706ac7fb707a57807b8130480b94e9bfb13113711ca10a"} 09:36:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:54 INFO - Contents: 09:36:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e8119c7834782e01ed7c2104f7b3ea0667263834b8a53054b21326e4ffe448462c13723a27c16372ebd74f048229444ba8dea8f574b620179d3166253988f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d614526f3e671baf4f9fca69ef3b7fcb323d56771fa6cda3584e5214b544d21905cef90d1f1b1803ceb4f59d52a8b424fee71e74180a26102029ec7ee040f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c85e053fdee92ffccd129b7f6a54f225fd8bcef12fc9828fe16e6895c9407b4d0e472559431e1961f706ac7fb707a57807b8130480b94e9bfb13113711ca10a"} 09:36:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:54 INFO - Copying logs to upload dir... 09:36:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.447200 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-27 09:36:54.806662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:36:54.810567) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043 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-Aurora/sha512/1e8119c7834782e01ed7c2104f7b3ea0667263834b8a53054b21326e4ffe448462c13723a27c16372ebd74f048229444ba8dea8f574b620179d3166253988f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d614526f3e671baf4f9fca69ef3b7fcb323d56771fa6cda3584e5214b544d21905cef90d1f1b1803ceb4f59d52a8b424fee71e74180a26102029ec7ee040f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c85e053fdee92ffccd129b7f6a54f225fd8bcef12fc9828fe16e6895c9407b4d0e472559431e1961f706ac7fb707a57807b8130480b94e9bfb13113711ca10a"} build_url:https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/cxg4--c3RgqZ3-KL94trfA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1e8119c7834782e01ed7c2104f7b3ea0667263834b8a53054b21326e4ffe448462c13723a27c16372ebd74f048229444ba8dea8f574b620179d3166253988f3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2d614526f3e671baf4f9fca69ef3b7fcb323d56771fa6cda3584e5214b544d21905cef90d1f1b1803ceb4f59d52a8b424fee71e74180a26102029ec7ee040f99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c85e053fdee92ffccd129b7f6a54f225fd8bcef12fc9828fe16e6895c9407b4d0e472559431e1961f706ac7fb707a57807b8130480b94e9bfb13113711ca10a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:36:54.836366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:36:54.836708) ========= 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=652eb03db935cfc1c15ebda0000001ad-1467044183.496808-1006947043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:36:54.925290) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:36:54.925935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:36:54.926465) ========= ========= Total master_lag: 0.19 =========