builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1469643897.59 results: success (0) buildid: 20160727082613 builduid: 58d64b2c470e4c148596eea8008ccdb1 revision: a9e8f70d870c1492bc3d64d3ac2f21f033d125cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.593271) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.594064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.594717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.614548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.614928) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-27 11:24:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-07-27 11:24:57 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.757453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.757949) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019781 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.808527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:57.808910) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a9e8f70d870c1492bc3d64d3ac2f21f033d125cf --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 a9e8f70d870c1492bc3d64d3ac2f21f033d125cf --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=31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-27 11:24:58,105 truncating revision to first 12 chars 2016-07-27 11:24:58,105 Setting DEBUG logging. 2016-07-27 11:24:58,105 attempt 1/10 2016-07-27 11:24:58,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a9e8f70d870c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 11:24:58,410 unpacking tar archive at: mozilla-aurora-a9e8f70d870c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:58.467597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:58.467932) ========= script_repo_revision: a9e8f70d870c1492bc3d64d3ac2f21f033d125cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:58.468438) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:58.468754) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 11:24:58.478485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-27 11:24:58.478789) ========= /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=31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:58 INFO - MultiFileLogger online at 20160727 11:24:58 in /builds/slave/test 11:24:58 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 11:24:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:58 INFO - {'append_to_log': False, 11:24:58 INFO - 'base_work_dir': '/builds/slave/test', 11:24:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:24:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:58 INFO - 'branch': 'Mozilla-Aurora', 11:24:58 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:58 INFO - 'config_files': ('talos/linux_config.py',), 11:24:58 INFO - 'default_actions': ('clobber', 11:24:58 INFO - 'read-buildbot-config', 11:24:58 INFO - 'download-and-extract', 11:24:58 INFO - 'populate-webroot', 11:24:58 INFO - 'create-virtualenv', 11:24:58 INFO - 'install', 11:24:58 INFO - 'run-tests'), 11:24:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:58 INFO - 'download_minidump_stackwalk': True, 11:24:58 INFO - 'download_symbols': 'ondemand', 11:24:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:58 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:58 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:58 INFO - 'installer_path': 'installer.exe', 11:24:58 INFO - 'log_level': 'info', 11:24:58 INFO - 'log_name': 'talos', 11:24:58 INFO - 'log_to_console': True, 11:24:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:58 INFO - 'opt_config_files': (), 11:24:58 INFO - 'pip_index': False, 11:24:58 INFO - 'sps_profile': False, 11:24:58 INFO - 'sps_profile_interval': 0, 11:24:58 INFO - 'suite': 'dromaeojs-e10s', 11:24:58 INFO - 'system_bits': '32', 11:24:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:58 INFO - 'title': 'talos-linux64-ix-014', 11:24:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:58 INFO - 'use_talos_json': True, 11:24:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:58 INFO - 'work_dir': 'build'} 11:24:58 INFO - ##### 11:24:58 INFO - ##### Running clobber step. 11:24:58 INFO - ##### 11:24:58 INFO - Running pre-action listener: _resource_record_pre_action 11:24:58 INFO - Running main action method: clobber 11:24:58 INFO - rmtree: /builds/slave/test/build 11:24:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:59 INFO - Running post-action listener: _resource_record_post_action 11:24:59 INFO - ##### 11:24:59 INFO - ##### Finished clobber step (success) 11:24:59 INFO - ##### 11:24:59 INFO - ##### 11:24:59 INFO - ##### Running read-buildbot-config step. 11:24:59 INFO - ##### 11:24:59 INFO - Running pre-action listener: _resource_record_pre_action 11:24:59 INFO - Running main action method: read_buildbot_config 11:24:59 INFO - Using buildbot properties: 11:24:59 INFO - { 11:24:59 INFO - "project": "", 11:24:59 INFO - "product": "firefox", 11:24:59 INFO - "script_repo_revision": "production", 11:24:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:24:59 INFO - "repository": "", 11:24:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:24:59 INFO - "buildid": "20160727082613", 11:24:59 INFO - "pgo_build": "True", 11:24:59 INFO - "basedir": "/builds/slave/test", 11:24:59 INFO - "buildnumber": 468, 11:24:59 INFO - "slavename": "talos-linux64-ix-014", 11:24:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:24:59 INFO - "platform": "ubuntu64_hw", 11:24:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:24:59 INFO - "branch": "mozilla-aurora", 11:24:59 INFO - "repo_path": "releases/mozilla-aurora", 11:24:59 INFO - "revision": "a9e8f70d870c1492bc3d64d3ac2f21f033d125cf", 11:24:59 INFO - "stage_platform": "linux64-pgo", 11:24:59 INFO - "builduid": "58d64b2c470e4c148596eea8008ccdb1", 11:24:59 INFO - "slavebuilddir": "test" 11:24:59 INFO - } 11:24:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 11:24:59 INFO - Running post-action listener: _resource_record_post_action 11:24:59 INFO - ##### 11:24:59 INFO - ##### Finished read-buildbot-config step (success) 11:24:59 INFO - ##### 11:24:59 INFO - ##### 11:24:59 INFO - ##### Running download-and-extract step. 11:24:59 INFO - ##### 11:24:59 INFO - Running pre-action listener: _resource_record_pre_action 11:24:59 INFO - Running main action method: download_and_extract 11:24:59 INFO - mkdir: /builds/slave/test/build/tests 11:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:59 INFO - https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:00 INFO - Downloaded 1361 bytes. 11:25:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:25:00 INFO - Using the following test package requirements: 11:25:00 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:25:00 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:25:00 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:25:00 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'jsshell-linux-x86_64.zip'], 11:25:00 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:25:00 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:25:00 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:25:00 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:25:00 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:25:00 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:25:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:25:00 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:25:00 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')]} 11:25:00 INFO - https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:25:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:25:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:25:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:01 INFO - Downloaded 24494815 bytes. 11:25:01 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'] 11:25:01 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 11:25:02 INFO - Return code: 0 11:25:02 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 11:25:02 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')]} 11:25:02 INFO - https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:04 INFO - Downloaded 24494815 bytes. 11:25:04 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'] 11:25:04 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 11:25:05 INFO - Return code: 0 11:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:05 INFO - https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:25:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:25:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:25:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:07 INFO - Downloaded 10833369 bytes. 11:25:07 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'] 11:25:07 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 11:25:07 INFO - Return code: 0 11:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:07 INFO - https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:25:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:25:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:25:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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 11:25:10 INFO - Downloaded 63663240 bytes. 11:25:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:25:10 INFO - mkdir: /builds/slave/test/properties 11:25:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:25:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:25:10 INFO - Contents: 11:25:10 INFO - build_url:https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:25:11 INFO - Running post-action listener: _resource_record_post_action 11:25:11 INFO - Running post-action listener: set_extra_try_arguments 11:25:11 INFO - ##### 11:25:11 INFO - ##### Finished download-and-extract step (success) 11:25:11 INFO - ##### 11:25:11 INFO - ##### 11:25:11 INFO - ##### Running populate-webroot step. 11:25:11 INFO - ##### 11:25:11 INFO - Running pre-action listener: _resource_record_pre_action 11:25:11 INFO - Running main action method: populate_webroot 11:25:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:25:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:25:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:25:11 INFO - '--tppagecycles', 11:25:11 INFO - '7'], 11:25:11 INFO - 'tests': ['tsvgm']}}, 11:25:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:25:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:25:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:25:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:25:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:25:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['damp', 'tps']}, 11:25:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'tests': ['damp', 'tps']}, 11:25:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['dromaeo_dom']}, 11:25:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:25:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['a11yr', 11:25:11 INFO - 'ts_paint', 11:25:11 INFO - 'tpaint', 11:25:11 INFO - 'sessionrestore', 11:25:11 INFO - 'sessionrestore_no_auto_restore', 11:25:11 INFO - 'tabpaint']}, 11:25:11 INFO - 'other-e10s': {'tests': ['a11yr', 11:25:11 INFO - 'ts_paint', 11:25:11 INFO - 'tpaint', 11:25:11 INFO - 'sessionrestore', 11:25:11 INFO - 'sessionrestore_no_auto_restore', 11:25:11 INFO - 'tabpaint']}, 11:25:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:25:11 INFO - 'ts_paint', 11:25:11 INFO - 'tpaint', 11:25:11 INFO - 'sessionrestore', 11:25:11 INFO - 'sessionrestore_no_auto_restore', 11:25:11 INFO - 'tabpaint']}, 11:25:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:25:11 INFO - 'ts_paint', 11:25:11 INFO - 'tpaint', 11:25:11 INFO - 'sessionrestore', 11:25:11 INFO - 'sessionrestore_no_auto_restore', 11:25:11 INFO - 'tabpaint']}, 11:25:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['a11yr', 11:25:11 INFO - 'ts_paint', 11:25:11 INFO - 'tpaint', 11:25:11 INFO - 'sessionrestore', 11:25:11 INFO - 'sessionrestore_no_auto_restore', 11:25:11 INFO - 'tabpaint']}, 11:25:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['a11yr', 11:25:11 INFO - 'ts_paint', 11:25:11 INFO - 'tpaint', 11:25:11 INFO - 'sessionrestore', 11:25:11 INFO - 'sessionrestore_no_auto_restore', 11:25:11 INFO - 'tabpaint']}, 11:25:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['tsvgx', 11:25:11 INFO - 'tsvgr_opacity', 11:25:11 INFO - 'tart', 11:25:11 INFO - 'tscrollx', 11:25:11 INFO - 'cart']}, 11:25:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:25:11 INFO - 'tsvgr_opacity', 11:25:11 INFO - 'tart', 11:25:11 INFO - 'tscrollx', 11:25:11 INFO - 'cart']}, 11:25:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'talos_options': ['--disable-e10s'], 11:25:11 INFO - 'tests': ['tp5o']}, 11:25:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'tests': ['tp5o']}, 11:25:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'talos_options': ['--disable-e10s', 11:25:11 INFO - '--xperf_path', 11:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:11 INFO - 'tests': ['tp5n']}, 11:25:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:25:11 INFO - 'talos_options': ['--xperf_path', 11:25:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:25:11 INFO - 'tests': ['tp5n']}}, 11:25:11 INFO - 'talos.zip': {'path': '', 11:25:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:25:11 INFO - Running post-action listener: _resource_record_post_action 11:25:11 INFO - ##### 11:25:11 INFO - ##### Finished populate-webroot step (success) 11:25:11 INFO - ##### 11:25:11 INFO - ##### 11:25:11 INFO - ##### Running create-virtualenv step. 11:25:11 INFO - ##### 11:25:11 INFO - Running pre-action listener: _resource_record_pre_action 11:25:11 INFO - Running main action method: create_virtualenv 11:25:11 INFO - Creating virtualenv /builds/slave/test/build/venv 11:25:11 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 11:25:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:25:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:25:11 INFO - Using real prefix '/usr' 11:25:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:25:12 INFO - Installing distribute.............................................................................................................................................................................................done. 11:25:14 INFO - Installing pip.................done. 11:25:14 INFO - Return code: 0 11:25:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:14 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:14 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 11:25:14 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 11:25:14 INFO - Using env: {'DISPLAY': ':0', 11:25:14 INFO - 'HOME': '/home/cltbld', 11:25:14 INFO - 'LANG': 'en_US.UTF-8', 11:25:14 INFO - 'LANGUAGE': 'en_US:en', 11:25:14 INFO - 'LOGNAME': 'cltbld', 11:25:14 INFO - 'MAIL': '/var/mail/cltbld', 11:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:14 INFO - 'MOZ_NO_REMOTE': '1', 11:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:14 INFO - 'NO_EM_RESTART': '1', 11:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:14 INFO - 'PWD': '/builds/slave/test', 11:25:14 INFO - 'SHELL': '/bin/bash', 11:25:14 INFO - 'SHLVL': '1', 11:25:14 INFO - 'TERM': 'linux', 11:25:14 INFO - 'TMOUT': '86400', 11:25:14 INFO - 'USER': 'cltbld', 11:25:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:14 INFO - '_': '/tools/buildbot/bin/python'} 11:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:14 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 11:25:14 INFO - Cleaning up... 11:25:14 INFO - Return code: 0 11:25:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:14 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:14 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 11:25:14 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 11:25:14 INFO - Using env: {'DISPLAY': ':0', 11:25:14 INFO - 'HOME': '/home/cltbld', 11:25:14 INFO - 'LANG': 'en_US.UTF-8', 11:25:14 INFO - 'LANGUAGE': 'en_US:en', 11:25:14 INFO - 'LOGNAME': 'cltbld', 11:25:14 INFO - 'MAIL': '/var/mail/cltbld', 11:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:14 INFO - 'MOZ_NO_REMOTE': '1', 11:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:14 INFO - 'NO_EM_RESTART': '1', 11:25:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:14 INFO - 'PWD': '/builds/slave/test', 11:25:14 INFO - 'SHELL': '/bin/bash', 11:25:14 INFO - 'SHLVL': '1', 11:25:14 INFO - 'TERM': 'linux', 11:25:14 INFO - 'TMOUT': '86400', 11:25:14 INFO - 'USER': 'cltbld', 11:25:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:14 INFO - '_': '/tools/buildbot/bin/python'} 11:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:14 INFO - Downloading/unpacking psutil>=3.1.1 11:25:14 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 11:25:14 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 11:25:14 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 11:25:14 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 11:25:14 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 11:25:14 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 11:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:25:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:16 INFO - Installing collected packages: psutil 11:25:16 INFO - Running setup.py install for psutil 11:25:16 INFO - building 'psutil._psutil_linux' extension 11:25:16 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 11:25:16 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 11:25:16 INFO - building 'psutil._psutil_posix' extension 11:25:16 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 11:25:16 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 11:25:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:16 INFO - Successfully installed psutil 11:25:16 INFO - Cleaning up... 11:25:17 INFO - Return code: 0 11:25:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:17 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')]} 11:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:17 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')]} 11:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:17 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:17 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 11:25:17 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 11:25:17 INFO - Using env: {'DISPLAY': ':0', 11:25:17 INFO - 'HOME': '/home/cltbld', 11:25:17 INFO - 'LANG': 'en_US.UTF-8', 11:25:17 INFO - 'LANGUAGE': 'en_US:en', 11:25:17 INFO - 'LOGNAME': 'cltbld', 11:25:17 INFO - 'MAIL': '/var/mail/cltbld', 11:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:17 INFO - 'MOZ_NO_REMOTE': '1', 11:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:17 INFO - 'NO_EM_RESTART': '1', 11:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:17 INFO - 'PWD': '/builds/slave/test', 11:25:17 INFO - 'SHELL': '/bin/bash', 11:25:17 INFO - 'SHLVL': '1', 11:25:17 INFO - 'TERM': 'linux', 11:25:17 INFO - 'TMOUT': '86400', 11:25:17 INFO - 'USER': 'cltbld', 11:25:17 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:17 INFO - '_': '/tools/buildbot/bin/python'} 11:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:17 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 11:25:17 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 11:25:17 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 11:25:17 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 11:25:17 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 11:25:17 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 11:25:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:19 INFO - Installing collected packages: mozsystemmonitor 11:25:19 INFO - Running setup.py install for mozsystemmonitor 11:25:19 INFO - Successfully installed mozsystemmonitor 11:25:19 INFO - Cleaning up... 11:25:19 INFO - Return code: 0 11:25:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:25:19 INFO - Using env: {'DISPLAY': ':0', 11:25:19 INFO - 'HOME': '/home/cltbld', 11:25:19 INFO - 'LANG': 'en_US.UTF-8', 11:25:19 INFO - 'LANGUAGE': 'en_US:en', 11:25:19 INFO - 'LOGNAME': 'cltbld', 11:25:19 INFO - 'MAIL': '/var/mail/cltbld', 11:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:19 INFO - 'MOZ_NO_REMOTE': '1', 11:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:19 INFO - 'NO_EM_RESTART': '1', 11:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:19 INFO - 'PWD': '/builds/slave/test', 11:25:19 INFO - 'SHELL': '/bin/bash', 11:25:19 INFO - 'SHLVL': '1', 11:25:19 INFO - 'TERM': 'linux', 11:25:19 INFO - 'TMOUT': '86400', 11:25:19 INFO - 'USER': 'cltbld', 11:25:19 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:19 INFO - '_': '/tools/buildbot/bin/python'} 11:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:19 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:21 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:21 INFO - warning: no files found matching '*.txt' 11:25:21 INFO - no previously-included directories found matching 'build' 11:25:21 INFO - no previously-included directories found matching 'dist' 11:25:21 INFO - no previously-included directories found matching '.git*' 11:25:21 INFO - Installing collected packages: jsonschema, functools32 11:25:21 INFO - Running setup.py install for functools32 11:25:21 INFO - warning: no files found matching '*.txt' 11:25:21 INFO - no previously-included directories found matching 'build' 11:25:21 INFO - no previously-included directories found matching 'dist' 11:25:21 INFO - no previously-included directories found matching '.git*' 11:25:21 INFO - Successfully installed jsonschema functools32 11:25:21 INFO - Cleaning up... 11:25:21 INFO - Return code: 0 11:25:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:21 INFO - Using env: {'DISPLAY': ':0', 11:25:21 INFO - 'HOME': '/home/cltbld', 11:25:21 INFO - 'LANG': 'en_US.UTF-8', 11:25:21 INFO - 'LANGUAGE': 'en_US:en', 11:25:21 INFO - 'LOGNAME': 'cltbld', 11:25:21 INFO - 'MAIL': '/var/mail/cltbld', 11:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:21 INFO - 'MOZ_NO_REMOTE': '1', 11:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:21 INFO - 'NO_EM_RESTART': '1', 11:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:21 INFO - 'PWD': '/builds/slave/test', 11:25:21 INFO - 'SHELL': '/bin/bash', 11:25:21 INFO - 'SHLVL': '1', 11:25:21 INFO - 'TERM': 'linux', 11:25:21 INFO - 'TMOUT': '86400', 11:25:21 INFO - 'USER': 'cltbld', 11:25:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:21 INFO - '_': '/tools/buildbot/bin/python'} 11:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:22 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:22 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 11:25:22 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 11:25:22 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 11:25:22 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 11:25:22 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 11:25:22 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 11:25:24 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:24 INFO - Downloading docopt-0.6.1.tar.gz 11:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:24 INFO - Running setup.py install for blobuploader 11:25:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:24 INFO - Running setup.py install for requests 11:25:25 INFO - Running setup.py install for docopt 11:25:25 INFO - Successfully installed blobuploader requests docopt 11:25:25 INFO - Cleaning up... 11:25:25 INFO - Return code: 0 11:25:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:25 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:25 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 11:25:25 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 11:25:25 INFO - Using env: {'DISPLAY': ':0', 11:25:25 INFO - 'HOME': '/home/cltbld', 11:25:25 INFO - 'LANG': 'en_US.UTF-8', 11:25:25 INFO - 'LANGUAGE': 'en_US:en', 11:25:25 INFO - 'LOGNAME': 'cltbld', 11:25:25 INFO - 'MAIL': '/var/mail/cltbld', 11:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:25 INFO - 'MOZ_NO_REMOTE': '1', 11:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:25 INFO - 'NO_EM_RESTART': '1', 11:25:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:25 INFO - 'PWD': '/builds/slave/test', 11:25:25 INFO - 'SHELL': '/bin/bash', 11:25:25 INFO - 'SHLVL': '1', 11:25:25 INFO - 'TERM': 'linux', 11:25:25 INFO - 'TMOUT': '86400', 11:25:25 INFO - 'USER': 'cltbld', 11:25:25 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:25 INFO - '_': '/tools/buildbot/bin/python'} 11:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:25 INFO - Running setup.py (path:/tmp/pip-DKHzbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:25 INFO - Running setup.py (path:/tmp/pip-CMpsq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:25 INFO - Running setup.py (path:/tmp/pip-er55Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:25 INFO - Running setup.py (path:/tmp/pip-ec9wTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:26 INFO - Running setup.py (path:/tmp/pip-OhBdAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:26 INFO - Running setup.py (path:/tmp/pip-CFHn6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:26 INFO - Running setup.py (path:/tmp/pip-2lnUZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:26 INFO - Running setup.py (path:/tmp/pip-NTsXFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:26 INFO - Running setup.py (path:/tmp/pip-QSvzpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:26 INFO - Running setup.py (path:/tmp/pip-A4cdoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:26 INFO - Running setup.py (path:/tmp/pip-9fYdLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:26 INFO - Running setup.py (path:/tmp/pip-LEP2IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:26 INFO - Running setup.py (path:/tmp/pip-PZqkk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:26 INFO - Running setup.py (path:/tmp/pip-xXh0c6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:26 INFO - Running setup.py (path:/tmp/pip-1lmHwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:26 INFO - Running setup.py (path:/tmp/pip-P8452w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:26 INFO - Running setup.py (path:/tmp/pip-0BUUrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:26 INFO - Running setup.py install for manifestparser 11:25:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Running setup.py install for mozcrash 11:25:27 INFO - Running setup.py install for mozdebug 11:25:27 INFO - Running setup.py install for mozdevice 11:25:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Running setup.py install for mozfile 11:25:27 INFO - Running setup.py install for mozhttpd 11:25:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Running setup.py install for mozinfo 11:25:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Running setup.py install for mozInstall 11:25:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Running setup.py install for mozleak 11:25:27 INFO - Running setup.py install for mozlog 11:25:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:27 INFO - Running setup.py install for moznetwork 11:25:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:28 INFO - Running setup.py install for mozprocess 11:25:28 INFO - Running setup.py install for mozprofile 11:25:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:28 INFO - Running setup.py install for mozrunner 11:25:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:28 INFO - Running setup.py install for mozscreenshot 11:25:28 INFO - Running setup.py install for moztest 11:25:28 INFO - Running setup.py install for mozversion 11:25:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:28 INFO - Cleaning up... 11:25:28 INFO - Return code: 0 11:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25: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')]} 11:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25: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')]} 11:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:28 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:28 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 11:25:28 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 11:25:28 INFO - Using env: {'DISPLAY': ':0', 11:25:28 INFO - 'HOME': '/home/cltbld', 11:25:28 INFO - 'LANG': 'en_US.UTF-8', 11:25:28 INFO - 'LANGUAGE': 'en_US:en', 11:25:28 INFO - 'LOGNAME': 'cltbld', 11:25:28 INFO - 'MAIL': '/var/mail/cltbld', 11:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:28 INFO - 'MOZ_NO_REMOTE': '1', 11:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:28 INFO - 'NO_EM_RESTART': '1', 11:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:28 INFO - 'PWD': '/builds/slave/test', 11:25:28 INFO - 'SHELL': '/bin/bash', 11:25:28 INFO - 'SHLVL': '1', 11:25:28 INFO - 'TERM': 'linux', 11:25:28 INFO - 'TMOUT': '86400', 11:25:28 INFO - 'USER': 'cltbld', 11:25:28 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:28 INFO - '_': '/tools/buildbot/bin/python'} 11:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:28 INFO - Running setup.py (path:/tmp/pip-Ws3U94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:29 INFO - Running setup.py (path:/tmp/pip-uH25YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:29 INFO - Running setup.py (path:/tmp/pip-2eXSpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:29 INFO - Running setup.py (path:/tmp/pip-sMgmqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:29 INFO - Running setup.py (path:/tmp/pip-Azjxyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:29 INFO - Running setup.py (path:/tmp/pip-gxoTz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:29 INFO - Running setup.py (path:/tmp/pip-rzugtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:29 INFO - Running setup.py (path:/tmp/pip-iU_1FC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:29 INFO - Running setup.py (path:/tmp/pip-G1ugGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:29 INFO - Running setup.py (path:/tmp/pip-XrRLp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:29 INFO - Running setup.py (path:/tmp/pip-KvcP7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:29 INFO - Running setup.py (path:/tmp/pip-yJ6jUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:29 INFO - Running setup.py (path:/tmp/pip-O7Q852-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:29 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:29 INFO - Running setup.py (path:/tmp/pip-5QsxOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 11:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:29 INFO - Running setup.py (path:/tmp/pip-brONN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:30 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)) 11:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:30 INFO - Running setup.py (path:/tmp/pip-dg3TEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:30 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)) 11:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:30 INFO - Running setup.py (path:/tmp/pip-PSAa3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:30 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)) 11:25:30 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)) 11:25:30 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)) 11:25:30 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)) 11:25:30 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)) 11:25:30 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)) 11:25:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:32 INFO - Downloading blessings-1.6.tar.gz 11:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:32 INFO - Installing collected packages: blessings 11:25:32 INFO - Running setup.py install for blessings 11:25:32 INFO - Successfully installed blessings 11:25:32 INFO - Cleaning up... 11:25:32 INFO - Return code: 0 11:25:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:32 INFO - Reading from file tmpfile_stdout 11:25:32 INFO - Current package versions: 11:25:32 INFO - argparse == 1.2.1 11:25:32 INFO - blessings == 1.6 11:25:32 INFO - blobuploader == 1.2.4 11:25:32 INFO - docopt == 0.6.1 11:25:32 INFO - functools32 == 3.2.3-2 11:25:32 INFO - jsonschema == 2.5.1 11:25:32 INFO - manifestparser == 1.1 11:25:32 INFO - mozInstall == 1.12 11:25:32 INFO - mozcrash == 0.17 11:25:32 INFO - mozdebug == 0.1 11:25:32 INFO - mozdevice == 0.48 11:25:32 INFO - mozfile == 1.2 11:25:32 INFO - mozhttpd == 0.7 11:25:32 INFO - mozinfo == 0.9 11:25:32 INFO - mozleak == 0.1 11:25:32 INFO - mozlog == 3.2 11:25:32 INFO - moznetwork == 0.27 11:25:32 INFO - mozprocess == 0.23 11:25:32 INFO - mozprofile == 0.28 11:25:32 INFO - mozrunner == 6.12 11:25:32 INFO - mozscreenshot == 0.1 11:25:32 INFO - mozsystemmonitor == 0.3 11:25:32 INFO - moztest == 0.7 11:25:32 INFO - mozversion == 1.4 11:25:32 INFO - psutil == 3.1.1 11:25:32 INFO - requests == 1.2.3 11:25:32 INFO - wsgiref == 0.1.2 11:25:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:32 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 11:25:32 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 11:25:32 INFO - Using env: {'DISPLAY': ':0', 11:25:32 INFO - 'HOME': '/home/cltbld', 11:25:32 INFO - 'LANG': 'en_US.UTF-8', 11:25:32 INFO - 'LANGUAGE': 'en_US:en', 11:25:32 INFO - 'LOGNAME': 'cltbld', 11:25:32 INFO - 'MAIL': '/var/mail/cltbld', 11:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:32 INFO - 'MOZ_NO_REMOTE': '1', 11:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:32 INFO - 'NO_EM_RESTART': '1', 11:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:32 INFO - 'PWD': '/builds/slave/test', 11:25:32 INFO - 'SHELL': '/bin/bash', 11:25:32 INFO - 'SHLVL': '1', 11:25:32 INFO - 'TERM': 'linux', 11:25:32 INFO - 'TMOUT': '86400', 11:25:32 INFO - 'USER': 'cltbld', 11:25:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:32 INFO - '_': '/tools/buildbot/bin/python'} 11:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 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)) 11:25:32 INFO - Cleaning up... 11:25:32 INFO - Return code: 0 11:25:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:32 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 11:25:32 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 11:25:32 INFO - Using env: {'DISPLAY': ':0', 11:25:32 INFO - 'HOME': '/home/cltbld', 11:25:32 INFO - 'LANG': 'en_US.UTF-8', 11:25:32 INFO - 'LANGUAGE': 'en_US:en', 11:25:32 INFO - 'LOGNAME': 'cltbld', 11:25:32 INFO - 'MAIL': '/var/mail/cltbld', 11:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:32 INFO - 'MOZ_NO_REMOTE': '1', 11:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:32 INFO - 'NO_EM_RESTART': '1', 11:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:32 INFO - 'PWD': '/builds/slave/test', 11:25:32 INFO - 'SHELL': '/bin/bash', 11:25:32 INFO - 'SHLVL': '1', 11:25:32 INFO - 'TERM': 'linux', 11:25:32 INFO - 'TMOUT': '86400', 11:25:32 INFO - 'USER': 'cltbld', 11:25:32 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:32 INFO - '_': '/tools/buildbot/bin/python'} 11:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:32 INFO - Cleaning up... 11:25:32 INFO - Return code: 0 11:25:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:25:33 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 0x7fba2dbadf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, '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': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', '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 11:25:33 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 11:25:33 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 11:25:33 INFO - Using env: {'DISPLAY': ':0', 11:25:33 INFO - 'HOME': '/home/cltbld', 11:25:33 INFO - 'LANG': 'en_US.UTF-8', 11:25:33 INFO - 'LANGUAGE': 'en_US:en', 11:25:33 INFO - 'LOGNAME': 'cltbld', 11:25:33 INFO - 'MAIL': '/var/mail/cltbld', 11:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:33 INFO - 'MOZ_NO_REMOTE': '1', 11:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:33 INFO - 'NO_EM_RESTART': '1', 11:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:33 INFO - 'PWD': '/builds/slave/test', 11:25:33 INFO - 'SHELL': '/bin/bash', 11:25:33 INFO - 'SHLVL': '1', 11:25:33 INFO - 'TERM': 'linux', 11:25:33 INFO - 'TMOUT': '86400', 11:25:33 INFO - 'USER': 'cltbld', 11:25:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:33 INFO - '_': '/tools/buildbot/bin/python'} 11:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:33 INFO - Downloading/unpacking flake8 11:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:25:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:25:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 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 11:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:25:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:35 INFO - no previously-included directories found matching 'docs/_build' 11:25:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:25:35 INFO - Running setup.py install for pep8 11:25:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:25:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:25:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:25:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:25:36 INFO - no previously-included directories found matching 'docs/_build' 11:25:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:36 INFO - Cleaning up... 11:25:36 INFO - Return code: 0 11:25:36 INFO - Running post-action listener: _resource_record_post_action 11:25:36 INFO - Running post-action listener: _start_resource_monitoring 11:25:36 INFO - Starting resource monitoring. 11:25:36 INFO - ##### 11:25:36 INFO - ##### Finished create-virtualenv step (success) 11:25:36 INFO - ##### 11:25:36 INFO - ##### 11:25:36 INFO - ##### Running install step. 11:25:36 INFO - ##### 11:25:36 INFO - Running pre-action listener: _resource_record_pre_action 11:25:36 INFO - Running main action method: install 11:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:36 INFO - Reading from file tmpfile_stdout 11:25:36 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:36 INFO - Reading from file tmpfile_stdout 11:25:36 INFO - Output received: 11:25:36 INFO - Usage: mozinstall [options] installer 11:25:36 INFO - Options: 11:25:36 INFO - -h, --help show this help message and exit 11:25:36 INFO - -d DEST, --destination=DEST 11:25:36 INFO - Directory to install application into. [default: 11:25:36 INFO - "/builds/slave/test"] 11:25:36 INFO - --app=APP Application being installed. [default: firefox] 11:25:36 INFO - mkdir: /builds/slave/test/build/application 11:25:36 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'] 11:25:36 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 11:25:52 INFO - Reading from file tmpfile_stdout 11:25:52 INFO - Output received: 11:25:52 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:52 INFO - Running post-action listener: _resource_record_post_action 11:25:52 INFO - ##### 11:25:52 INFO - ##### Finished install step (success) 11:25:52 INFO - ##### 11:25:52 INFO - ##### 11:25:52 INFO - ##### Running run-tests step. 11:25:52 INFO - ##### 11:25:52 INFO - Running pre-action listener: _resource_record_pre_action 11:25:52 INFO - Running main action method: run_tests 11:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:52 INFO - Python 2.7.3 11:25:52 INFO - Return code: 0 11:25:52 INFO - grabbing minidump binary from tooltool 11:25: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')]} 11:25:52 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 0x1f2e1c0>, '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 0x1f2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:52 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 11:25:52 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 11:25:52 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 11:25:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:52 INFO - Return code: 0 11:25:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:53 INFO - Return code: 0 11:25:53 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/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:25:53 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/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 11:25:53 INFO - Using env: {'DISPLAY': ':0', 11:25:53 INFO - 'HOME': '/home/cltbld', 11:25:53 INFO - 'LANG': 'en_US.UTF-8', 11:25:53 INFO - 'LANGUAGE': 'en_US:en', 11:25:53 INFO - 'LOGNAME': 'cltbld', 11:25:53 INFO - 'MAIL': '/var/mail/cltbld', 11:25:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:53 INFO - 'MOZ_NO_REMOTE': '1', 11:25:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:53 INFO - 'NO_EM_RESTART': '1', 11:25:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:53 INFO - 'PWD': '/builds/slave/test', 11:25:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:53 INFO - 'SHELL': '/bin/bash', 11:25:53 INFO - 'SHLVL': '1', 11:25:53 INFO - 'TERM': 'linux', 11:25:53 INFO - 'TMOUT': '86400', 11:25:53 INFO - 'USER': 'cltbld', 11:25:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159', 11:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:53 INFO - '_': '/tools/buildbot/bin/python'} 11:25:53 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/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 11:25:53 INFO - mozversion application_buildid: 20160727082613 11:25:53 INFO - mozversion application_changeset: a9e8f70d870c1492bc3d64d3ac2f21f033d125cf 11:25:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:25:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:53 INFO - mozversion application_name: Firefox 11:25:53 INFO - mozversion application_remotingname: firefox-dev 11:25:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:53 INFO - mozversion application_vendor: Mozilla 11:25:53 INFO - mozversion application_version: 49.0a2 11:25:53 INFO - mozversion platform_buildid: 20160727082613 11:25:53 INFO - mozversion platform_changeset: a9e8f70d870c1492bc3d64d3ac2f21f033d125cf 11:25:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:25:53 INFO - mozversion platform_version: 49.0a2 11:25:53 INFO - using testdate: 1469643953 11:25:53 INFO - actual date: 1469643953 11:25:53 INFO - starting webserver on 'localhost:57078' 11:25:53 INFO - SUITE-START | Running 2 tests 11:25:53 INFO - TEST-START | dromaeo_css 11:25:53 INFO - operating with platform_type : linux_ 11:25:53 INFO - Initialising browser for dromaeo_css test... 11:25:53 INFO - TEST-INFO | started process 21395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3kb8rs/profile http://localhost:57078/getInfo.html) 11:25:57 INFO - PROCESS | 21395 | __metrics Screen width/height:1600/1200 11:25:57 INFO - PROCESS | 21395 | colorDepth:24 11:25:57 INFO - PROCESS | 21395 | Browser inner width/height: 1024/697 11:25:57 INFO - PROCESS | 21395 | __metrics 11:25:58 ERROR - PROCESS | 21395 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:25:59 INFO - TEST-INFO | 21395: exit 0 11:25:59 INFO - Browser initialized. 11:25:59 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:59 INFO - TEST-INFO | started process 21526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3kb8rs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:11 INFO - PROCESS | 21526 | RSS: Main: 155942912 11:26:11 INFO - PROCESS | 21526 | 11:27:00 INFO - PROCESS | 21526 | 1469644020639 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] 11:29:09 INFO - PROCESS | 21526 | Cycle 1(1): loaded http://localhost:57078/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57078/tests/dromaeo/cssquery-ext.html) 11:29:10 INFO - PROCESS | 21526 | RSS: Main: 160337920 11:29:10 INFO - PROCESS | 21526 | 11:32:12 INFO - PROCESS | 21526 | Cycle 1(1): loaded http://localhost:57078/tests/dromaeo/cssquery-ext.html (next: http://localhost:57078/tests/dromaeo/cssquery-jquery.html) 11:32:12 INFO - PROCESS | 21526 | RSS: Main: 157126656 11:32:12 INFO - PROCESS | 21526 | 11:35:14 INFO - PROCESS | 21526 | Cycle 1(1): loaded http://localhost:57078/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57078/tests/dromaeo/cssquery-mootools.html) 11:35:14 INFO - PROCESS | 21526 | RSS: Main: 156622848 11:35:14 INFO - PROCESS | 21526 | 11:38:16 INFO - PROCESS | 21526 | Cycle 1(1): loaded http://localhost:57078/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57078/tests/dromaeo/cssquery-prototype.html) 11:38:17 INFO - PROCESS | 21526 | RSS: Main: 156545024 11:38:17 INFO - PROCESS | 21526 | 11:41:19 INFO - PROCESS | 21526 | Cycle 1(1): loaded http://localhost:57078/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57078/tests/dromaeo/cssquery-yui.html) 11:41:20 INFO - PROCESS | 21526 | RSS: Main: 158613504 11:41:20 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | Cycle 1(1): loaded http://localhost:57078/tests/dromaeo/cssquery-yui.html (next: http://localhost:57078/tests/dromaeo/cssquery-dojo.html) 11:44:22 INFO - PROCESS | 21526 | RSS: Main: 158781440 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | __start_tp_report 11:44:22 INFO - PROCESS | 21526 | _x_x_mozilla_page_load 11:44:22 INFO - PROCESS | 21526 | _x_x_mozilla_page_load_details 11:44:22 INFO - PROCESS | 21526 | |i|pagename|runs| 11:44:22 INFO - PROCESS | 21526 | |0;dojo.html;3327.584051993501;3356.899293021209;3379.9324013519713;3401.4217583010886;3407.693307602315;5600.047991841387;5602.35572909115;5674.177244299574;5678.063119585268;5740.995325817986;5684.687342196177;5693.3452652944925;5736.541076713864;5739.51214146797;5760.135979603062;5153.381594208691;5165.04446677364;5222;5245.2132180173085;5278.181881808326;5068.72122033288;5083;5258.763355649005;5278.630495865291;5279.9208011879855;5078.263651770491;5179.948200517984;5182.119039763231;5196.948030519703;5198.532132108109;5208.8437346879655;5214.426413094557;5279.973600132013;5283.577313814885;5283.603729720248;5147.459516750762;5181.274621552986;5256;5262.947370526284;5288.365396152448;5376.274202982587;5489.368722596912;5530.087535556629;5577.609567330289;5646.040173170571;6083.452489275986;6126.846828829271;6147.631142131441;6157.138000679908;6161.7227224775;5932.525397968152;6171.969140154315;6178.660173690445;6187.257529096492;6188.628682279078;5637.408072152447;5705.62913410627;5721.971390143022;5769.336526299446;5779.739911704026;6306.684665766693;6308.621482710961;6319.46284565817;6322.430981211713;6324.9051264231075;5720.313562372542;5879.588428810028;6031.9396806032255;6033.3966603340195;6065.75736970525;6048.455638992512;6167.198264225622;6168.629882207082;6170.876582468325;6171.413715697002;6061.696915154313;6122.724477398528;6140.416660417253;6147.0779383092895;6151.2618485781995;5850.678212698257;6005.489533389711;6060.999935010762;6146.78486252979;6147.846303842351;4670.8365207217585;4671.089137618132;4687.95312046882;4695.3426520287185;4718.363020992122;4132.669386449077;4158.688098392633;4168.708190426702;4194.832206711697;4203.642690371353;5861.41385861419;5875.853103672357;5915.467607915222;5915.970420147872;5924.526037917042;5914.970425147847;6060.787872424444;6126.239477547061;6152.938470615326;6153.7230824613;5972.163897054415;5992.64044157352;5996.4603185713495;5998.910016349758;6005.819825405245;4832.347633069561;4838.903221935541;4853.247746599282;4890.755462226874;4903.117438860968;6313.43179113882;6392.360763923571;6396.616203027833;6398.232212134573;6404.071409645669;6132.5400594956445;6132.627792144284;6150.261968563801;6165.938340616536;6180.196574445294;6132.630864714964;6198.163247961648;6309.842253943504;6327.082573026977;6426.4537514311805;5991.580589358703;6007.87984240304;6019.789307374221;6022.126791615279;6039.214902062704;5891.941080589139;6113.23584551931;6119.602225855305;6123.326434092157;6144.324124346408;5887.205227294432;5931.6441013539325;5985.820425387245;6000.609960352563;6010.579259451796;5922.407759224043;5961.7615295387695;5977.671228082323;6005.759769609342;6018.7291571878495;5677.971610141923;5766.394528574439;5799.362070172193;5808.041673123887;5809.331926828469;5990.580659353804;6087.847803804941;6098.451139397475;6100.23747031621;6131.509479241739;5882.588218824641;5899.38056504078;5905.881882362242;5922.170896074639;5945.554083443845 11:44:22 INFO - PROCESS | 21526 | |1;ext.html;579.5913880714097;647.8412788866727;658.6871236162821;660.5607271164674;665.3612531969309;43251.56748432515;45021;45024;45025.77487112564;49003.50996490034;46357.30464043042;46787.298190527166;46805.531944680544;47016.29475557861;47107;8663.350248731338;8834.072422395653;8915.509646969414;8922.152395522415;8935.55322233889;8874.15695508929;8943.910560894405;8985.05656906022;9045.547722613876;9050.77373065672;8981.461112333249;9071.092890710943;9071.59177836999;9077;9107.499087550183;8973.282137429023;9006.189442950134;9019.458832470073;9024.593893274785;9057;8684.305255579538;8705.260052895512;8759.080296568833;8855.291576673852;8877.911220887772;44497.77751111256;44650.55349446496;44686;44886;44964.325535117;3796.8101594920145;3893.3186692329014;4033.616806403387;4062.5328087270045;4511.939694171867;33705.831470842735;33870.49194262088;34229;34465.31069378623;34597.481037784455;4571.291449825282;4681.46163191234;4703.6942598730975;4735.956007610978;4841.830535931225;369919;371156;373178;374698.3795243073;379223;61301;61619.38380616226;62283.68858155771;62298;62364.688176558826;38562.421563676005;39247.60752392497;39552.80223598864;41366.37950430746;41677.37483937744;18990.335338263372;19197.136128874234;19208.423747287605;19232.519187020436;19233.711494327596;14563.854361456462;14649;14676.119432834064;14714.852851471349;14762.630934226516;20378.59242815165;20400.795992040188;20558.58882822335;20678.276260331117;20773.584528309348;7404.370628496638;7438.66526006331;7445.590492522855;7473.4021278297605;7476.775696729107;1121.3440137519478;1159.913006524514;1214.7388311513066;1247.650657815813;1263.7662032524013;31719.365612687616;31919.20201994922;32631.184220394207;33053.17367065795;33378.66621333756;1165.7143999719954;1182.1134149387958;1193.4390836306923;1220.2251570252954;1238.993805030987;17086.658266834595;17227.22477488516;17295.827041729674;17360.21879015422;17412.303507859797;467449;468436;470489;472479;473219;58360.70819645959;58375;58420.7078964611;58517.707411463525;58612.41387586155;1471.3599584180915;1481.5111013365563;1503.6090616439803;1513.1828812441158;1514.6970605878648;31176.376472470878;31422.528662070545;31528.527072094395;31774.682253178096;32452.83773581117;50986.23520647119;51616.48383516117;51787.223191652905;51829;51947.74026129845;373234;375733;378592;379433;381048;29043.85478072596;29084.563731544466;29180.124596262147;29371.853140734158;29385.706142938296;48214.27678584894;49412;49447;49473.50526494689;49825.50174498209;40152.39771403373;40937.38593921034;41258.38112428256;42037.108330125826;42214.366784497644;41693.58306416897;41983;42106.7894660537;42181.78909105435;42532.1493570133;43604.34593481164;44676.32985505155;44876.326855097854;45207.32189017233;47914;38531.28557448486;38634;38981.41527877028;39144.80427597844;39375.80312098421;29860.850695746383;30224.69775302219;30285.697143028287;30423.54364684576;30603.06480472573 11:44:22 INFO - PROCESS | 21526 | |2;jquery.html;429.55870392106243;433.84381622615865;435.51657659997403;440.6871121503732;444.96217821485175;19704.802951970494;19995.800041999577;20602;21049;21056.89471552644;19613.901930490327;19787.802121978777;19797.802021979776;19985.60028799423;20000.899995500004;5779.248697669308;6004.219451471303;6036.577439579231;6042.486388656969;6090.147379366892;5689.573282003846;5938.673372964486;5959.344472108065;5985.760569577234;5993.910091348634;5886.352501224862;5906.61606995546;5922.378150294222;5944.227250457435;5961.344252132262;5734.655920644754;5863.706814659271;5902.173695682608;5905.29136503618;5908.49777768888;5254.08053590624;5272.446393128705;5286.02208591408;5290.365156181283;5306.044911915854;23214.41963950898;23355.182568610187;23833.642495362583;23965.40086497834;24031.279061628004;2220.611393006234;2374.584447721659;2415.130553000918;2547.681539807524;2707.553253713135;10469.267151299413;10542.894571054268;10687.679369618847;11038.11695064401;12024.819627705592;2009.6985452182143;2043.1725151313742;2089.341857314941;2114.1754715660904;2127.755308139568;76883.61558192229;78390.21609783944;78468.21531784667;80034;81035;11683.474243659055;11711.414429278502;11774.823377649342;11985.700357491132;11996.760064798655;16662.166891655612;16674.416395426102;16878.324867005427;16928.661426771643;16930.576735581708;8855.33584981129;8865.778355541162;8981.236594889508;9028.413153145024;9073.13805188506;8545.051957074798;8581;8725.127487251351;8786.384953053224;8837.027926928033;5108.591312694975;5124.615653825978;5171;5171.689698618095;5185.688858668492;2117.3965419855267;2159.5788821180035;2167.674848772697;2184.14818220894;2200.8349373797028;1027.1885210683477;1049.7690508088208;1051.1748277602198;1103.5309993252836;1125.0156113400774;18515.35196268124;19401;19475.220991160477;19716;19767.802321976884;1036.18659352408;1062.675883855416;1064.6007747094839;1091.6779550032759;1101.4382664840828;10711.143108551452;10928.945355273172;10947.945260273807;10952.452377381258;10983.61557345489;564750;576275;581887;587187;605583;92516.53741731249;94829;96149.51925240469;96254;96381.51809240908;1057.4659796802566;1067;1071.8231491803922;1084.5444913136503;1095.9232853700164;17169.656606868044;17217.139143042546;17217.483475495756;17265.13674316254;17451.650966980844;40671.38992915049;40802.79598601988;41165.58834411618;41316.586834132475;42043.369349460394;54787.17819232635;56569.71715141398;57020;57171.71414143069;57886.4211357881;9021.413608115452;9052.864207036768;9164.862527061967;9226.584803683716;9409.200217981548;9149.5882685278;12513.499460021498;12735.23588584688;12964.28696421668;13007;11112.722181945515;11283.943580282046;11500.309981401142;11585.88414115848;11725.88274117248;10967.177461690246;11256.549738010715;11343.886561134283;11394.658160255205;11544;11602.535898563963;11694.2983420995;11708.238964467282;11750.35373054456;11846;9053.185213330831;9078.863817042618;9200.21798147165;9209.815803683754;9317.068293170629;10262.794744105226;11517.596884109016;11755.706107347385;11761.117916156152;11933.940330298294 11:44:22 INFO - PROCESS | 21526 | |3;mootools.html;1562.6562156325604;1590.7772911792347;1801.9279228830846;1833.697439922413;1885.2270569066686;8712.869306960401;9506.572204250826;9557.474338911366;10164.898351016478;10188.184945204384;9518.5240737963;9713;9746.366486178393;9851.458169800659;9878.654247101353;2494.750524947509;2522.268542122782;2529.633203185537;2538.885750141248;2542.936426589341;2412.601920683085;2525.9873700631565;2531.227975467482;2542.2627438042946;2542.872856357184;2515.0819950717946;2533.100749234023;2599.116300457844;2601.3626661467965;2608.100205429124;2401.7838394544488;2409.975900240993;2413.9155129570468;2436.4517983453757;2449.461118553915;2407.9879600601885;2425.0663494554547;2426.065964603623;2436.5979613363775;2497.900083996638;9710.61157553697;9714.562844671937;9779.51102444875;9794.853077203848;9824.754381140458;5804.245448091763;5950;5954.880902381971;5966.194563733884;5972.790952316648;3630.6369363063745;3751.137238435148;3763.9623603763885;3794.4498047782918;3821.522309711286;1130.22014809781;1148.5692865175558;1175.1069187417538;1197.0961923747602;1200.8739082396398;14064.2967851607;14072.437102515887;14127.717445651133;14141.292935353295;14158.575242742734;5032.295478632995;5058.519440653132;5140.820071297561;5167.22491626259;5179.352580927384;11636.476358563885;11652.76694466106;11704;11762;11766.52933882635;5870;5884.499817515559;5956;5963.731632076567;5965.343812180657;4683.086798074342;5270.631055826056;5448.972755136199;5461.2354270402175;5467.5625949923915;4439.334099884978;4452.131834292347;4484.887877803081;4523.95476045242;4539.909201815945;1384.3977869626744;1390.860913908601;1395.3790563199482;1418.0782491380685;1431.6778724786839;901.3285102598606;905.76902889764;929.5677509957767;942.2838642631513;948.4214629076258;6346.11154438379;6543.411093001652;6564.8358791030605;6572.737090516326;6609.206895172514;503.88158782686037;503.9042581909425;504.2562220724402;514.3493480746858;515.9819406320836;4390.385346051556;4433.357163211316;4494.213512635276;4558.772061396917;4565.178267911808;12143.635690929286;12497.75004499905;12517.874821251853;12566.371681415892;12611.369431528386;11995.580154694544;12351.25892446438;12363.6909077272;12368.381580920917;12369.690757731129;9007.279417646703;9166.770830729152;9306.906930930603;9316.720498384924;9431.245500359955;6280.823252537011;6296.2759282681245;6340.809775706736;6440.549161558646;6504.869902602016;10488.00363965422;10876.45617719095;11399.487023084146;11422.657320280405;11456.427178640868;11007.449627518752;11196.88803111991;11211.159163062966;11222.831657524981;11313.264637798517;7737.92262077372;8438;8564.785880353042;8666.263367613823;8886.24466920319;8866.73399798007;9164.816703665756;9195.528715405502;9197.402168859002;9204.631814727336;7856.135825059353;7907.9604601976625;7922.643481043482;7991.640376183202;8247.051589067094;7707.807304817425;7949.244821741925;8086.8786968194345;8234.300084492885;8251.793705157419;7093.680784364819;7196.0285361475535;7201.531900426456;7593.810154746176;7636.08366995964;5129.461406552407;5212.635115541876;5377.166539186433;5430.13117901134;5434.809781657623;5256.264123022704;5289.8677533060445;5435.347758269033;5512.062949298549;5552.888942221214 11:44:22 INFO - PROCESS | 21526 | |4;prototype.html;358.9802560859152;359.2921943770771;362.0550363551131;365.74946161879114;366.88993302009396;5645.350784659765;5696.060150075233;5720.770034442594;5736.22560954271;5740.052891272935;5508.980838544862;5611.523020543259;5620.943790562093;5624.662520248788;5638.9004144191895;4387.407699960512;4391.836163416697;4403.229434848889;4435.401220835178;4472.12793505265;4440.289553671413;4458.264386376244;4460.4647442306805;4500.34744961982;4507.520863525048;4470.351798989144;4478.216312145378;4482.148391805546;4488.0799436115685;4499.842505512308;4299.570042995707;4395.516493185747;4404.867853964386;4414.646828253732;4433.379326894221;3947.50656167979;3965.8413663453425;3976.264391087629;3979.1245925896255;3998.0604557928864;5459.535939445152;5516.862078448071;5540.335159780811;5560.4161563035705;5566.882545774339;4914.262860570907;5082.720450375228;5086.415062267813;5101.2603172539775;5107.850733584951;5893.911591326134;5909;5932.597298094279;5967.254093238345;5995.250593675791;4342.978285108554;4366.6070053695;4377.824887004516;4405.229084910128;4405.273129933557;5860.443257890493;5942.2275104236605;6162.476189523896;6199.915014872425;6207.968960155215;4365.628921541705;4375.293635482164;4390.956090439055;4396.1647287016;4398.3402489626815;4428.623566996777;4429.55704429561;4441.289393697058;4456.6211871991245;4471.306947423154;4934.8766280843265;5082.847514574495;5089.567386772092;5094.363204599425;5126.487351264844;5906;5911.965406053923;5935.495482883917;5960.910586341209;5962.869493515939;1518.8305005145976;1544.274191130167;1550.674173581594;1557.766335049729;1566.4204244429634;960.4765402855461;998.3161534348994;1006.5420233793607;1006.9144122749502;1018.3737001743874;5093.617978651616;5135.35808023997;5212.3223980883;5235.528802407725;5264.289320941701;5363.973180134074;5400.6498375406145;5429.267048948342;5431;5479.205515200274;4826.95173048272;5164.837911469965;5202.81790137351;5234.607404444682;5263.763130659053;2900.448914706199;2912.9513375184915;2917.197770613056;2931.750801181881;2943.234758962685;5570.248016517799;5604.6917419542315;5616.382197958222;5691.516221121251;5707.200991861143;5096.413912400048;5399.730013499309;5474;5475.260839786658;5516.99999999992;5626.930883132191;5669.801556945487;5688;5692.345380281238;5701.857453563694;5337.864854058408;5514.724263786715;5528.170774383874;5540.263075070757;5556.694381809039;5283.313169287968;5344.327836081959;5413.593980451403;5449.64577302474;5905.40945905406;6364.427201551883;6420.325865784025;6425.935740642533;6434.710438030394;6438.8390290243115;4372.497162826316;4429.269170586817;4432.180046691373;4451.732896026248;4453.576910193527;6102.694865256808;6151.3541078186145;6178.196834411498;6187.752489900354;6236.158118653923;5906.320773111147;6007.008843540767;6019.759209631741;6026.909596356146;6034.909476357946;5753.079507278815;5933.495652869555;5984.371640977634;5988.443004818866;5994.760209591567;5835.708214589169;5837.474627283565;5846.766129354778;5861.35525092248;5917.372722501346;5956.761729530944;6051.636901785907;6069.9089513656445;6111.877762444815;6115.908261376172;5836.095405212199;5880.382559831156;5908.172855800105;5941.673207973603;5960.5231581474245 11:44:22 INFO - PROCESS | 21526 | |5;yui.html;839.5550358310094;851.3104385447788;878.5387671472477;893.5487578772721;906.7869050773071;13989.720205595882;17298.221580028898;17409.04250266235;17502;17519.64960700787;15205.315760790763;15222.847771522282;15245.161516116608;16309.266083026263;16856.410025649104;719.9964000180019;845.5898889038842;858.4034096303056;864.269692110169;877.33322674767;866.7919699272193;874.191372979991;874.567089290802;874.8119154381807;876.3208513402133;904.6245807989676;908.2325435007408;915.2860768600502;915.693242763675;915.8671992561075;898.2589363774912;899.2715900120891;904.9457032578066;906.9954650226773;907.5507623726231;670.0686046395514;672.9495287853431;674.197704731368;675.8040168351172;677;15925.601859953595;15999;16099.517014489584;16107.677846443123;16122.83877161225;16250.268737906705;16689.08210048447;16713.665726685518;16869.15654217284;16895.91552042244;13279.734405311936;13381.66545836352;13393.464261429532;13507.729845403037;13891;4030.536488303824;4098.549159592442;4118.279301122292;4140.834366625331;4256.08494173751;77770.22229777687;79687.20312796856;79861;79902.80145797876;79903;10824.891751082389;10871.347719136877;11133.610323638795;11296.37869917146;11446.656600302003;23326.7667323328;24624.630630540556;24700.5059898801;24802.131925382524;24808.627870581957;9060.501672408082;9060.773480662905;9087.954560227157;9324.90675093254;9362.95318523403;4821.975890120597;4974.427940786783;5004.399472063303;5057.671251368649;5063.974680126649;3739.270842185748;3759.154190307214;3855.575886652466;3869.6517313441927;3905.7656540607654;690.4890381117937;692.9376356127973;714.4998501049182;714.8498815248752;721.2679130682361;735.2023054985401;748.9962550187323;825.9132791056973;847.1993965702352;847.3136759225048;10241.795164096677;10441.32131411471;10489.059851091059;10520.631777887891;10883.18376121794;592.4970226280236;816.7263966571146;829.3738227638215;848.5290663681593;858.429144618834;4804.903901921942;4895.653695233839;4926.3349447824085;5018.774155163026;5024.221245706921;70793;71423.64288178526;117145.41427292809;117899;120005;62196.37803621906;103341;103871;106848.46575767071;107000;93071.53464232635;93803.53098234601;93937;94524.52737736405;95178.99999999862;9906;10012.64955726546;10213.642522511676;10269.589216431259;10509.737256568647;49752.25371619356;52744.89020439139;53231.20153197783;53381.19928201158;57009.714951424976;77979.61010194913;78525;78666.6066669663;80645.19354806376;80719.59640201762;13498.59504214875;13570.321483925567;14216.857831421554;14281.571552853431;14565.85434145645;14471.78292325637;14799.704005920037;14970.101793892401;15013;15118.470853520514;13770.518031868836;14031.508897188549;14439.639009024859;14963.177025263714;15469.613259668598;13572.689113333385;14101.788473172706;14775.519990409673;14782.113073215642;15137.848621513644;12804.69282979004;13750.312484375541;13810.309484525935;13826.37781299864;14416.279186040865;11286.153538484483;11674.94162529182;11679;11712.590059347882;11876.762464750484;11222.004632344888;11271.557965587199;11729.882701172879;11745.295282282748;11835.408229588658 11:44:22 INFO - PROCESS | 21526 | __end_tp_report 11:44:22 INFO - PROCESS | 21526 | __start_cc_report 11:44:22 INFO - PROCESS | 21526 | _x_x_mozilla_cycle_collect,335 11:44:22 INFO - PROCESS | 21526 | __end_cc_report 11:44:22 INFO - PROCESS | 21526 | __startTimestamp1469645062833__endTimestamp 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | ------- Summary: start ------- 11:44:22 INFO - PROCESS | 21526 | Number of tests: 6 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | [#0] dojo.html Cycles:165 Average:5673.04 Median:5915.97 stddev:652.45 (11.0%) stddev-sans-first:627.97 11:44:22 INFO - PROCESS | 21526 | Values: 3327.6 3356.9 3379.9 3401.4 3407.7 5600.0 5602.4 5674.2 5678.1 5741.0 5684.7 5693.3 5736.5 5739.5 5760.1 5153.4 5165.0 5222.0 5245.2 5278.2 5068.7 5083.0 5258.8 5278.6 5279.9 5078.3 5179.9 5182.1 5196.9 5198.5 5208.8 5214.4 5280.0 5283.6 5283.6 5147.5 5181.3 5256.0 5262.9 5288.4 5376.3 5489.4 5530.1 5577.6 5646.0 6083.5 6126.8 6147.6 6157.1 6161.7 5932.5 6172.0 6178.7 6187.3 6188.6 5637.4 5705.6 5722.0 5769.3 5779.7 6306.7 6308.6 6319.5 6322.4 6324.9 5720.3 5879.6 6031.9 6033.4 6065.8 6048.5 6167.2 6168.6 6170.9 6171.4 6061.7 6122.7 6140.4 6147.1 6151.3 5850.7 6005.5 6061.0 6146.8 6147.8 4670.8 4671.1 4688.0 4695.3 4718.4 4132.7 4158.7 4168.7 4194.8 4203.6 5861.4 5875.9 5915.5 5916.0 5924.5 5915.0 6060.8 6126.2 6152.9 6153.7 5972.2 5992.6 5996.5 5998.9 6005.8 4832.3 4838.9 4853.2 4890.8 4903.1 6313.4 6392.4 6396.6 6398.2 6404.1 6132.5 6132.6 6150.3 6165.9 6180.2 6132.6 6198.2 6309.8 6327.1 6426.5 5991.6 6007.9 6019.8 6022.1 6039.2 5891.9 6113.2 6119.6 6123.3 6144.3 5887.2 5931.6 5985.8 6000.6 6010.6 5922.4 5961.8 5977.7 6005.8 6018.7 5678.0 5766.4 5799.4 5808.0 5809.3 5990.6 6087.8 6098.5 6100.2 6131.5 5882.6 5899.4 5905.9 5922.2 5945.6 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | [#1] ext.html Cycles:180 Average:57852.88 Median:42144.29 stddev:107937.51 (256.1%) stddev-sans-first:108154.65 11:44:22 INFO - PROCESS | 21526 | Values: 579.6 647.8 658.7 660.6 665.4 43251.6 45021.0 45024.0 45025.8 49003.5 46357.3 46787.3 46805.5 47016.3 47107.0 8663.4 8834.1 8915.5 8922.2 8935.6 8874.2 8943.9 8985.1 9045.5 9050.8 8981.5 9071.1 9071.6 9077.0 9107.5 8973.3 9006.2 9019.5 9024.6 9057.0 8684.3 8705.3 8759.1 8855.3 8877.9 44497.8 44650.6 44686.0 44886.0 44964.3 3796.8 3893.3 4033.6 4062.5 4511.9 33705.8 33870.5 34229.0 34465.3 34597.5 4571.3 4681.5 4703.7 4736.0 4841.8 369919.0 371156.0 373178.0 374698.4 379223.0 61301.0 61619.4 62283.7 62298.0 62364.7 38562.4 39247.6 39552.8 41366.4 41677.4 18990.3 19197.1 19208.4 19232.5 19233.7 14563.9 14649.0 14676.1 14714.9 14762.6 20378.6 20400.8 20558.6 20678.3 20773.6 7404.4 7438.7 7445.6 7473.4 7476.8 1121.3 1159.9 1214.7 1247.7 1263.8 31719.4 31919.2 32631.2 33053.2 33378.7 1165.7 1182.1 1193.4 1220.2 1239.0 17086.7 17227.2 17295.8 17360.2 17412.3 467449.0 468436.0 470489.0 472479.0 473219.0 58360.7 58375.0 58420.7 58517.7 58612.4 1471.4 1481.5 1503.6 1513.2 1514.7 31176.4 31422.5 31528.5 31774.7 32452.8 50986.2 51616.5 51787.2 51829.0 51947.7 373234.0 375733.0 378592.0 379433.0 381048.0 29043.9 29084.6 29180.1 29371.9 29385.7 48214.3 49412.0 49447.0 49473.5 49825.5 40152.4 40937.4 41258.4 42037.1 42214.4 41693.6 41983.0 42106.8 42181.8 42532.1 43604.3 44676.3 44876.3 45207.3 47914.0 38531.3 38634.0 38981.4 39144.8 39375.8 29860.9 30224.7 30285.7 30423.5 30603.1 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | [#2] jquery.html Cycles:180 Average:31800.40 Median:23284.80 stddev:95713.47 (411.1%) stddev-sans-first:95952.99 11:44:22 INFO - PROCESS | 21526 | Values: 429.6 433.8 435.5 440.7 445.0 19704.8 19995.8 20602.0 21049.0 21056.9 19613.9 19787.8 19797.8 19985.6 20000.9 5779.2 6004.2 6036.6 6042.5 6090.1 5689.6 5938.7 5959.3 5985.8 5993.9 5886.4 5906.6 5922.4 5944.2 5961.3 5734.7 5863.7 5902.2 5905.3 5908.5 5254.1 5272.4 5286.0 5290.4 5306.0 23214.4 23355.2 23833.6 23965.4 24031.3 2220.6 2374.6 2415.1 2547.7 2707.6 10469.3 10542.9 10687.7 11038.1 12024.8 2009.7 2043.2 2089.3 2114.2 2127.8 76883.6 78390.2 78468.2 80034.0 81035.0 11683.5 11711.4 11774.8 11985.7 11996.8 16662.2 16674.4 16878.3 16928.7 16930.6 8855.3 8865.8 8981.2 9028.4 9073.1 8545.1 8581.0 8725.1 8786.4 8837.0 5108.6 5124.6 5171.0 5171.7 5185.7 2117.4 2159.6 2167.7 2184.1 2200.8 1027.2 1049.8 1051.2 1103.5 1125.0 18515.4 19401.0 19475.2 19716.0 19767.8 1036.2 1062.7 1064.6 1091.7 1101.4 10711.1 10928.9 10947.9 10952.5 10983.6 564750.0 576275.0 581887.0 587187.0 605583.0 92516.5 94829.0 96149.5 96254.0 96381.5 1057.5 1067.0 1071.8 1084.5 1095.9 17169.7 17217.1 17217.5 17265.1 17451.7 40671.4 40802.8 41165.6 41316.6 42043.4 54787.2 56569.7 57020.0 57171.7 57886.4 9021.4 9052.9 9164.9 9226.6 9409.2 9149.6 12513.5 12735.2 12964.3 13007.0 11112.7 11283.9 11500.3 11585.9 11725.9 10967.2 11256.5 11343.9 11394.7 11544.0 11602.5 11694.3 11708.2 11750.4 11846.0 9053.2 9078.9 9200.2 9209.8 9317.1 10262.8 11517.6 11755.7 11761.1 11933.9 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | [#3] mootools.html Cycles:180 Average:6362.16 Median:2768.28 stddev:3733.77 (134.9%) stddev-sans-first:3726.83 11:44:22 INFO - PROCESS | 21526 | Values: 1562.7 1590.8 1801.9 1833.7 1885.2 8712.9 9506.6 9557.5 10164.9 10188.2 9518.5 9713.0 9746.4 9851.5 9878.7 2494.8 2522.3 2529.6 2538.9 2542.9 2412.6 2526.0 2531.2 2542.3 2542.9 2515.1 2533.1 2599.1 2601.4 2608.1 2401.8 2410.0 2413.9 2436.5 2449.5 2408.0 2425.1 2426.1 2436.6 2497.9 9710.6 9714.6 9779.5 9794.9 9824.8 5804.2 5950.0 5954.9 5966.2 5972.8 3630.6 3751.1 3764.0 3794.4 3821.5 1130.2 1148.6 1175.1 1197.1 1200.9 14064.3 14072.4 14127.7 14141.3 14158.6 5032.3 5058.5 5140.8 5167.2 5179.4 11636.5 11652.8 11704.0 11762.0 11766.5 5870.0 5884.5 5956.0 5963.7 5965.3 4683.1 5270.6 5449.0 5461.2 5467.6 4439.3 4452.1 4484.9 4524.0 4539.9 1384.4 1390.9 1395.4 1418.1 1431.7 901.3 905.8 929.6 942.3 948.4 6346.1 6543.4 6564.8 6572.7 6609.2 503.9 503.9 504.3 514.3 516.0 4390.4 4433.4 4494.2 4558.8 4565.2 12143.6 12497.8 12517.9 12566.4 12611.4 11995.6 12351.3 12363.7 12368.4 12369.7 9007.3 9166.8 9306.9 9316.7 9431.2 6280.8 6296.3 6340.8 6440.5 6504.9 10488.0 10876.5 11399.5 11422.7 11456.4 11007.4 11196.9 11211.2 11222.8 11313.3 7737.9 8438.0 8564.8 8666.3 8886.2 8866.7 9164.8 9195.5 9197.4 9204.6 7856.1 7908.0 7922.6 7991.6 8247.1 7707.8 7949.2 8086.9 8234.3 8251.8 7093.7 7196.0 7201.5 7593.8 7636.1 5129.5 5212.6 5377.2 5430.1 5434.8 5256.3 5289.9 5435.3 5512.1 5552.9 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | [#4] prototype.html Cycles:180 Average:4885.83 Median:5421.43 stddev:1407.20 (26.0%) stddev-sans-first:1369.51 11:44:22 INFO - PROCESS | 21526 | Values: 359.0 359.3 362.1 365.7 366.9 5645.4 5696.1 5720.8 5736.2 5740.1 5509.0 5611.5 5620.9 5624.7 5638.9 4387.4 4391.8 4403.2 4435.4 4472.1 4440.3 4458.3 4460.5 4500.3 4507.5 4470.4 4478.2 4482.1 4488.1 4499.8 4299.6 4395.5 4404.9 4414.6 4433.4 3947.5 3965.8 3976.3 3979.1 3998.1 5459.5 5516.9 5540.3 5560.4 5566.9 4914.3 5082.7 5086.4 5101.3 5107.9 5893.9 5909.0 5932.6 5967.3 5995.3 4343.0 4366.6 4377.8 4405.2 4405.3 5860.4 5942.2 6162.5 6199.9 6208.0 4365.6 4375.3 4391.0 4396.2 4398.3 4428.6 4429.6 4441.3 4456.6 4471.3 4934.9 5082.8 5089.6 5094.4 5126.5 5906.0 5912.0 5935.5 5960.9 5962.9 1518.8 1544.3 1550.7 1557.8 1566.4 960.5 998.3 1006.5 1006.9 1018.4 5093.6 5135.4 5212.3 5235.5 5264.3 5364.0 5400.6 5429.3 5431.0 5479.2 4827.0 5164.8 5202.8 5234.6 5263.8 2900.4 2913.0 2917.2 2931.8 2943.2 5570.2 5604.7 5616.4 5691.5 5707.2 5096.4 5399.7 5474.0 5475.3 5517.0 5626.9 5669.8 5688.0 5692.3 5701.9 5337.9 5514.7 5528.2 5540.3 5556.7 5283.3 5344.3 5413.6 5449.6 5905.4 6364.4 6420.3 6425.9 6434.7 6438.8 4372.5 4429.3 4432.2 4451.7 4453.6 6102.7 6151.4 6178.2 6187.8 6236.2 5906.3 6007.0 6019.8 6026.9 6034.9 5753.1 5933.5 5984.4 5988.4 5994.8 5835.7 5837.5 5846.8 5861.4 5917.4 5956.8 6051.6 6069.9 6111.9 6115.9 5836.1 5880.4 5908.2 5941.7 5960.5 11:44:22 INFO - PROCESS | 21526 | 11:44:22 INFO - PROCESS | 21526 | [#5] yui.html Cycles:180 Average:21289.52 Median:3968.15 stddev:29756.78 (749.9%) stddev-sans-first:29800.63 11:44:22 INFO - PROCESS | 21526 | Values: 839.6 851.3 878.5 893.5 906.8 13989.7 17298.2 17409.0 17502.0 17519.6 15205.3 15222.8 15245.2 16309.3 16856.4 720.0 845.6 858.4 864.3 877.3 866.8 874.2 874.6 874.8 876.3 904.6 908.2 915.3 915.7 915.9 898.3 899.3 904.9 907.0 907.6 670.1 672.9 674.2 675.8 677.0 15925.6 15999.0 16099.5 16107.7 16122.8 16250.3 16689.1 16713.7 16869.2 16895.9 13279.7 13381.7 13393.5 13507.7 13891.0 4030.5 4098.5 4118.3 4140.8 4256.1 77770.2 79687.2 79861.0 79902.8 79903.0 10824.9 10871.3 11133.6 11296.4 11446.7 23326.8 24624.6 24700.5 24802.1 24808.6 9060.5 9060.8 9088.0 9324.9 9363.0 4822.0 4974.4 5004.4 5057.7 5064.0 3739.3 3759.2 3855.6 3869.7 3905.8 690.5 692.9 714.5 714.8 721.3 735.2 749.0 825.9 847.2 847.3 10241.8 10441.3 10489.1 10520.6 10883.2 592.5 816.7 829.4 848.5 858.4 4804.9 4895.7 4926.3 5018.8 5024.2 70793.0 71423.6 117145.4 117899.0 120005.0 62196.4 103341.0 103871.0 106848.5 107000.0 93071.5 93803.5 93937.0 94524.5 95179.0 9906.0 10012.6 10213.6 10269.6 10509.7 49752.3 52744.9 53231.2 53381.2 57009.7 77979.6 78525.0 78666.6 80645.2 80719.6 13498.6 13570.3 14216.9 14281.6 14565.9 14471.8 14799.7 14970.1 15013.0 15118.5 13770.5 14031.5 14439.6 14963.2 15469.6 13572.7 14101.8 14775.5 14782.1 15137.8 12804.7 13750.3 13810.3 13826.4 14416.3 11286.2 11674.9 11679.0 11712.6 11876.8 11222.0 11271.6 11729.9 11745.3 11835.4 11:44:22 INFO - PROCESS | 21526 | -------- Summary: end -------- 11:44:22 INFO - PROCESS | 21526 | 11:44:23 INFO - TEST-INFO | 21526: exit 0 11:44:23 INFO - TEST-OK | dromaeo_css | took 1110052ms 11:44:23 INFO - TEST-START | kraken 11:44:23 INFO - operating with platform_type : linux_ 11:44:23 INFO - Initialising browser for kraken test... 11:44:23 INFO - TEST-INFO | started process 21769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP4vTK4/profile http://localhost:57078/getInfo.html) 11:44:27 INFO - PROCESS | 21769 | __metrics Screen width/height:1600/1200 11:44:27 INFO - PROCESS | 21769 | colorDepth:24 11:44:27 INFO - PROCESS | 21769 | Browser inner width/height: 1024/697 11:44:27 INFO - PROCESS | 21769 | __metrics 11:44:28 ERROR - PROCESS | 21769 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:44:29 INFO - TEST-INFO | 21769: exit 0 11:44:29 INFO - Browser initialized. 11:44:29 INFO - Running cycle 1/1 for kraken test... 11:44:29 INFO - TEST-INFO | started process 21902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP4vTK4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:41 INFO - PROCESS | 21902 | RSS: Main: 156282880 11:44:41 INFO - PROCESS | 21902 | 11:44:43 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57078/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:44 INFO - PROCESS | 21902 | RSS: Main: 161251328 11:44:44 INFO - PROCESS | 21902 | 11:44:47 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57078/tests/kraken/driver.html?testName=audio-dft) 11:44:47 INFO - PROCESS | 21902 | RSS: Main: 161021952 11:44:47 INFO - PROCESS | 21902 | 11:44:50 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57078/tests/kraken/driver.html?testName=audio-fft) 11:44:51 INFO - PROCESS | 21902 | RSS: Main: 161579008 11:44:51 INFO - PROCESS | 21902 | 11:44:53 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57078/tests/kraken/driver.html?testName=audio-oscillator) 11:44:53 INFO - PROCESS | 21902 | RSS: Main: 160940032 11:44:53 INFO - PROCESS | 21902 | 11:44:56 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57078/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:56 INFO - PROCESS | 21902 | RSS: Main: 161132544 11:44:56 INFO - PROCESS | 21902 | 11:44:59 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57078/tests/kraken/driver.html?testName=imaging-darkroom) 11:45:00 INFO - PROCESS | 21902 | RSS: Main: 160849920 11:45:00 INFO - PROCESS | 21902 | 11:45:03 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57078/tests/kraken/driver.html?testName=imaging-desaturate) 11:45:04 INFO - PROCESS | 21902 | RSS: Main: 161554432 11:45:04 INFO - PROCESS | 21902 | 11:45:07 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57078/tests/kraken/driver.html?testName=json-parse-financial) 11:45:07 INFO - PROCESS | 21902 | RSS: Main: 160907264 11:45:07 INFO - PROCESS | 21902 | 11:45:09 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57078/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:45:10 INFO - PROCESS | 21902 | RSS: Main: 160899072 11:45:10 INFO - PROCESS | 21902 | 11:45:11 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:12 INFO - PROCESS | 21902 | RSS: Main: 161091584 11:45:12 INFO - PROCESS | 21902 | 11:45:14 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:15 INFO - PROCESS | 21902 | RSS: Main: 162217984 11:45:15 INFO - PROCESS | 21902 | 11:45:17 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:18 INFO - PROCESS | 21902 | RSS: Main: 162009088 11:45:18 INFO - PROCESS | 21902 | 11:45:21 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:21 INFO - PROCESS | 21902 | RSS: Main: 161726464 11:45:21 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | Cycle 1(1): loaded http://localhost:57078/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57078/tests/kraken/driver.html?testName=ai-astar) 11:45:23 INFO - PROCESS | 21902 | RSS: Main: 162369536 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | __start_tp_report 11:45:23 INFO - PROCESS | 21902 | _x_x_mozilla_page_load 11:45:23 INFO - PROCESS | 21902 | _x_x_mozilla_page_load_details 11:45:23 INFO - PROCESS | 21902 | |i|pagename|runs| 11:45:23 INFO - PROCESS | 21902 | |0;ai-astar;112;106;112;111;112;113;110;111;112;112 11:45:23 INFO - PROCESS | 21902 | |1;audio-beat-detection;152;127;156;179;126;158;159;125;180;126 11:45:23 INFO - PROCESS | 21902 | |2;audio-dft;162;163;161;162;163;165;165;165;162;164 11:45:23 INFO - PROCESS | 21902 | |3;audio-fft;76;76;77;183;76;76;75;77;164;82 11:45:23 INFO - PROCESS | 21902 | |4;audio-oscillator;86;86;146;86;85;87;142;84;84;146 11:45:23 INFO - PROCESS | 21902 | |5;imaging-gaussian-blur;116;122;117;118;117;117;117;117;117;118 11:45:23 INFO - PROCESS | 21902 | |6;imaging-darkroom;148;148;147;148;147;146;147;147;147;149 11:45:23 INFO - PROCESS | 21902 | |7;imaging-desaturate;96;95;96;96;96;97;95;95;96;95 11:45:23 INFO - PROCESS | 21902 | |8;json-parse-financial;51;51;55;56;52;52;55;64;52;51 11:45:23 INFO - PROCESS | 21902 | |9;json-stringify-tinderbox;58;61;60;60;59;60;60;61;59;60 11:45:23 INFO - PROCESS | 21902 | |10;stanford-crypto-aes;78;76;77;77;79;77;82;77;99;78 11:45:23 INFO - PROCESS | 21902 | |11;stanford-crypto-ccm;121;117;124;130;126;128;132;124;122;126 11:45:23 INFO - PROCESS | 21902 | |12;stanford-crypto-pbkdf2;156;165;161;159;159;153;161;162;155;156 11:45:23 INFO - PROCESS | 21902 | |13;stanford-crypto-sha256-iterative;63;64;62;65;62;63;61;61;62;64 11:45:23 INFO - PROCESS | 21902 | __end_tp_report 11:45:23 INFO - PROCESS | 21902 | __start_cc_report 11:45:23 INFO - PROCESS | 21902 | _x_x_mozilla_cycle_collect,889 11:45:23 INFO - PROCESS | 21902 | __end_cc_report 11:45:23 INFO - PROCESS | 21902 | __startTimestamp1469645123544__endTimestamp 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | ------- Summary: start ------- 11:45:23 INFO - PROCESS | 21902 | Number of tests: 14 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:1.97 (1.8%) stddev-sans-first:2.06 11:45:23 INFO - PROCESS | 21902 | Values: 112.0 106.0 112.0 111.0 112.0 113.0 110.0 111.0 112.0 112.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:157.00 stddev:21.65 (13.8%) stddev-sans-first:22.93 11:45:23 INFO - PROCESS | 21902 | Values: 152.0 127.0 156.0 179.0 126.0 158.0 159.0 125.0 180.0 126.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.48 (0.9%) stddev-sans-first:1.50 11:45:23 INFO - PROCESS | 21902 | Values: 162.0 163.0 161.0 162.0 163.0 165.0 165.0 165.0 162.0 164.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#3] audio-fft Cycles:10 Average:96.20 Median:76.00 stddev:41.03 (54.0%) stddev-sans-first:42.86 11:45:23 INFO - PROCESS | 21902 | Values: 76.0 76.0 77.0 183.0 76.0 76.0 75.0 77.0 164.0 82.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.50 stddev:28.65 (33.5%) stddev-sans-first:29.70 11:45:23 INFO - PROCESS | 21902 | Values: 86.0 86.0 146.0 86.0 85.0 87.0 142.0 84.0 84.0 146.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.65 (1.4%) stddev-sans-first:1.64 11:45:23 INFO - PROCESS | 21902 | Values: 116.0 122.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 11:45:23 INFO - PROCESS | 21902 | Values: 148.0 148.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 149.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:45:23 INFO - PROCESS | 21902 | Values: 96.0 95.0 96.0 96.0 96.0 97.0 95.0 95.0 96.0 95.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.50 stddev:4.01 (7.5%) stddev-sans-first:4.12 11:45:23 INFO - PROCESS | 21902 | Values: 51.0 51.0 55.0 56.0 52.0 52.0 55.0 64.0 52.0 51.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.71 11:45:23 INFO - PROCESS | 21902 | Values: 58.0 61.0 60.0 60.0 59.0 60.0 60.0 61.0 59.0 60.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:78.00 stddev:6.88 (8.8%) stddev-sans-first:7.26 11:45:23 INFO - PROCESS | 21902 | Values: 78.0 76.0 77.0 77.0 79.0 77.0 82.0 77.0 99.0 78.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.00 stddev:4.42 (3.5%) stddev-sans-first:4.45 11:45:23 INFO - PROCESS | 21902 | Values: 121.0 117.0 124.0 130.0 126.0 128.0 132.0 124.0 122.0 126.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:160.00 stddev:3.68 (2.3%) stddev-sans-first:3.77 11:45:23 INFO - PROCESS | 21902 | Values: 156.0 165.0 161.0 159.0 159.0 153.0 161.0 162.0 155.0 156.0 11:45:23 INFO - PROCESS | 21902 | 11:45:23 INFO - PROCESS | 21902 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.41 11:45:23 INFO - PROCESS | 21902 | Values: 63.0 64.0 62.0 65.0 62.0 63.0 61.0 61.0 62.0 64.0 11:45:23 INFO - PROCESS | 21902 | -------- Summary: end -------- 11:45:23 INFO - PROCESS | 21902 | 11:45:24 INFO - TEST-INFO | 21902: exit 0 11:45:24 INFO - TEST-OK | kraken | took 60912ms 11:45:24 INFO - SUITE-END | took 1170s 11:45:24 INFO - Completed test suite (00:19:31) 11:45:24 INFO - javascript benchmark 11:45:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7635.037676471601, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.584051993501, 3356.899293021209, 3379.9324013519713, 3401.4217583010886, 3407.693307602315, 5600.047991841387, 5602.35572909115, 5674.177244299574, 5678.063119585268, 5740.995325817986, 5684.687342196177, 5693.3452652944925, 5736.541076713864, 5739.51214146797, 5760.135979603062, 5153.381594208691, 5165.04446677364, 5222.0, 5245.2132180173085, 5278.181881808326, 5068.72122033288, 5083.0, 5258.763355649005, 5278.630495865291, 5279.9208011879855, 5078.263651770491, 5179.948200517984, 5182.119039763231, 5196.948030519703, 5198.532132108109, 5208.8437346879655, 5214.426413094557, 5279.973600132013, 5283.577313814885, 5283.603729720248, 5147.459516750762, 5181.274621552986, 5256.0, 5262.947370526284, 5288.365396152448, 5376.274202982587, 5489.368722596912, 5530.087535556629, 5577.609567330289, 5646.040173170571, 6083.452489275986, 6126.846828829271, 6147.631142131441, 6157.138000679908, 6161.7227224775, 5932.525397968152, 6171.969140154315, 6178.660173690445, 6187.257529096492, 6188.628682279078, 5637.408072152447, 5705.62913410627, 5721.971390143022, 5769.336526299446, 5779.739911704026, 6306.684665766693, 6308.621482710961, 6319.46284565817, 6322.430981211713, 6324.9051264231075, 5720.313562372542, 5879.588428810028, 6031.9396806032255, 6033.3966603340195, 6065.75736970525, 6048.455638992512, 6167.198264225622, 6168.629882207082, 6170.876582468325, 6171.413715697002, 6061.696915154313, 6122.724477398528, 6140.416660417253, 6147.0779383092895, 6151.2618485781995, 5850.678212698257, 6005.489533389711, 6060.999935010762, 6146.78486252979, 6147.846303842351, 4670.8365207217585, 4671.089137618132, 4687.95312046882, 4695.3426520287185, 4718.363020992122, 4132.669386449077, 4158.688098392633, 4168.708190426702, 4194.832206711697, 4203.642690371353, 5861.41385861419, 5875.853103672357, 5915.467607915222, 5915.970420147872, 5924.526037917042, 5914.970425147847, 6060.787872424444, 6126.239477547061, 6152.938470615326, 6153.7230824613, 5972.163897054415, 5992.64044157352, 5996.4603185713495, 5998.910016349758, 6005.819825405245, 4832.347633069561, 4838.903221935541, 4853.247746599282, 4890.755462226874, 4903.117438860968, 6313.43179113882, 6392.360763923571, 6396.616203027833, 6398.232212134573, 6404.071409645669, 6132.5400594956445, 6132.627792144284, 6150.261968563801, 6165.938340616536, 6180.196574445294, 6132.630864714964, 6198.163247961648, 6309.842253943504, 6327.082573026977, 6426.4537514311805, 5991.580589358703, 6007.87984240304, 6019.789307374221, 6022.126791615279, 6039.214902062704, 5891.941080589139, 6113.23584551931, 6119.602225855305, 6123.326434092157, 6144.324124346408, 5887.205227294432, 5931.6441013539325, 5985.820425387245, 6000.609960352563, 6010.579259451796, 5922.407759224043, 5961.7615295387695, 5977.671228082323, 6005.759769609342, 6018.7291571878495, 5677.971610141923, 5766.394528574439, 5799.362070172193, 5808.041673123887, 5809.331926828469, 5990.580659353804, 6087.847803804941, 6098.451139397475, 6100.23747031621, 6131.509479241739, 5882.588218824641, 5899.38056504078, 5905.881882362242, 5922.170896074639, 5945.554083443845], "value": 5629.192764497435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5913880714097, 647.8412788866727, 658.6871236162821, 660.5607271164674, 665.3612531969309, 43251.56748432515, 45021.0, 45024.0, 45025.77487112564, 49003.50996490034, 46357.30464043042, 46787.298190527166, 46805.531944680544, 47016.29475557861, 47107.0, 8663.350248731338, 8834.072422395653, 8915.509646969414, 8922.152395522415, 8935.55322233889, 8874.15695508929, 8943.910560894405, 8985.05656906022, 9045.547722613876, 9050.77373065672, 8981.461112333249, 9071.092890710943, 9071.59177836999, 9077.0, 9107.499087550183, 8973.282137429023, 9006.189442950134, 9019.458832470073, 9024.593893274785, 9057.0, 8684.305255579538, 8705.260052895512, 8759.080296568833, 8855.291576673852, 8877.911220887772, 44497.77751111256, 44650.55349446496, 44686.0, 44886.0, 44964.325535117, 3796.8101594920145, 3893.3186692329014, 4033.616806403387, 4062.5328087270045, 4511.939694171867, 33705.831470842735, 33870.49194262088, 34229.0, 34465.31069378623, 34597.481037784455, 4571.291449825282, 4681.46163191234, 4703.6942598730975, 4735.956007610978, 4841.830535931225, 369919.0, 371156.0, 373178.0, 374698.3795243073, 379223.0, 61301.0, 61619.38380616226, 62283.68858155771, 62298.0, 62364.688176558826, 38562.421563676005, 39247.60752392497, 39552.80223598864, 41366.37950430746, 41677.37483937744, 18990.335338263372, 19197.136128874234, 19208.423747287605, 19232.519187020436, 19233.711494327596, 14563.854361456462, 14649.0, 14676.119432834064, 14714.852851471349, 14762.630934226516, 20378.59242815165, 20400.795992040188, 20558.58882822335, 20678.276260331117, 20773.584528309348, 7404.370628496638, 7438.66526006331, 7445.590492522855, 7473.4021278297605, 7476.775696729107, 1121.3440137519478, 1159.913006524514, 1214.7388311513066, 1247.650657815813, 1263.7662032524013, 31719.365612687616, 31919.20201994922, 32631.184220394207, 33053.17367065795, 33378.66621333756, 1165.7143999719954, 1182.1134149387958, 1193.4390836306923, 1220.2251570252954, 1238.993805030987, 17086.658266834595, 17227.22477488516, 17295.827041729674, 17360.21879015422, 17412.303507859797, 467449.0, 468436.0, 470489.0, 472479.0, 473219.0, 58360.70819645959, 58375.0, 58420.7078964611, 58517.707411463525, 58612.41387586155, 1471.3599584180915, 1481.5111013365563, 1503.6090616439803, 1513.1828812441158, 1514.6970605878648, 31176.376472470878, 31422.528662070545, 31528.527072094395, 31774.682253178096, 32452.83773581117, 50986.23520647119, 51616.48383516117, 51787.223191652905, 51829.0, 51947.74026129845, 373234.0, 375733.0, 378592.0, 379433.0, 381048.0, 29043.85478072596, 29084.563731544466, 29180.124596262147, 29371.853140734158, 29385.706142938296, 48214.27678584894, 49412.0, 49447.0, 49473.50526494689, 49825.50174498209, 40152.39771403373, 40937.38593921034, 41258.38112428256, 42037.108330125826, 42214.366784497644, 41693.58306416897, 41983.0, 42106.7894660537, 42181.78909105435, 42532.1493570133, 43604.34593481164, 44676.32985505155, 44876.326855097854, 45207.32189017233, 47914.0, 38531.28557448486, 38634.0, 38981.41527877028, 39144.80427597844, 39375.80312098421, 29860.850695746383, 30224.69775302219, 30285.697143028287, 30423.54364684576, 30603.06480472573], "value": 20734.094355659803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.55870392106243, 433.84381622615865, 435.51657659997403, 440.6871121503732, 444.96217821485175, 19704.802951970494, 19995.800041999577, 20602.0, 21049.0, 21056.89471552644, 19613.901930490327, 19787.802121978777, 19797.802021979776, 19985.60028799423, 20000.899995500004, 5779.248697669308, 6004.219451471303, 6036.577439579231, 6042.486388656969, 6090.147379366892, 5689.573282003846, 5938.673372964486, 5959.344472108065, 5985.760569577234, 5993.910091348634, 5886.352501224862, 5906.61606995546, 5922.378150294222, 5944.227250457435, 5961.344252132262, 5734.655920644754, 5863.706814659271, 5902.173695682608, 5905.29136503618, 5908.49777768888, 5254.08053590624, 5272.446393128705, 5286.02208591408, 5290.365156181283, 5306.044911915854, 23214.41963950898, 23355.182568610187, 23833.642495362583, 23965.40086497834, 24031.279061628004, 2220.611393006234, 2374.584447721659, 2415.130553000918, 2547.681539807524, 2707.553253713135, 10469.267151299413, 10542.894571054268, 10687.679369618847, 11038.11695064401, 12024.819627705592, 2009.6985452182143, 2043.1725151313742, 2089.341857314941, 2114.1754715660904, 2127.755308139568, 76883.61558192229, 78390.21609783944, 78468.21531784667, 80034.0, 81035.0, 11683.474243659055, 11711.414429278502, 11774.823377649342, 11985.700357491132, 11996.760064798655, 16662.166891655612, 16674.416395426102, 16878.324867005427, 16928.661426771643, 16930.576735581708, 8855.33584981129, 8865.778355541162, 8981.236594889508, 9028.413153145024, 9073.13805188506, 8545.051957074798, 8581.0, 8725.127487251351, 8786.384953053224, 8837.027926928033, 5108.591312694975, 5124.615653825978, 5171.0, 5171.689698618095, 5185.688858668492, 2117.3965419855267, 2159.5788821180035, 2167.674848772697, 2184.14818220894, 2200.8349373797028, 1027.1885210683477, 1049.7690508088208, 1051.1748277602198, 1103.5309993252836, 1125.0156113400774, 18515.35196268124, 19401.0, 19475.220991160477, 19716.0, 19767.802321976884, 1036.18659352408, 1062.675883855416, 1064.6007747094839, 1091.6779550032759, 1101.4382664840828, 10711.143108551452, 10928.945355273172, 10947.945260273807, 10952.452377381258, 10983.61557345489, 564750.0, 576275.0, 581887.0, 587187.0, 605583.0, 92516.53741731249, 94829.0, 96149.51925240469, 96254.0, 96381.51809240908, 1057.4659796802566, 1067.0, 1071.8231491803922, 1084.5444913136503, 1095.9232853700164, 17169.656606868044, 17217.139143042546, 17217.483475495756, 17265.13674316254, 17451.650966980844, 40671.38992915049, 40802.79598601988, 41165.58834411618, 41316.586834132475, 42043.369349460394, 54787.17819232635, 56569.71715141398, 57020.0, 57171.71414143069, 57886.4211357881, 9021.413608115452, 9052.864207036768, 9164.862527061967, 9226.584803683716, 9409.200217981548, 9149.5882685278, 12513.499460021498, 12735.23588584688, 12964.28696421668, 13007.0, 11112.722181945515, 11283.943580282046, 11500.309981401142, 11585.88414115848, 11725.88274117248, 10967.177461690246, 11256.549738010715, 11343.886561134283, 11394.658160255205, 11544.0, 11602.535898563963, 11694.2983420995, 11708.238964467282, 11750.35373054456, 11846.0, 9053.185213330831, 9078.863817042618, 9200.21798147165, 9209.815803683754, 9317.068293170629, 10262.794744105226, 11517.596884109016, 11755.706107347385, 11761.117916156152, 11933.940330298294], "value": 9582.460882999956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1562.6562156325604, 1590.7772911792347, 1801.9279228830846, 1833.697439922413, 1885.2270569066686, 8712.869306960401, 9506.572204250826, 9557.474338911366, 10164.898351016478, 10188.184945204384, 9518.5240737963, 9713.0, 9746.366486178393, 9851.458169800659, 9878.654247101353, 2494.750524947509, 2522.268542122782, 2529.633203185537, 2538.885750141248, 2542.936426589341, 2412.601920683085, 2525.9873700631565, 2531.227975467482, 2542.2627438042946, 2542.872856357184, 2515.0819950717946, 2533.100749234023, 2599.116300457844, 2601.3626661467965, 2608.100205429124, 2401.7838394544488, 2409.975900240993, 2413.9155129570468, 2436.4517983453757, 2449.461118553915, 2407.9879600601885, 2425.0663494554547, 2426.065964603623, 2436.5979613363775, 2497.900083996638, 9710.61157553697, 9714.562844671937, 9779.51102444875, 9794.853077203848, 9824.754381140458, 5804.245448091763, 5950.0, 5954.880902381971, 5966.194563733884, 5972.790952316648, 3630.6369363063745, 3751.137238435148, 3763.9623603763885, 3794.4498047782918, 3821.522309711286, 1130.22014809781, 1148.5692865175558, 1175.1069187417538, 1197.0961923747602, 1200.8739082396398, 14064.2967851607, 14072.437102515887, 14127.717445651133, 14141.292935353295, 14158.575242742734, 5032.295478632995, 5058.519440653132, 5140.820071297561, 5167.22491626259, 5179.352580927384, 11636.476358563885, 11652.76694466106, 11704.0, 11762.0, 11766.52933882635, 5870.0, 5884.499817515559, 5956.0, 5963.731632076567, 5965.343812180657, 4683.086798074342, 5270.631055826056, 5448.972755136199, 5461.2354270402175, 5467.5625949923915, 4439.334099884978, 4452.131834292347, 4484.887877803081, 4523.95476045242, 4539.909201815945, 1384.3977869626744, 1390.860913908601, 1395.3790563199482, 1418.0782491380685, 1431.6778724786839, 901.3285102598606, 905.76902889764, 929.5677509957767, 942.2838642631513, 948.4214629076258, 6346.11154438379, 6543.411093001652, 6564.8358791030605, 6572.737090516326, 6609.206895172514, 503.88158782686037, 503.9042581909425, 504.2562220724402, 514.3493480746858, 515.9819406320836, 4390.385346051556, 4433.357163211316, 4494.213512635276, 4558.772061396917, 4565.178267911808, 12143.635690929286, 12497.75004499905, 12517.874821251853, 12566.371681415892, 12611.369431528386, 11995.580154694544, 12351.25892446438, 12363.6909077272, 12368.381580920917, 12369.690757731129, 9007.279417646703, 9166.770830729152, 9306.906930930603, 9316.720498384924, 9431.245500359955, 6280.823252537011, 6296.2759282681245, 6340.809775706736, 6440.549161558646, 6504.869902602016, 10488.00363965422, 10876.45617719095, 11399.487023084146, 11422.657320280405, 11456.427178640868, 11007.449627518752, 11196.88803111991, 11211.159163062966, 11222.831657524981, 11313.264637798517, 7737.92262077372, 8438.0, 8564.785880353042, 8666.263367613823, 8886.24466920319, 8866.73399798007, 9164.816703665756, 9195.528715405502, 9197.402168859002, 9204.631814727336, 7856.135825059353, 7907.9604601976625, 7922.643481043482, 7991.640376183202, 8247.051589067094, 7707.807304817425, 7949.244821741925, 8086.8786968194345, 8234.300084492885, 8251.793705157419, 7093.680784364819, 7196.0285361475535, 7201.531900426456, 7593.810154746176, 7636.08366995964, 5129.461406552407, 5212.635115541876, 5377.166539186433, 5430.13117901134, 5434.809781657623, 5256.264123022704, 5289.8677533060445, 5435.347758269033, 5512.062949298549, 5552.888942221214], "value": 4958.688725188208, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.9802560859152, 359.2921943770771, 362.0550363551131, 365.74946161879114, 366.88993302009396, 5645.350784659765, 5696.060150075233, 5720.770034442594, 5736.22560954271, 5740.052891272935, 5508.980838544862, 5611.523020543259, 5620.943790562093, 5624.662520248788, 5638.9004144191895, 4387.407699960512, 4391.836163416697, 4403.229434848889, 4435.401220835178, 4472.12793505265, 4440.289553671413, 4458.264386376244, 4460.4647442306805, 4500.34744961982, 4507.520863525048, 4470.351798989144, 4478.216312145378, 4482.148391805546, 4488.0799436115685, 4499.842505512308, 4299.570042995707, 4395.516493185747, 4404.867853964386, 4414.646828253732, 4433.379326894221, 3947.50656167979, 3965.8413663453425, 3976.264391087629, 3979.1245925896255, 3998.0604557928864, 5459.535939445152, 5516.862078448071, 5540.335159780811, 5560.4161563035705, 5566.882545774339, 4914.262860570907, 5082.720450375228, 5086.415062267813, 5101.2603172539775, 5107.850733584951, 5893.911591326134, 5909.0, 5932.597298094279, 5967.254093238345, 5995.250593675791, 4342.978285108554, 4366.6070053695, 4377.824887004516, 4405.229084910128, 4405.273129933557, 5860.443257890493, 5942.2275104236605, 6162.476189523896, 6199.915014872425, 6207.968960155215, 4365.628921541705, 4375.293635482164, 4390.956090439055, 4396.1647287016, 4398.3402489626815, 4428.623566996777, 4429.55704429561, 4441.289393697058, 4456.6211871991245, 4471.306947423154, 4934.8766280843265, 5082.847514574495, 5089.567386772092, 5094.363204599425, 5126.487351264844, 5906.0, 5911.965406053923, 5935.495482883917, 5960.910586341209, 5962.869493515939, 1518.8305005145976, 1544.274191130167, 1550.674173581594, 1557.766335049729, 1566.4204244429634, 960.4765402855461, 998.3161534348994, 1006.5420233793607, 1006.9144122749502, 1018.3737001743874, 5093.617978651616, 5135.35808023997, 5212.3223980883, 5235.528802407725, 5264.289320941701, 5363.973180134074, 5400.6498375406145, 5429.267048948342, 5431.0, 5479.205515200274, 4826.95173048272, 5164.837911469965, 5202.81790137351, 5234.607404444682, 5263.763130659053, 2900.448914706199, 2912.9513375184915, 2917.197770613056, 2931.750801181881, 2943.234758962685, 5570.248016517799, 5604.6917419542315, 5616.382197958222, 5691.516221121251, 5707.200991861143, 5096.413912400048, 5399.730013499309, 5474.0, 5475.260839786658, 5516.99999999992, 5626.930883132191, 5669.801556945487, 5688.0, 5692.345380281238, 5701.857453563694, 5337.864854058408, 5514.724263786715, 5528.170774383874, 5540.263075070757, 5556.694381809039, 5283.313169287968, 5344.327836081959, 5413.593980451403, 5449.64577302474, 5905.40945905406, 6364.427201551883, 6420.325865784025, 6425.935740642533, 6434.710438030394, 6438.8390290243115, 4372.497162826316, 4429.269170586817, 4432.180046691373, 4451.732896026248, 4453.576910193527, 6102.694865256808, 6151.3541078186145, 6178.196834411498, 6187.752489900354, 6236.158118653923, 5906.320773111147, 6007.008843540767, 6019.759209631741, 6026.909596356146, 6034.909476357946, 5753.079507278815, 5933.495652869555, 5984.371640977634, 5988.443004818866, 5994.760209591567, 5835.708214589169, 5837.474627283565, 5846.766129354778, 5861.35525092248, 5917.372722501346, 5956.761729530944, 6051.636901785907, 6069.9089513656445, 6111.877762444815, 6115.908261376172, 5836.095405212199, 5880.382559831156, 5908.172855800105, 5941.673207973603, 5960.5231581474245], "value": 4442.489180402228, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.5550358310094, 851.3104385447788, 878.5387671472477, 893.5487578772721, 906.7869050773071, 13989.720205595882, 17298.221580028898, 17409.04250266235, 17502.0, 17519.64960700787, 15205.315760790763, 15222.847771522282, 15245.161516116608, 16309.266083026263, 16856.410025649104, 719.9964000180019, 845.5898889038842, 858.4034096303056, 864.269692110169, 877.33322674767, 866.7919699272193, 874.191372979991, 874.567089290802, 874.8119154381807, 876.3208513402133, 904.6245807989676, 908.2325435007408, 915.2860768600502, 915.693242763675, 915.8671992561075, 898.2589363774912, 899.2715900120891, 904.9457032578066, 906.9954650226773, 907.5507623726231, 670.0686046395514, 672.9495287853431, 674.197704731368, 675.8040168351172, 677.0, 15925.601859953595, 15999.0, 16099.517014489584, 16107.677846443123, 16122.83877161225, 16250.268737906705, 16689.08210048447, 16713.665726685518, 16869.15654217284, 16895.91552042244, 13279.734405311936, 13381.66545836352, 13393.464261429532, 13507.729845403037, 13891.0, 4030.536488303824, 4098.549159592442, 4118.279301122292, 4140.834366625331, 4256.08494173751, 77770.22229777687, 79687.20312796856, 79861.0, 79902.80145797876, 79903.0, 10824.891751082389, 10871.347719136877, 11133.610323638795, 11296.37869917146, 11446.656600302003, 23326.7667323328, 24624.630630540556, 24700.5059898801, 24802.131925382524, 24808.627870581957, 9060.501672408082, 9060.773480662905, 9087.954560227157, 9324.90675093254, 9362.95318523403, 4821.975890120597, 4974.427940786783, 5004.399472063303, 5057.671251368649, 5063.974680126649, 3739.270842185748, 3759.154190307214, 3855.575886652466, 3869.6517313441927, 3905.7656540607654, 690.4890381117937, 692.9376356127973, 714.4998501049182, 714.8498815248752, 721.2679130682361, 735.2023054985401, 748.9962550187323, 825.9132791056973, 847.1993965702352, 847.3136759225048, 10241.795164096677, 10441.32131411471, 10489.059851091059, 10520.631777887891, 10883.18376121794, 592.4970226280236, 816.7263966571146, 829.3738227638215, 848.5290663681593, 858.429144618834, 4804.903901921942, 4895.653695233839, 4926.3349447824085, 5018.774155163026, 5024.221245706921, 70793.0, 71423.64288178526, 117145.41427292809, 117899.0, 120005.0, 62196.37803621906, 103341.0, 103871.0, 106848.46575767071, 107000.0, 93071.53464232635, 93803.53098234601, 93937.0, 94524.52737736405, 95178.99999999862, 9906.0, 10012.64955726546, 10213.642522511676, 10269.589216431259, 10509.737256568647, 49752.25371619356, 52744.89020439139, 53231.20153197783, 53381.19928201158, 57009.714951424976, 77979.61010194913, 78525.0, 78666.6066669663, 80645.19354806376, 80719.59640201762, 13498.59504214875, 13570.321483925567, 14216.857831421554, 14281.571552853431, 14565.85434145645, 14471.78292325637, 14799.704005920037, 14970.101793892401, 15013.0, 15118.470853520514, 13770.518031868836, 14031.508897188549, 14439.639009024859, 14963.177025263714, 15469.613259668598, 13572.689113333385, 14101.788473172706, 14775.519990409673, 14782.113073215642, 15137.848621513644, 12804.69282979004, 13750.312484375541, 13810.309484525935, 13826.37781299864, 14416.279186040865, 11286.153538484483, 11674.94162529182, 11679.0, 11712.590059347882, 11876.762464750484, 11222.004632344888, 11271.557965587199, 11729.882701172879, 11745.295282282748, 11835.408229588658], "value": 8039.409589121185, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 111.0, 112.0, 113.0, 110.0, 111.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 156.0, 179.0, 126.0, 158.0, 159.0, 125.0, 180.0, 126.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 163.0, 165.0, 165.0, 165.0, 162.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 183.0, 76.0, 76.0, 75.0, 77.0, 164.0, 82.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 146.0, 86.0, 85.0, 87.0, 142.0, 84.0, 84.0, 146.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 149.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 55.0, 56.0, 52.0, 52.0, 55.0, 64.0, 52.0, 51.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0, 61.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 77.0, 79.0, 77.0, 82.0, 77.0, 99.0, 78.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 124.0, 130.0, 126.0, 128.0, 132.0, 124.0, 122.0, 126.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 161.0, 159.0, 159.0, 153.0, 161.0, 162.0, 155.0, 156.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 65.0, 62.0, 63.0, 61.0, 61.0, 62.0, 64.0], "value": 62.7, "unit": "score"}]}]} 11:45:24 INFO - Return code: 0 11:45:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:24 ERROR - # TBPL SUCCESS # 11:45:24 INFO - Running post-action listener: _resource_record_post_action 11:45:24 INFO - ##### 11:45:24 INFO - ##### Finished run-tests step (success) 11:45:24 INFO - ##### 11:45:24 INFO - Running post-run listener: _resource_record_post_run 11:45:24 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520818688; Read time: 12; Write time: 439128 11:45:24 INFO - TinderboxPrint: CPU usage
13.4% 11:45:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:45:24 INFO - TinderboxPrint: I/O write bytes / time
520,818,688 / 439,128 11:45:24 INFO - TinderboxPrint: CPU idle
8,204.3 (86.6%) 11:45:24 INFO - TinderboxPrint: CPU user
1,218.3 (12.9%) 11:45:24 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 268054528; Read time: 0; Write time: 286732 11:45:24 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252764160; Read time: 12; Write time: 152396 11:45:25 INFO - Running post-run listener: _upload_blobber_files 11:45:25 INFO - Blob upload gear active. 11:45:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:25 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 11:45:25 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'] 11:45:25 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 11:45:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:33 INFO - (blobuploader) - INFO - Done attempting. 11:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:33 INFO - (blobuploader) - INFO - Done attempting. 11:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:34 INFO - (blobuploader) - INFO - Done attempting. 11:45:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:34 INFO - Return code: 0 11:45:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d22dfa8d33e1519affff8f95f65bcbd3bfc32f52a8eeb9f696971d0c2a4184465bb5fd649e0b7bc6036faa94cd7f8ffa682fbfadb2b676e7931b9eb29134661f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b5c6271f076368ba3bf2599bd7e9a04b5d30b444bbbe9e5d751dfd4bd0a8f4a4c282f003212048897f3a5f92a35faef55623c14af923bcdcc92cbe3be1212b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2bfaa0b562d7cf7ae604df15b722d11fc3f3b8915a0b395fa507239bebcfec1e8664c150ccd3e3c7a3a8eb641e3c3c76b2b96f8087d8fcb70b6fa1702b26d3d"} 11:45:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:34 INFO - Contents: 11:45:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d22dfa8d33e1519affff8f95f65bcbd3bfc32f52a8eeb9f696971d0c2a4184465bb5fd649e0b7bc6036faa94cd7f8ffa682fbfadb2b676e7931b9eb29134661f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b5c6271f076368ba3bf2599bd7e9a04b5d30b444bbbe9e5d751dfd4bd0a8f4a4c282f003212048897f3a5f92a35faef55623c14af923bcdcc92cbe3be1212b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2bfaa0b562d7cf7ae604df15b722d11fc3f3b8915a0b395fa507239bebcfec1e8664c150ccd3e3c7a3a8eb641e3c3c76b2b96f8087d8fcb70b6fa1702b26d3d"} 11:45:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:34 INFO - Copying logs to upload dir... 11:45:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.020084 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-27 11:45:34.520665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 11:45:34.523886) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159 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/d22dfa8d33e1519affff8f95f65bcbd3bfc32f52a8eeb9f696971d0c2a4184465bb5fd649e0b7bc6036faa94cd7f8ffa682fbfadb2b676e7931b9eb29134661f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b5c6271f076368ba3bf2599bd7e9a04b5d30b444bbbe9e5d751dfd4bd0a8f4a4c282f003212048897f3a5f92a35faef55623c14af923bcdcc92cbe3be1212b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2bfaa0b562d7cf7ae604df15b722d11fc3f3b8915a0b395fa507239bebcfec1e8664c150ccd3e3c7a3a8eb641e3c3c76b2b96f8087d8fcb70b6fa1702b26d3d"} build_url:https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/U9lGvDzHRSCQ2-g_NHBmAg/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/d22dfa8d33e1519affff8f95f65bcbd3bfc32f52a8eeb9f696971d0c2a4184465bb5fd649e0b7bc6036faa94cd7f8ffa682fbfadb2b676e7931b9eb29134661f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5b5c6271f076368ba3bf2599bd7e9a04b5d30b444bbbe9e5d751dfd4bd0a8f4a4c282f003212048897f3a5f92a35faef55623c14af923bcdcc92cbe3be1212b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2bfaa0b562d7cf7ae604df15b722d11fc3f3b8915a0b395fa507239bebcfec1e8664c150ccd3e3c7a3a8eb641e3c3c76b2b96f8087d8fcb70b6fa1702b26d3d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-27 11:45:34.550595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:45:34.550968) ========= 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=31acecf42b6a79ec49471d4a000001bb-1469643434.28783-1570393159 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004358 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 11:45:34.634559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 11:45:34.634991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 11:45:34.635692) ========= ========= Total master_lag: 0.18 =========