builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1462838313.38 results: success (0) buildid: 20160509140655 builduid: 51fec580243d478c9aa09015fb798427 revision: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.381131) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.381504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.381770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.401682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.401923) ========= 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=920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 16:58:33-- 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% 438M=0s 2016-05-09 16:58:33 (438 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118883 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.529057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.529327) ========= 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=920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009559 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.611768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:33.612061) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 --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 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 --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=920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 16:58:33,920 truncating revision to first 12 chars 2016-05-09 16:58:33,920 Setting DEBUG logging. 2016-05-09 16:58:33,920 attempt 1/10 2016-05-09 16:58:33,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1a31ddc2411f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 16:58:34,219 unpacking tar archive at: mozilla-aurora-1a31ddc2411f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559887 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.180727) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.181003) ========= script_repo_revision: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.181394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.181667) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 16:58:34.187693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-05-09 16:58:34.187955) ========= /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=920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:34 INFO - MultiFileLogger online at 20160509 16:58:34 in /builds/slave/test 16:58:34 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 16:58:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:58:34 INFO - {'append_to_log': False, 16:58:34 INFO - 'base_work_dir': '/builds/slave/test', 16:58:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:58:34 INFO - 'branch': 'Mozilla-Aurora', 16:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:34 INFO - 'config_files': ('talos/linux_config.py',), 16:58:34 INFO - 'default_actions': ('clobber', 16:58:34 INFO - 'read-buildbot-config', 16:58:34 INFO - 'download-and-extract', 16:58:34 INFO - 'populate-webroot', 16:58:34 INFO - 'create-virtualenv', 16:58:34 INFO - 'install', 16:58:34 INFO - 'run-tests'), 16:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:34 INFO - 'download_minidump_stackwalk': True, 16:58:34 INFO - 'download_symbols': 'ondemand', 16:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:34 INFO - 'installer_path': 'installer.exe', 16:58:34 INFO - 'log_level': 'info', 16:58:34 INFO - 'log_name': 'talos', 16:58:34 INFO - 'log_to_console': True, 16:58:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:34 INFO - 'opt_config_files': (), 16:58:34 INFO - 'pip_index': False, 16:58:34 INFO - 'sps_profile': False, 16:58:34 INFO - 'sps_profile_interval': 0, 16:58:34 INFO - 'suite': 'dromaeojs-e10s', 16:58:34 INFO - 'system_bits': '32', 16:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:34 INFO - 'title': 'talos-linux64-ix-053', 16:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:34 INFO - 'use_talos_json': True, 16:58:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:34 INFO - 'work_dir': 'build'} 16:58:34 INFO - ##### 16:58:34 INFO - ##### Running clobber step. 16:58:34 INFO - ##### 16:58:34 INFO - Running pre-action listener: _resource_record_pre_action 16:58:34 INFO - Running main action method: clobber 16:58:34 INFO - rmtree: /builds/slave/test/build 16:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:58:35 INFO - Running post-action listener: _resource_record_post_action 16:58:35 INFO - ##### 16:58:35 INFO - ##### Running read-buildbot-config step. 16:58:35 INFO - ##### 16:58:35 INFO - Running pre-action listener: _resource_record_pre_action 16:58:35 INFO - Running main action method: read_buildbot_config 16:58:35 INFO - Using buildbot properties: 16:58:35 INFO - { 16:58:35 INFO - "project": "", 16:58:35 INFO - "product": "firefox", 16:58:35 INFO - "script_repo_revision": "production", 16:58:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:58:35 INFO - "repository": "", 16:58:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:58:35 INFO - "buildid": "20160509140655", 16:58:35 INFO - "pgo_build": "True", 16:58:35 INFO - "basedir": "/builds/slave/test", 16:58:35 INFO - "buildnumber": 305, 16:58:35 INFO - "slavename": "talos-linux64-ix-053", 16:58:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:58:35 INFO - "platform": "ubuntu64_hw", 16:58:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:58:35 INFO - "branch": "mozilla-aurora", 16:58:35 INFO - "repo_path": "releases/mozilla-aurora", 16:58:35 INFO - "revision": "1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27", 16:58:35 INFO - "stage_platform": "linux64-pgo", 16:58:35 INFO - "builduid": "51fec580243d478c9aa09015fb798427", 16:58:35 INFO - "slavebuilddir": "test" 16:58:35 INFO - } 16:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 16:58:35 INFO - Running post-action listener: _resource_record_post_action 16:58:35 INFO - ##### 16:58:35 INFO - ##### Running download-and-extract step. 16:58:35 INFO - ##### 16:58:35 INFO - Running pre-action listener: _resource_record_pre_action 16:58:35 INFO - Running main action method: download_and_extract 16:58:35 INFO - mkdir: /builds/slave/test/build/tests 16:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:35 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:58:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:58:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:58:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:58:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:58:36 INFO - Downloaded 1361 bytes. 16:58:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 16:58:36 INFO - Using the following test package requirements: 16:58:36 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:58:36 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:58:36 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:58:36 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'jsshell-linux-x86_64.zip'], 16:58:36 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:58:36 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 16:58:36 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:58:36 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:58:36 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:58:36 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 16:58:36 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:58:36 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:36 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:37 INFO - Downloaded 23799958 bytes. 16:58:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:58:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:58:39 INFO - Return code: 0 16:58:39 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:39 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 16:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:58:41 INFO - Downloaded 23799958 bytes. 16:58:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:58:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:58:43 INFO - Return code: 0 16:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:43 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:58:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:58:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:58:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 16:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:58:44 INFO - Downloaded 10840145 bytes. 16:58:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:58:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:58:44 INFO - Return code: 0 16:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:44 INFO - https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:58:46 INFO - Downloaded 62692819 bytes. 16:58:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:58:46 INFO - mkdir: /builds/slave/test/properties 16:58:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:58:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:58:46 INFO - Contents: 16:58:46 INFO - build_url:https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 16:58:46 INFO - Running post-action listener: _resource_record_post_action 16:58:46 INFO - Running post-action listener: set_extra_try_arguments 16:58:46 INFO - ##### 16:58:46 INFO - ##### Running populate-webroot step. 16:58:46 INFO - ##### 16:58:46 INFO - Running pre-action listener: _resource_record_pre_action 16:58:46 INFO - Running main action method: populate_webroot 16:58:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:46 INFO - '--tppagecycles', 16:58:46 INFO - '7'], 16:58:46 INFO - 'tests': ['tsvgm']}}, 16:58:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:58:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:58:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:58:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['damp', 'tps']}, 16:58:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'tests': ['damp', 'tps']}, 16:58:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['dromaeo_dom']}, 16:58:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['a11yr', 16:58:46 INFO - 'ts_paint', 16:58:46 INFO - 'tpaint', 16:58:46 INFO - 'sessionrestore', 16:58:46 INFO - 'sessionrestore_no_auto_restore', 16:58:46 INFO - 'tabpaint']}, 16:58:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:58:46 INFO - 'ts_paint', 16:58:46 INFO - 'tpaint', 16:58:46 INFO - 'sessionrestore', 16:58:46 INFO - 'sessionrestore_no_auto_restore', 16:58:46 INFO - 'tabpaint']}, 16:58:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:58:46 INFO - 'ts_paint', 16:58:46 INFO - 'tpaint', 16:58:46 INFO - 'sessionrestore', 16:58:46 INFO - 'sessionrestore_no_auto_restore', 16:58:46 INFO - 'tabpaint']}, 16:58:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:58:46 INFO - 'ts_paint', 16:58:46 INFO - 'tpaint', 16:58:46 INFO - 'sessionrestore', 16:58:46 INFO - 'sessionrestore_no_auto_restore', 16:58:46 INFO - 'tabpaint']}, 16:58:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['a11yr', 16:58:46 INFO - 'ts_paint', 16:58:46 INFO - 'tpaint', 16:58:46 INFO - 'sessionrestore', 16:58:46 INFO - 'sessionrestore_no_auto_restore', 16:58:46 INFO - 'tabpaint']}, 16:58:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['a11yr', 16:58:46 INFO - 'ts_paint', 16:58:46 INFO - 'tpaint', 16:58:46 INFO - 'sessionrestore', 16:58:46 INFO - 'sessionrestore_no_auto_restore', 16:58:46 INFO - 'tabpaint']}, 16:58:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['tsvgx', 16:58:46 INFO - 'tsvgr_opacity', 16:58:46 INFO - 'tart', 16:58:46 INFO - 'tscrollx', 16:58:46 INFO - 'cart']}, 16:58:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:58:46 INFO - 'tsvgr_opacity', 16:58:46 INFO - 'tart', 16:58:46 INFO - 'tscrollx', 16:58:46 INFO - 'cart']}, 16:58:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'talos_options': ['--disable-e10s'], 16:58:46 INFO - 'tests': ['tp5o']}, 16:58:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'tests': ['tp5o']}, 16:58:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'talos_options': ['--disable-e10s', 16:58:46 INFO - '--xperf_path', 16:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:46 INFO - 'tests': ['tp5n']}, 16:58:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:58:46 INFO - 'talos_options': ['--xperf_path', 16:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:46 INFO - 'tests': ['tp5n']}}, 16:58:46 INFO - 'talos.zip': {'path': '', 16:58:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:46 INFO - Running post-action listener: _resource_record_post_action 16:58:46 INFO - ##### 16:58:46 INFO - ##### Running create-virtualenv step. 16:58:46 INFO - ##### 16:58:46 INFO - Running pre-action listener: _resource_record_pre_action 16:58:46 INFO - Running main action method: create_virtualenv 16:58:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:58:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:58:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:58:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:46 INFO - Using real prefix '/usr' 16:58:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:58:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:49 INFO - Installing pip.................done. 16:58:49 INFO - Return code: 0 16:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:49 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 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:58:49 INFO - Using env: {'DISPLAY': ':0', 16:58:49 INFO - 'HOME': '/home/cltbld', 16:58:49 INFO - 'LANG': 'en_US.UTF-8', 16:58:49 INFO - 'LANGUAGE': 'en_US:en', 16:58:49 INFO - 'LOGNAME': 'cltbld', 16:58:49 INFO - 'MAIL': '/var/mail/cltbld', 16:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:49 INFO - 'MOZ_NO_REMOTE': '1', 16:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:49 INFO - 'NO_EM_RESTART': '1', 16:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:49 INFO - 'PWD': '/builds/slave/test', 16:58:49 INFO - 'SHELL': '/bin/bash', 16:58:49 INFO - 'SHLVL': '1', 16:58:49 INFO - 'TERM': 'linux', 16:58:49 INFO - 'TMOUT': '86400', 16:58:49 INFO - 'USER': 'cltbld', 16:58:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:49 INFO - '_': '/tools/buildbot/bin/python'} 16:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:58:49 INFO - Cleaning up... 16:58:49 INFO - Return code: 0 16:58:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:49 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:58:49 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>=0.7.1'] in /builds/slave/test/build 16:58:49 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>=0.7.1 16:58:49 INFO - Using env: {'DISPLAY': ':0', 16:58:49 INFO - 'HOME': '/home/cltbld', 16:58:49 INFO - 'LANG': 'en_US.UTF-8', 16:58:49 INFO - 'LANGUAGE': 'en_US:en', 16:58:49 INFO - 'LOGNAME': 'cltbld', 16:58:49 INFO - 'MAIL': '/var/mail/cltbld', 16:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:49 INFO - 'MOZ_NO_REMOTE': '1', 16:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:49 INFO - 'NO_EM_RESTART': '1', 16:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:49 INFO - 'PWD': '/builds/slave/test', 16:58:49 INFO - 'SHELL': '/bin/bash', 16:58:49 INFO - 'SHLVL': '1', 16:58:49 INFO - 'TERM': 'linux', 16:58:49 INFO - 'TMOUT': '86400', 16:58:49 INFO - 'USER': 'cltbld', 16:58:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:49 INFO - '_': '/tools/buildbot/bin/python'} 16:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:49 INFO - Downloading/unpacking psutil>=0.7.1 16:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:51 INFO - Installing collected packages: psutil 16:58:51 INFO - Running setup.py install for psutil 16:58:51 INFO - building 'psutil._psutil_linux' extension 16:58:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:58:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:58:52 INFO - building 'psutil._psutil_posix' extension 16:58:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:58:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:52 INFO - Successfully installed psutil 16:58:52 INFO - Cleaning up... 16:58:52 INFO - Return code: 0 16:58:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:52 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:58:52 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.0.0'] in /builds/slave/test/build 16:58:52 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.0.0 16:58:52 INFO - Using env: {'DISPLAY': ':0', 16:58:52 INFO - 'HOME': '/home/cltbld', 16:58:52 INFO - 'LANG': 'en_US.UTF-8', 16:58:52 INFO - 'LANGUAGE': 'en_US:en', 16:58:52 INFO - 'LOGNAME': 'cltbld', 16:58:52 INFO - 'MAIL': '/var/mail/cltbld', 16:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:52 INFO - 'MOZ_NO_REMOTE': '1', 16:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:52 INFO - 'NO_EM_RESTART': '1', 16:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:52 INFO - 'PWD': '/builds/slave/test', 16:58:52 INFO - 'SHELL': '/bin/bash', 16:58:52 INFO - 'SHLVL': '1', 16:58:52 INFO - 'TERM': 'linux', 16:58:52 INFO - 'TMOUT': '86400', 16:58:52 INFO - 'USER': 'cltbld', 16:58:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:52 INFO - '_': '/tools/buildbot/bin/python'} 16:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:58:54 INFO - Installing collected packages: mozsystemmonitor 16:58:54 INFO - Running setup.py install for mozsystemmonitor 16:58:54 INFO - Successfully installed mozsystemmonitor 16:58:54 INFO - Cleaning up... 16:58:54 INFO - Return code: 0 16:58:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:58:54 INFO - Using env: {'DISPLAY': ':0', 16:58:54 INFO - 'HOME': '/home/cltbld', 16:58:54 INFO - 'LANG': 'en_US.UTF-8', 16:58:54 INFO - 'LANGUAGE': 'en_US:en', 16:58:54 INFO - 'LOGNAME': 'cltbld', 16:58:54 INFO - 'MAIL': '/var/mail/cltbld', 16:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:54 INFO - 'MOZ_NO_REMOTE': '1', 16:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:54 INFO - 'NO_EM_RESTART': '1', 16:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:54 INFO - 'PWD': '/builds/slave/test', 16:58:54 INFO - 'SHELL': '/bin/bash', 16:58:54 INFO - 'SHLVL': '1', 16:58:54 INFO - 'TERM': 'linux', 16:58:54 INFO - 'TMOUT': '86400', 16:58:54 INFO - 'USER': 'cltbld', 16:58:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:54 INFO - '_': '/tools/buildbot/bin/python'} 16:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:54 INFO - Downloading/unpacking blobuploader==1.2.4 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:58:57 INFO - Downloading docopt-0.6.1.tar.gz 16:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:57 INFO - Running setup.py install for blobuploader 16:58:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:57 INFO - Running setup.py install for requests 16:58:57 INFO - Running setup.py install for docopt 16:58:57 INFO - Successfully installed blobuploader requests docopt 16:58:57 INFO - Cleaning up... 16:58:57 INFO - Return code: 0 16:58:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:57 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 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:58:57 INFO - Using env: {'DISPLAY': ':0', 16:58:57 INFO - 'HOME': '/home/cltbld', 16:58:57 INFO - 'LANG': 'en_US.UTF-8', 16:58:57 INFO - 'LANGUAGE': 'en_US:en', 16:58:57 INFO - 'LOGNAME': 'cltbld', 16:58:57 INFO - 'MAIL': '/var/mail/cltbld', 16:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:57 INFO - 'MOZ_NO_REMOTE': '1', 16:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:58:57 INFO - 'NO_EM_RESTART': '1', 16:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:57 INFO - 'PWD': '/builds/slave/test', 16:58:57 INFO - 'SHELL': '/bin/bash', 16:58:57 INFO - 'SHLVL': '1', 16:58:57 INFO - 'TERM': 'linux', 16:58:57 INFO - 'TMOUT': '86400', 16:58:57 INFO - 'USER': 'cltbld', 16:58:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:57 INFO - '_': '/tools/buildbot/bin/python'} 16:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:57 INFO - Running setup.py (path:/tmp/pip-jvMB0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:57 INFO - Running setup.py (path:/tmp/pip-PycwGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:58 INFO - Running setup.py (path:/tmp/pip-d3e9Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:58 INFO - Running setup.py (path:/tmp/pip-f8W_Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:58 INFO - Running setup.py (path:/tmp/pip-t9e6hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:58 INFO - Running setup.py (path:/tmp/pip-LYXHv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:58 INFO - Running setup.py (path:/tmp/pip-iOuc9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:58 INFO - Running setup.py (path:/tmp/pip-Oo7tRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:58 INFO - Running setup.py (path:/tmp/pip-4ADQyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:58 INFO - Running setup.py (path:/tmp/pip-TZPUdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:58 INFO - Running setup.py (path:/tmp/pip-7jWBIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:58 INFO - Running setup.py (path:/tmp/pip-6Tllj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:58 INFO - Running setup.py (path:/tmp/pip-FlOAye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:58 INFO - Running setup.py (path:/tmp/pip-mCeqKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:58 INFO - Running setup.py (path:/tmp/pip-bxrKOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:58 INFO - Running setup.py (path:/tmp/pip-LgtLAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:58 INFO - Running setup.py (path:/tmp/pip-93lxYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:58 INFO - Running setup.py install for manifestparser 16:58:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:58 INFO - Running setup.py install for mozcrash 16:58:59 INFO - Running setup.py install for mozdebug 16:58:59 INFO - Running setup.py install for mozdevice 16:58:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Running setup.py install for mozfile 16:58:59 INFO - Running setup.py install for mozhttpd 16:58:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Running setup.py install for mozinfo 16:58:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Running setup.py install for mozInstall 16:58:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Running setup.py install for mozleak 16:58:59 INFO - Running setup.py install for mozlog 16:58:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Running setup.py install for moznetwork 16:58:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:59 INFO - Running setup.py install for mozprocess 16:58:59 INFO - Running setup.py install for mozprofile 16:59:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:59:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:59:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:59:00 INFO - Running setup.py install for mozrunner 16:59:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:59:00 INFO - Running setup.py install for mozscreenshot 16:59:00 INFO - Running setup.py install for moztest 16:59:00 INFO - Running setup.py install for mozversion 16:59:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:59:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:59:00 INFO - Cleaning up... 16:59:00 INFO - Return code: 0 16:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59: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')]} 16:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59: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')]} 16:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:00 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 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:59:00 INFO - Using env: {'DISPLAY': ':0', 16:59:00 INFO - 'HOME': '/home/cltbld', 16:59:00 INFO - 'LANG': 'en_US.UTF-8', 16:59:00 INFO - 'LANGUAGE': 'en_US:en', 16:59:00 INFO - 'LOGNAME': 'cltbld', 16:59:00 INFO - 'MAIL': '/var/mail/cltbld', 16:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:00 INFO - 'MOZ_NO_REMOTE': '1', 16:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:00 INFO - 'NO_EM_RESTART': '1', 16:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:00 INFO - 'PWD': '/builds/slave/test', 16:59:00 INFO - 'SHELL': '/bin/bash', 16:59:00 INFO - 'SHLVL': '1', 16:59:00 INFO - 'TERM': 'linux', 16:59:00 INFO - 'TMOUT': '86400', 16:59:00 INFO - 'USER': 'cltbld', 16:59:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:00 INFO - '_': '/tools/buildbot/bin/python'} 16:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:59:00 INFO - Running setup.py (path:/tmp/pip-D9aZeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:59:00 INFO - Running setup.py (path:/tmp/pip-2cotEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:59:00 INFO - Running setup.py (path:/tmp/pip-JndmsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:59:00 INFO - Running setup.py (path:/tmp/pip-3O9nTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:59:00 INFO - Running setup.py (path:/tmp/pip-jS1ZeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:59:00 INFO - Running setup.py (path:/tmp/pip-HTCzJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:59:01 INFO - Running setup.py (path:/tmp/pip-dYB2Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:59:01 INFO - Running setup.py (path:/tmp/pip-7eNJSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:59:01 INFO - Running setup.py (path:/tmp/pip-DORV99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:59:01 INFO - Running setup.py (path:/tmp/pip-krN7SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:59:01 INFO - Running setup.py (path:/tmp/pip-qOekg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:59:01 INFO - Running setup.py (path:/tmp/pip-37byXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:59:01 INFO - Running setup.py (path:/tmp/pip-EIagpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:59:01 INFO - Running setup.py (path:/tmp/pip-Uwgb_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:01 INFO - Running setup.py (path:/tmp/pip-HZlqEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:59:01 INFO - Running setup.py (path:/tmp/pip-Jh0_sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:59:01 INFO - Running setup.py (path:/tmp/pip-4hM6wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:59:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:03 INFO - Downloading blessings-1.6.tar.gz 16:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:59:03 INFO - Installing collected packages: blessings 16:59:03 INFO - Running setup.py install for blessings 16:59:03 INFO - Successfully installed blessings 16:59:03 INFO - Cleaning up... 16:59:03 INFO - Return code: 0 16:59:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:59:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:03 INFO - Reading from file tmpfile_stdout 16:59:03 INFO - Current package versions: 16:59:03 INFO - argparse == 1.2.1 16:59:03 INFO - blessings == 1.6 16:59:03 INFO - blobuploader == 1.2.4 16:59:03 INFO - docopt == 0.6.1 16:59:03 INFO - manifestparser == 1.1 16:59:03 INFO - mozInstall == 1.12 16:59:03 INFO - mozcrash == 0.17 16:59:03 INFO - mozdebug == 0.1 16:59:03 INFO - mozdevice == 0.48 16:59:03 INFO - mozfile == 1.2 16:59:03 INFO - mozhttpd == 0.7 16:59:03 INFO - mozinfo == 0.9 16:59:03 INFO - mozleak == 0.1 16:59:03 INFO - mozlog == 3.1 16:59:03 INFO - moznetwork == 0.27 16:59:03 INFO - mozprocess == 0.22 16:59:03 INFO - mozprofile == 0.28 16:59:03 INFO - mozrunner == 6.11 16:59:03 INFO - mozscreenshot == 0.1 16:59:03 INFO - mozsystemmonitor == 0.0 16:59:03 INFO - moztest == 0.7 16:59:03 INFO - mozversion == 1.4 16:59:03 INFO - psutil == 3.1.1 16:59:03 INFO - requests == 1.2.3 16:59:03 INFO - wsgiref == 0.1.2 16:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:03 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 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:59:03 INFO - Using env: {'DISPLAY': ':0', 16:59:03 INFO - 'HOME': '/home/cltbld', 16:59:03 INFO - 'LANG': 'en_US.UTF-8', 16:59:03 INFO - 'LANGUAGE': 'en_US:en', 16:59:03 INFO - 'LOGNAME': 'cltbld', 16:59:03 INFO - 'MAIL': '/var/mail/cltbld', 16:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:03 INFO - 'MOZ_NO_REMOTE': '1', 16:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:03 INFO - 'NO_EM_RESTART': '1', 16:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:03 INFO - 'PWD': '/builds/slave/test', 16:59:03 INFO - 'SHELL': '/bin/bash', 16:59:03 INFO - 'SHLVL': '1', 16:59:03 INFO - 'TERM': 'linux', 16:59:03 INFO - 'TMOUT': '86400', 16:59:03 INFO - 'USER': 'cltbld', 16:59:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:03 INFO - '_': '/tools/buildbot/bin/python'} 16:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:59:04 INFO - Cleaning up... 16:59:04 INFO - Return code: 0 16:59:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:04 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 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:59:04 INFO - Using env: {'DISPLAY': ':0', 16:59:04 INFO - 'HOME': '/home/cltbld', 16:59:04 INFO - 'LANG': 'en_US.UTF-8', 16:59:04 INFO - 'LANGUAGE': 'en_US:en', 16:59:04 INFO - 'LOGNAME': 'cltbld', 16:59:04 INFO - 'MAIL': '/var/mail/cltbld', 16:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:04 INFO - 'MOZ_NO_REMOTE': '1', 16:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:04 INFO - 'NO_EM_RESTART': '1', 16:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:04 INFO - 'PWD': '/builds/slave/test', 16:59:04 INFO - 'SHELL': '/bin/bash', 16:59:04 INFO - 'SHLVL': '1', 16:59:04 INFO - 'TERM': 'linux', 16:59:04 INFO - 'TMOUT': '86400', 16:59:04 INFO - 'USER': 'cltbld', 16:59:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:04 INFO - '_': '/tools/buildbot/bin/python'} 16:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:04 INFO - Downloading/unpacking jsonschema 16:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:59:06 INFO - Downloading/unpacking functools32 (from jsonschema) 16:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:59:06 INFO - warning: no files found matching '*.txt' 16:59:06 INFO - no previously-included directories found matching 'build' 16:59:06 INFO - no previously-included directories found matching 'dist' 16:59:06 INFO - no previously-included directories found matching '.git*' 16:59:06 INFO - Installing collected packages: jsonschema, functools32 16:59:06 INFO - Running setup.py install for functools32 16:59:06 INFO - warning: no files found matching '*.txt' 16:59:06 INFO - no previously-included directories found matching 'build' 16:59:06 INFO - no previously-included directories found matching 'dist' 16:59:06 INFO - no previously-included directories found matching '.git*' 16:59:06 INFO - Successfully installed jsonschema functools32 16:59:06 INFO - Cleaning up... 16:59:06 INFO - Return code: 0 16:59:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:06 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 0x7f1ae796df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, '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': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:59:06 INFO - Using env: {'DISPLAY': ':0', 16:59:06 INFO - 'HOME': '/home/cltbld', 16:59:06 INFO - 'LANG': 'en_US.UTF-8', 16:59:06 INFO - 'LANGUAGE': 'en_US:en', 16:59:06 INFO - 'LOGNAME': 'cltbld', 16:59:06 INFO - 'MAIL': '/var/mail/cltbld', 16:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:06 INFO - 'MOZ_NO_REMOTE': '1', 16:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:06 INFO - 'NO_EM_RESTART': '1', 16:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:06 INFO - 'PWD': '/builds/slave/test', 16:59:06 INFO - 'SHELL': '/bin/bash', 16:59:06 INFO - 'SHLVL': '1', 16:59:06 INFO - 'TERM': 'linux', 16:59:06 INFO - 'TMOUT': '86400', 16:59:06 INFO - 'USER': 'cltbld', 16:59:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:06 INFO - '_': '/tools/buildbot/bin/python'} 16:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:06 INFO - Downloading/unpacking flake8 16:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:59:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:59:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:09 INFO - no previously-included directories found matching 'docs/_build' 16:59:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:59:09 INFO - Running setup.py install for pep8 16:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:59:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:59:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:59:09 INFO - no previously-included directories found matching 'docs/_build' 16:59:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:59:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:59:09 INFO - Cleaning up... 16:59:09 INFO - Return code: 0 16:59:09 INFO - Running post-action listener: _resource_record_post_action 16:59:09 INFO - Running post-action listener: _start_resource_monitoring 16:59:09 INFO - Starting resource monitoring. 16:59:09 INFO - ##### 16:59:09 INFO - ##### Running install step. 16:59:09 INFO - ##### 16:59:09 INFO - Running pre-action listener: _resource_record_pre_action 16:59:09 INFO - Running main action method: install 16:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:59:09 INFO - Reading from file tmpfile_stdout 16:59:09 INFO - Detecting whether we're running mozinstall >=1.0... 16:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:59:09 INFO - Reading from file tmpfile_stdout 16:59:09 INFO - Output received: 16:59:09 INFO - Usage: mozinstall [options] installer 16:59:09 INFO - Options: 16:59:09 INFO - -h, --help show this help message and exit 16:59:09 INFO - -d DEST, --destination=DEST 16:59:09 INFO - Directory to install application into. [default: 16:59:09 INFO - "/builds/slave/test"] 16:59:09 INFO - --app=APP Application being installed. [default: firefox] 16:59:09 INFO - mkdir: /builds/slave/test/build/application 16:59:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:59:25 INFO - Reading from file tmpfile_stdout 16:59:25 INFO - Output received: 16:59:25 INFO - /builds/slave/test/build/application/firefox/firefox 16:59:25 INFO - Running post-action listener: _resource_record_post_action 16:59:25 INFO - ##### 16:59:25 INFO - ##### Running run-tests step. 16:59:25 INFO - ##### 16:59:25 INFO - Running pre-action listener: _resource_record_pre_action 16:59:25 INFO - Running main action method: run_tests 16:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:59:25 INFO - Python 2.7.3 16:59:25 INFO - Return code: 0 16:59:25 INFO - grabbing minidump binary from tooltool 16:59: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')]} 16:59:25 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1345410>, '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 0x1346310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13467a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:59:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:59:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:59:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:25 INFO - Return code: 0 16:59:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:59:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:59:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:59:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:59:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:59:26 INFO - Return code: 0 16:59:26 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/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:59:26 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/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:59:26 INFO - Using env: {'DISPLAY': ':0', 16:59:26 INFO - 'HOME': '/home/cltbld', 16:59:26 INFO - 'LANG': 'en_US.UTF-8', 16:59:26 INFO - 'LANGUAGE': 'en_US:en', 16:59:26 INFO - 'LOGNAME': 'cltbld', 16:59:26 INFO - 'MAIL': '/var/mail/cltbld', 16:59:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:59:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:26 INFO - 'MOZ_NO_REMOTE': '1', 16:59:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:26 INFO - 'NO_EM_RESTART': '1', 16:59:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:26 INFO - 'PWD': '/builds/slave/test', 16:59:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:59:26 INFO - 'SHELL': '/bin/bash', 16:59:26 INFO - 'SHLVL': '1', 16:59:26 INFO - 'TERM': 'linux', 16:59:26 INFO - 'TMOUT': '86400', 16:59:26 INFO - 'USER': 'cltbld', 16:59:26 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726', 16:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:26 INFO - '_': '/tools/buildbot/bin/python'} 16:59:26 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/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:59:26 INFO - mozversion application_buildid: 20160509140655 16:59:26 INFO - mozversion application_changeset: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 16:59:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:59:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:26 INFO - mozversion application_name: Firefox 16:59:26 INFO - mozversion application_remotingname: firefox-dev 16:59:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:59:26 INFO - mozversion application_vendor: Mozilla 16:59:26 INFO - mozversion application_version: 48.0a2 16:59:26 INFO - mozversion platform_buildid: 20160509140655 16:59:26 INFO - mozversion platform_changeset: 1a31ddc2411f1bf4b9f6766811b5fb4ff3891c27 16:59:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:59:26 INFO - mozversion platform_version: 48.0a2 16:59:26 INFO - using testdate: 1462838366 16:59:26 INFO - actual date: 1462838366 16:59:26 INFO - starting webserver on 'localhost:35470' 16:59:26 INFO - SUITE-START | Running 2 tests 16:59:26 INFO - TEST-START | dromaeo_css 16:59:26 INFO - operating with platform_type : linux_ 16:59:26 INFO - Initialising browser for dromaeo_css test... 16:59:26 INFO - TEST-INFO | started process 27562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HSpus/profile http://localhost:35470/getInfo.html) 16:59:30 INFO - PROCESS | 27562 | 16:59:30 INFO - PROCESS | 27562 | (process:27643): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:59:30 INFO - PROCESS | 27562 | __metrics Screen width/height:1600/1200 16:59:30 INFO - PROCESS | 27562 | colorDepth:24 16:59:30 INFO - PROCESS | 27562 | Browser inner width/height: 1024/697 16:59:30 INFO - PROCESS | 27562 | __metrics 16:59:31 ERROR - PROCESS | 27562 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:59:32 INFO - TEST-INFO | 27562: exit 0 16:59:32 INFO - Browser initialized. 16:59:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:32 INFO - TEST-INFO | started process 27694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HSpus/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:33 INFO - PROCESS | 27694 | 16:59:33 INFO - PROCESS | 27694 | (process:27763): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:59:43 INFO - PROCESS | 27694 | RSS: Main: 151314432 16:59:43 INFO - PROCESS | 27694 | 17:00:33 INFO - PROCESS | 27694 | 1462838433226 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] 17:02:40 INFO - PROCESS | 27694 | Cycle 1(1): loaded http://localhost:35470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35470/tests/dromaeo/cssquery-ext.html) 17:02:41 INFO - PROCESS | 27694 | RSS: Main: 154447872 17:02:41 INFO - PROCESS | 27694 | 17:05:42 INFO - PROCESS | 27694 | Cycle 1(1): loaded http://localhost:35470/tests/dromaeo/cssquery-ext.html (next: http://localhost:35470/tests/dromaeo/cssquery-jquery.html) 17:05:43 INFO - PROCESS | 27694 | RSS: Main: 152633344 17:05:43 INFO - PROCESS | 27694 | 17:08:45 INFO - PROCESS | 27694 | Cycle 1(1): loaded http://localhost:35470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35470/tests/dromaeo/cssquery-mootools.html) 17:08:45 INFO - PROCESS | 27694 | RSS: Main: 152539136 17:08:45 INFO - PROCESS | 27694 | 17:11:47 INFO - PROCESS | 27694 | Cycle 1(1): loaded http://localhost:35470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35470/tests/dromaeo/cssquery-prototype.html) 17:11:47 INFO - PROCESS | 27694 | RSS: Main: 152244224 17:11:47 INFO - PROCESS | 27694 | 17:14:50 INFO - PROCESS | 27694 | Cycle 1(1): loaded http://localhost:35470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35470/tests/dromaeo/cssquery-yui.html) 17:14:50 INFO - PROCESS | 27694 | RSS: Main: 153731072 17:14:50 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | Cycle 1(1): loaded http://localhost:35470/tests/dromaeo/cssquery-yui.html (next: http://localhost:35470/tests/dromaeo/cssquery-dojo.html) 17:17:52 INFO - PROCESS | 27694 | RSS: Main: 155500544 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | __start_tp_report 17:17:52 INFO - PROCESS | 27694 | _x_x_mozilla_page_load 17:17:52 INFO - PROCESS | 27694 | _x_x_mozilla_page_load_details 17:17:52 INFO - PROCESS | 27694 | |i|pagename|runs| 17:17:52 INFO - PROCESS | 27694 | |0;dojo.html;3256.2673398485335;3324.7672662913596;3343.715784158346;3376.27410106827;3380.188754698873;5305.257263983045;5352.491513306235;5355.656875202436;5361.490658387456;5374.516293533581;5350.30446042015;5359.38367087785;5390.487903649157;5394.083005888999;5395.622306438551;4853.029394121172;4882.536159064884;4890.364252647151;4913.3612630358;4919.926201106986;4800;4868.002059577778;4958.67768595042;4972.154733695263;5013.373328333958;4959.851204463872;4983.078130545842;5005.474425185358;5015.072211640858;5060.038592667382;4981.676191047571;4990.076835785373;5017.046761115376;5024.84925452237;5052.191649336125;4848.733319667417;4868.9756551217015;4958.504149585013;4962.230854217602;4968.850934471971;5294.576433885319;5337.386200586943;5375.381831089436;5382.650127741685;5429.375621803503;5651.971740141273;5684;5754.74103665336;5836.182934389189;5850.707464626794;5839.562032847553;5875.618084824516;5886.7939622113445;5927.525797936155;5962.821115366502;5455.0453670607485;5480.150576660624;5483.8080667176455;5485.945140548583;5490.972545137289;5640.182173584889;5944.256967879015;5962.940370596239;5974.954382982961;5979.671118088547;5444.782208711607;5630.296212973379;5688.857778555569;5742.253507044057;5767.423257674199;5892.646441213541;5897.764089436375;5905.320888097838;5906.881862362815;5917.378675239124;5739.626924249994;5853.09277062056;5868.735906884115;5891.528677705774;5892.911606325909;5719.599628025998;5764.510016648632;5764.827055188351;5773.855653608609;5789.247397838254;4370.956290437055;4406.184855801623;4408.096340250241;4420.911581768347;4438.511763705989;3913.5890731473355;3915.138669492764;3975.5229372475487;3979.2041591681777;3996.3805610130476;5507.394186639466;5547.55619550435;5643.774249030075;5673.063944449203;5707.20099186106;5839.941600584025;5900.468957793819;5909.793157239476;5911.940880591225;5917.993941030035;5496.642718223303;5528.695921724263;5567.47109024642;5600.803971860965;5630.690312032795;4865.1242776300605;4892.046051020017;4933.901321973541;4942.827001054946;4976.0794253063295;6022.18700475439;6078.574499784972;6081.6351018939;6087.452129308295;6089.208402907594;5551.583631227593;5861.296644402699;5900.055991041413;5918.112283157475;5955.553333499918;5970.283565972111;5983.790567330123;5989.981703110395;5998.670073146019;6079.969600151971;5702.144678298288;5713.571482138773;5716.885662286814;5741.311042674905;5763.308402991668;5646.181303710857;5821.621594596338;5821.7089145543405;5856.0630299151935;5924.170616113662;5636.408177141341;5639.971800140973;5654.15187721845;5667.886642267049;5685.545156387562;5584.301962254718;5607.915881261702;5622.606417550732;5626.38109807929;5667.4332566743;5476.424975377528;5516.751746171351;5569.916451253153;5600.43995600453;5643.209950606836;5496.203050557727;5586.581006424616;5590.329160500603;5597.216389705363;5602.887942241214;5409.2427060212385;5425.538829199404;5451.37309209446;5467.589930755289;5468.56251499887 17:17:52 INFO - PROCESS | 27694 | |1;ext.html;602.2111034544747;612.6201754911954;631.1290419221475;633.3666333666333;644.3942693867764;39286.60713392865;39782.40326395106;40087;40117;40288.1942361153;42462;43292;43321;43377;43437.34843977343;8634.309255259595;8765.386422950396;8792.384533082655;8816.8677469838;8835.93968723751;8611.61247743853;8715.825683486326;8761.342899282547;8923.73228803137;9014.86477702835;8932.196102350787;9064.365494415393;9064.818703625957;9070.863937040916;9122.954385228099;9002.594883230271;9015.819683606323;9024.007359190451;9026;9099.454032758056;8830.823383532357;8896.822063558693;8904.73285801427;8921.776955576162;8990.37067405282;43398.349024764655;44096;44176;44417.33373999393;44434.777826110985;3605.441156620728;3657.0674478007936;3669.5141910502543;3786.962130378716;4177.770222637754;33052.3389532208;33337.66662333394;33576.328473430396;33637.15907102342;34850;3907.882763517099;3949.921001579981;3980.900477488057;3987.581303963071;4034.838606455738;313591;314099;314146;315372;317384.0653983669;38132.237355253295;38966.80516597399;60716.69641651763;60915;61329.38670613326;36478;36620.63379366226;36687.449688254696;36719.26561468756;36819.81590092032;14645.780313295309;14772.926135369255;14775.26123693811;14823;14956.326965286587;12035.097367697457;12100.636980890587;12150;12190.268583884996;12211.511539538318;8980.012198658142;9133.40632858862;9221.585028673591;9230.35387522867;9244.491552964651;3479.008482582452;3572.4462708280257;3578.6063533011347;3593.011921721495;3597.2625611749527;1079.3200283821143;1113.9164562657834;1200.9819852702217;1210.6852218423273;1243;28589.142325730263;28853.134405967856;29137.125886223446;29221.561676574867;29394.559081613792;1156.7028489162801;1209.449700386322;1268.9594532483275;1281.88463038327;1325.8077578751027;16244.350225991064;16304.184790760415;16401;16496.092714900795;16595.66808663844;558227;582495;642006;648895;651646;58282.7085864568;58791.4120858786;59254.11118833221;59315.40684593185;59566.40433595609;1292.6380613428255;1301.5509649171022;1301.9674508137373;1303.3701142318787;1519.3239008641049;30384.79318795294;33601;33871.49192762061;34209.31581368309;34292;55912;56485.71757141188;56556.71721641366;56802.43197567971;56901.430985689614;471462;478577;480833;480845;482220;30901.69098309078;31025.68974310228;31436.842815785774;31536.369272614877;31536.526952096196;50582;50695;50881;51689.224661629356;51820;43092.35361469643;43483.56516434795;43530.13047516332;48003.279950801465;48108.518914810404;41427.58572414237;41490.37764433596;41721.1655766889;42435.36346954737;42511.57488425076;40977.59022409857;42051.1589768209;42052;42057.78971105125;42085.78957105195;35984;36606.63393366139;37196.81401592975;37279.81360093182;37432;29101.85449072826;29300.56049159307;29300.70699293065;29383;29529.557056644597 17:17:52 INFO - PROCESS | 27694 | |2;jquery.html;417.7744018230156;425.25367979196506;426.4647866927006;435.5231022030879;439.5297032175572;18313.7252941206;18355.908220458896;19001.239950401985;19086.42740717779;19207;18444.170012349445;18691.626167476643;19076.236950521998;19089.14098865551;19093;5051.974740126294;5484.369297530775;5674.432556744334;5706.600537962355;5726;5621.550275977932;5663.3204015518195;5665.603407761459;5670.659760414368;5733.283339582552;5462.180672899057;5594.216809646653;5600.415215243173;5628.774849006035;5651.745671444774;5498.890022199554;5553.972230138864;5555.694436805994;5558.6942718150485;5574.581906357019;4825.131476334259;4935.185694360426;4935.235038569028;4972;4973.403191617029;22348.10607575695;22658.09367625293;22679.77320226793;22686.77313226863;22700.318990430147;2479.727230004698;2483.8509689418693;2530.4180038591226;2637.894484220629;3251.7011536530767;14130.15219086858;14277.428902843978;14422.92788536061;14442.277886105652;14648.560543183721;2025.2000459818437;2026.6149431608094;2071.730675012254;2134.253011445997;2206.580749657576;72910;80873.76504939796;82255.17744822535;82556.9999999994;83824;11239;11287.209895307415;11382.260153090023;11463.598774042868;11524.539018439169;15717.371305147895;15794.447194348373;15799.289031993589;15857.682846343008;15976.440824571317;8315.792105197297;8320.66717331312;8326.50040997542;8398;8460.661573537112;7845.058592968766;7874.72438464651;7900.644470998819;7956.443048986515;7970.2826745593175;4857.53853383928;4934.876628084255;4934.925976110361;4937.358143441402;5024.472430394756;2002.449326435242;2078.231054509841;2136.3804496695784;2166.967495487569;2184.6067707812426;1030.9278350515542;1054.6935357653658;1090.7327704712395;1146.2148428326623;1189.4469071881445;17980.9100954497;18121.275148994155;18251.361202357853;18771.249150033847;18772.342967996054;1056.1339701444742;1072.104792498257;1093.8468614393992;1094;1106.4523061084653;10232.72516883297;10447.94776026115;10480.213983951235;10516.211284153718;10677.412742299093;481423;485750;497455;500106;503516;57164.28507144792;92778;94454.52772736092;95804;97996.51001744946;1059.5073290919759;1062.5059347403494;1067.882532921378;1071.2233630617895;1085.9511321990528;16214.18929053519;16341.101239431946;16410.671786563962;16484.587885302964;16858.74711879347;37775.62224377721;38895.805520972215;40298.1940361197;40832;41350.9662258446;58004.4199557999;58163.418365817495;58289.70855145697;58454.70772646109;58730.119048213455;8306.460080094774;8441.077122830477;8591.226789588967;8609.913900861162;8731.912680873364;12080.697982550506;12785.87214127884;12876.22742635445;13268.53560125391;13450.46198152063;11026.779464410827;11754.76490470203;11906.345151016778;11986.820197696867;12015.939920300343;11229.101671866394;11375.31748095117;11504;11675.416229188337;11822.527098916291;6195.039768835838;9385.671501497414;11169.832452513056;11567.074634029426;11966.700832479257;8398.874016889873;8450.873236901329;8508;8655.48067115975;8676.609552570024;11461.4269286537;11782.882171178522;11787.351695656478;11841.407929603312;11991.580294689644 17:17:52 INFO - PROCESS | 27694 | |3;mootools.html;1544.7760074789153;1576.2197712132497;1756.8155343688911;1851.5093500222451;1874.4938866506036;7273.963630181855;7699.846003079935;8033.959830200848;8199.590020498974;8233.217844304789;7954.522728636286;8005.759827205193;8035.799105022377;8058.959705201481;8081.959590202056;2184.1045171479695;2184.453886528364;2216.9113235470563;2220.589190999662;2222.655488399301;2192.484766079978;2204.0412420597013;2257.3566533537946;2269.092363054783;2275.4425165834396;2194.2868567715477;2209.668549717539;2209.7569267380577;2223.055201539339;2232.598132336179;2219.6670499425054;2229.63211070174;2232.3303009097367;2238.2613737466595;2247.9438014049615;2226.5769503794227;2231.7098777159026;2236.821054315667;2239.0931672672596;2246.3710161154904;8028.879566806502;8223.301019413357;8226.794330141734;8238.958805205995;8268.710595129201;4714.5521175488275;4792.544708252711;4794.856154315376;4819.566239038469;4829.985703002374;3027.6366835979825;3141.921451963696;3239.2549713566013;3257.641659417462;3261.2010057535817;1078.0354026427324;1088.205609904766;1100.3397961223282;1103.172620534599;1112.554978008795;10871.891281087246;11076.944615276952;11098.778024439465;11103.222774405795;11161.99542041212;4046.979765101156;4072.328065869158;4102.733322334098;4127.380892866094;4130.545639979599;9390.718278451657;9440.952795236117;9471.857922131174;9490.620375184915;9537.809243815223;4740.810367585258;4758.666893317504;4776.116418462526;4776.188048031843;4784.521547845257;3889.86385476507;4363;4403.3174857897075;4415.911681766347;4512.706674066175;3595.2989167112687;3657.4330978698345;3689.0592898810633;3713.4615480755137;3724.627537246308;1159.8260260960756;1188.1148544334526;1194;1194.3848917807336;1194.9103817213743;938.3244064273712;1009.9798004040025;1026.958921643126;1037.8391349340864;1039.5374058544026;5533.142362933751;5854.882902342015;5859.267591551056;5859.707014649251;5929.970350148222;1010.5957616953277;1030.1449796668746;1072.8658917635296;1079.8758142813676;1089.5369467976236;3986.920261594752;4049.2104039712563;4056.492938382702;4066.7763273019677;4069.1658210066867;9902.712647355942;10046.69859904204;10104.141148002502;10243.436610986468;10316.742081447874;9954.30319877616;9985.550650220757;10029;10084.848727269096;10098.545565449573;7310.488265821447;7535.13345965221;7593.734219302298;7792.376609871197;7900.762977110696;5807.245058142584;5817.485373991917;5853.209816674695;5908.970455147697;5931.673757943355;8692.91307086921;8794.42836215644;8985.640574376952;9000.414973026733;9138.543072846463;8991.775205619912;9123.27013838878;9221.400608960395;9371.062893710847;9394.81210375775;7036.19083805369;7037.296270373126;7064.32888875556;7109.573425594481;7149.463790215651;7835.216478352119;7861.882071769042;7907.406944479072;7924.326432253092;7942.523448593103;7058.400035996998;7180;7204.819879503054;7335.7432489862595;7462.179160292255;7035.839086550866;7042.295770423121;7073.2219455858785;7190.1731300901065;7270.200277969525;6685.532012759255;6692.76575319881;6730.158730158731;6732.394084532416;6776.15298087739;4854.19905715553;4982.153033984304;5124.205748109049;5149.845504634717;5193.221016847503;5005.849824505271;5046.243063540352;5065.3161823153405;5104.440793580232;5131.974340128276 17:17:52 INFO - PROCESS | 27694 | |4;prototype.html;339.76386411444054;346.2175483407499;351.3131827277672;352.5557797175558;355.48454740626084;6438.098666186737;6566.901496477557;6600.339966003397;6655.966720166404;6739.191297044355;6400.551961362695;6493.772717954873;6521.282658907517;6560.048792925023;6597.538172327939;4887.071456423286;4912.287718280847;4919.11455937931;4931.186354251544;4937.901241975158;4924.187509061001;4930.950690493085;4938.333325001115;4941.555260026596;4971.950280497203;4844.031193761261;4870.220764677652;4892.902141957159;4906.681065730734;4908.950910490885;4642.675012749109;4799.016201678647;4864.951350486503;4895.8041678333;4909.288153217782;4206.116715489751;4221.577842215754;4223.303154979425;4224.049588842486;4229.429027081335;6289.150964619764;6295.968520157416;6320.462760665349;6368.458681012119;6381.968090159566;5746.080627099644;5752.424757524256;5763.596548241625;5767.279090113736;5777.422257774231;6886.449084073262;6894.931050689479;6916.585004899722;6925.065116209348;6927.653617319113;4569;4689.929651055237;4710.175719249118;4733.502982186856;4740.739259340735;7182.676779544933;7262.818429539251;7264.20093789688;7290.744823931137;7301.415886729049;4838.758062096881;4842.15262329091;4845.75771211438;4866.975665121652;4873.342098816685;4907.214845624754;4911.943932054625;4920.5325494078725;4936.259561065869;4943.307936888838;5710.885782284414;5721.628094173865;5736.799212027642;5737.655740655574;5758.62568933018;6897.1033765611155;6951.339622735832;7005.1593808742255;7009.334113259232;7026.227115017344;1747.3534792126995;1766.055160489132;1775.334249656379;1777.2357886109098;1784.1346946730825;1070.0423121306387;1117.0728295514866;1129.5594718059963;1139.2480962564832;1153.798085335063;6582.341765823475;6730.730770769114;6795.354441328066;6821.113255276782;6836.316368363224;7238.963805180941;7258.891116633255;7292.96353518229;7302.8174295641975;7302.853942921111;6758.121444212221;6796.592204467748;6803.523753337317;6806.18325800907;6842.076319696777;3864.2851072551666;3917.9216415671526;3960.4257382679352;3972.4041393790585;3975.423563583322;7521.962390188014;7566.508176968479;7608.429367797437;7647.044119485065;7761.767146985487;7352.77941661751;7365.079365079365;7379.1513975892385;7379.631018449056;7381.261873812683;7545.547267163988;7555.622218889033;7565.205653406533;7569.886451703229;7591;7143.642817858982;7255;7277.672504737194;7284.745033923788;7339.302766237199;7190.856182876418;7225.458090643117;7266.854662906607;7278.818029549304;7321.59731214767;7544.358729507834;7567.659455324413;7569.432292577969;7593.316601505891;7600.239976002355;4672.813087476598;4673.415823022122;4683.765811709469;4684.718916864999;4692.4369075709765;7103.928960710534;7211.206767255702;7213.242609525924;7238.27617238272;7274.8908766367485;7041.3310735480045;7078.973548835493;7100.467464940047;7107.786766397016;7150.356467917913;7002.404795592432;7031.824204394727;7032.578045317297;7036.311285291391;7037.472189585904;6782.389584937379;6865.210500792473;6878.209005964378;6893.586384816927;6907.6891539881835;6976.162860456778;7040.119985001875;7099.893501597583;7108.431325493844;7120.786376408716;6648.335166483313;6877.58734475913;6888.173419189729;6892.655367231719;6932.168139823253 17:17:52 INFO - PROCESS | 27694 | |5;yui.html;851.6210286422545;854.1330549492267;876.4828751036891;886.31310734181;930.9906900930989;14892.77660835087;14912.25438728062;14956.25218739064;14974.625634359147;15028.924855375735;13588.184708917448;13663.658408539792;13705.588832335021;13738.313084345793;13779.448822047107;748.577053964511;864.4813112132733;893.3121496447732;895.7088946092546;900.653248499326;905.9094090590954;906.0441234497603;907.5054095517926;909.0909090909091;913.6528119314651;959.2853324273426;961.6826447272383;962.2542529539593;964.9903500965006;965.7633879699483;951.7430293820698;960.7165886063593;963.3834346018554;964.4599024546277;966.1980556138388;705.9752908648172;706.2372637551432;706.5654622407183;709.6309918842225;709.8544798316333;13028.088033837636;13085.934570327183;13165.210087394787;13194.868051319556;13291.468341266338;12498.875011249953;12649.367531623382;12824;12996.415161317764;13086.214827110309;11022.008019278222;11030.109352374231;11059.557617695282;11299.322040677504;11453.026492748126;3967.107400834818;3976.264391087658;4002.479677641917;4022.557518672944;4048.8785336439955;55184.72407637936;56670.716646416506;58349;58470;58854.11718824221;10838.729031774268;11120;11325.71685707864;11652.30086194831;11683.357415342238;21153.471163220736;21183.669796322392;21245;21245.575088498143;21330.680039799416;8341.16588341161;8380.664773409117;8628.223459888515;8631.654733810577;8793.956030219935;4553.635709143261;4594.816207351735;4639.396878405853;4726.007538416902;4773.355596994431;3317.6350601433824;3392.0163152685936;3399.201187720884;3407.6762707542744;3410.1815564264894;564.8700798816295;600.4115966352998;604.3322129047427;610.4688920639072;611.8011646214998;727.3017902813252;753.3596443023387;759.3659294489163;767.769669099268;785.7446329942677;8516.148385161558;8566.271866891384;8636.395452318404;8695.521746303888;8888.200061994452;496.13919849061847;771.1915558016442;773.1881524399358;810.9148539403278;819.7745619954441;4043.1913617276073;4200.558941311118;4220.092680073799;4301.720388174758;4306.741595504217;61770.69114654398;63665.36334636687;63861.680691596244;63929.36070639327;70948.64525677338;58479.70760146172;60238.69880650657;60702;62631.37368626255;64452.67773661196;54798;54991.725041374535;55152.172717409274;55388.44611553913;55446.72276638591;9210.769730756785;9300.860487092563;9388.859167112361;9450.763730906507;9575.856362154434;36332.63667363292;37209.62790372062;37236.81381593075;37239.813800930824;38551;53558.46441535691;54065.18902216391;54350.45649543612;54535.18197227124;55159.17261241165;12059.577914773292;12316.938415307866;12373.690657733629;12516.812247816108;12775.105742597929;12871.292078935749;13157.144785588906;13522.459101636217;13792.862071379157;13832.170069795442;11980.341081240615;11992.280463171888;12029.639110826689;12312.199707019015;12736.299503527394;11752.647420577396;11928.642140735792;12021.398930053638;12189.57336493254;12289.877101228873;12084.214526055779;12220.69448263765;12312.81530777057;12423.130380873252;12674.429650665557;10252.179825614083;10350.171986241234;10680.305780124267;10693.732656683645;10705.839412408975;10704.464776760975;10991.450427478754;11135.665930022113;11170.218084733991;11297.548098075986 17:17:52 INFO - PROCESS | 27694 | __end_tp_report 17:17:52 INFO - PROCESS | 27694 | __start_cc_report 17:17:52 INFO - PROCESS | 27694 | _x_x_mozilla_cycle_collect,295 17:17:52 INFO - PROCESS | 27694 | __end_cc_report 17:17:52 INFO - PROCESS | 27694 | __startTimestamp1462839472957__endTimestamp 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | ------- Summary: start ------- 17:17:52 INFO - PROCESS | 27694 | Number of tests: 6 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | [#0] dojo.html Cycles:165 Average:5395.85 Median:5586.58 stddev:598.60 (10.7%) stddev-sans-first:576.43 17:17:52 INFO - PROCESS | 27694 | Values: 3256.3 3324.8 3343.7 3376.3 3380.2 5305.3 5352.5 5355.7 5361.5 5374.5 5350.3 5359.4 5390.5 5394.1 5395.6 4853.0 4882.5 4890.4 4913.4 4919.9 4800.0 4868.0 4958.7 4972.2 5013.4 4959.9 4983.1 5005.5 5015.1 5060.0 4981.7 4990.1 5017.0 5024.8 5052.2 4848.7 4869.0 4958.5 4962.2 4968.9 5294.6 5337.4 5375.4 5382.7 5429.4 5652.0 5684.0 5754.7 5836.2 5850.7 5839.6 5875.6 5886.8 5927.5 5962.8 5455.0 5480.2 5483.8 5485.9 5491.0 5640.2 5944.3 5962.9 5975.0 5979.7 5444.8 5630.3 5688.9 5742.3 5767.4 5892.6 5897.8 5905.3 5906.9 5917.4 5739.6 5853.1 5868.7 5891.5 5892.9 5719.6 5764.5 5764.8 5773.9 5789.2 4371.0 4406.2 4408.1 4420.9 4438.5 3913.6 3915.1 3975.5 3979.2 3996.4 5507.4 5547.6 5643.8 5673.1 5707.2 5839.9 5900.5 5909.8 5911.9 5918.0 5496.6 5528.7 5567.5 5600.8 5630.7 4865.1 4892.0 4933.9 4942.8 4976.1 6022.2 6078.6 6081.6 6087.5 6089.2 5551.6 5861.3 5900.1 5918.1 5955.6 5970.3 5983.8 5990.0 5998.7 6080.0 5702.1 5713.6 5716.9 5741.3 5763.3 5646.2 5821.6 5821.7 5856.1 5924.2 5636.4 5640.0 5654.2 5667.9 5685.5 5584.3 5607.9 5622.6 5626.4 5667.4 5476.4 5516.8 5569.9 5600.4 5643.2 5496.2 5586.6 5590.3 5597.2 5602.9 5409.2 5425.5 5451.4 5467.6 5468.6 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | [#1] ext.html Cycles:180 Average:61895.24 Median:22506.21 stddev:129907.02 (577.2%) stddev-sans-first:130189.93 17:17:52 INFO - PROCESS | 27694 | Values: 602.2 612.6 631.1 633.4 644.4 39286.6 39782.4 40087.0 40117.0 40288.2 42462.0 43292.0 43321.0 43377.0 43437.3 8634.3 8765.4 8792.4 8816.9 8835.9 8611.6 8715.8 8761.3 8923.7 9014.9 8932.2 9064.4 9064.8 9070.9 9123.0 9002.6 9015.8 9024.0 9026.0 9099.5 8830.8 8896.8 8904.7 8921.8 8990.4 43398.3 44096.0 44176.0 44417.3 44434.8 3605.4 3657.1 3669.5 3787.0 4177.8 33052.3 33337.7 33576.3 33637.2 34850.0 3907.9 3949.9 3980.9 3987.6 4034.8 313591.0 314099.0 314146.0 315372.0 317384.1 38132.2 38966.8 60716.7 60915.0 61329.4 36478.0 36620.6 36687.4 36719.3 36819.8 14645.8 14772.9 14775.3 14823.0 14956.3 12035.1 12100.6 12150.0 12190.3 12211.5 8980.0 9133.4 9221.6 9230.4 9244.5 3479.0 3572.4 3578.6 3593.0 3597.3 1079.3 1113.9 1201.0 1210.7 1243.0 28589.1 28853.1 29137.1 29221.6 29394.6 1156.7 1209.4 1269.0 1281.9 1325.8 16244.4 16304.2 16401.0 16496.1 16595.7 558227.0 582495.0 642006.0 648895.0 651646.0 58282.7 58791.4 59254.1 59315.4 59566.4 1292.6 1301.6 1302.0 1303.4 1519.3 30384.8 33601.0 33871.5 34209.3 34292.0 55912.0 56485.7 56556.7 56802.4 56901.4 471462.0 478577.0 480833.0 480845.0 482220.0 30901.7 31025.7 31436.8 31536.4 31536.5 50582.0 50695.0 50881.0 51689.2 51820.0 43092.4 43483.6 43530.1 48003.3 48108.5 41427.6 41490.4 41721.2 42435.4 42511.6 40977.6 42051.2 42052.0 42057.8 42085.8 35984.0 36606.6 37196.8 37279.8 37432.0 29101.9 29300.6 29300.7 29383.0 29529.6 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | [#2] jquery.html Cycles:180 Average:28922.86 Median:22683.27 stddev:81317.25 (358.5%) stddev-sans-first:81517.19 17:17:52 INFO - PROCESS | 27694 | Values: 417.8 425.3 426.5 435.5 439.5 18313.7 18355.9 19001.2 19086.4 19207.0 18444.2 18691.6 19076.2 19089.1 19093.0 5052.0 5484.4 5674.4 5706.6 5726.0 5621.6 5663.3 5665.6 5670.7 5733.3 5462.2 5594.2 5600.4 5628.8 5651.7 5498.9 5554.0 5555.7 5558.7 5574.6 4825.1 4935.2 4935.2 4972.0 4973.4 22348.1 22658.1 22679.8 22686.8 22700.3 2479.7 2483.9 2530.4 2637.9 3251.7 14130.2 14277.4 14422.9 14442.3 14648.6 2025.2 2026.6 2071.7 2134.3 2206.6 72910.0 80873.8 82255.2 82557.0 83824.0 11239.0 11287.2 11382.3 11463.6 11524.5 15717.4 15794.4 15799.3 15857.7 15976.4 8315.8 8320.7 8326.5 8398.0 8460.7 7845.1 7874.7 7900.6 7956.4 7970.3 4857.5 4934.9 4934.9 4937.4 5024.5 2002.4 2078.2 2136.4 2167.0 2184.6 1030.9 1054.7 1090.7 1146.2 1189.4 17980.9 18121.3 18251.4 18771.2 18772.3 1056.1 1072.1 1093.8 1094.0 1106.5 10232.7 10447.9 10480.2 10516.2 10677.4 481423.0 485750.0 497455.0 500106.0 503516.0 57164.3 92778.0 94454.5 95804.0 97996.5 1059.5 1062.5 1067.9 1071.2 1086.0 16214.2 16341.1 16410.7 16484.6 16858.7 37775.6 38895.8 40298.2 40832.0 41351.0 58004.4 58163.4 58289.7 58454.7 58730.1 8306.5 8441.1 8591.2 8609.9 8731.9 12080.7 12785.9 12876.2 13268.5 13450.5 11026.8 11754.8 11906.3 11986.8 12015.9 11229.1 11375.3 11504.0 11675.4 11822.5 6195.0 9385.7 11169.8 11567.1 11966.7 8398.9 8450.9 8508.0 8655.5 8676.6 11461.4 11782.9 11787.4 11841.4 11991.6 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | [#3] mootools.html Cycles:180 Average:5403.11 Median:4780.35 stddev:2966.80 (62.1%) stddev-sans-first:2960.96 17:17:52 INFO - PROCESS | 27694 | Values: 1544.8 1576.2 1756.8 1851.5 1874.5 7274.0 7699.8 8034.0 8199.6 8233.2 7954.5 8005.8 8035.8 8059.0 8082.0 2184.1 2184.5 2216.9 2220.6 2222.7 2192.5 2204.0 2257.4 2269.1 2275.4 2194.3 2209.7 2209.8 2223.1 2232.6 2219.7 2229.6 2232.3 2238.3 2247.9 2226.6 2231.7 2236.8 2239.1 2246.4 8028.9 8223.3 8226.8 8239.0 8268.7 4714.6 4792.5 4794.9 4819.6 4830.0 3027.6 3141.9 3239.3 3257.6 3261.2 1078.0 1088.2 1100.3 1103.2 1112.6 10871.9 11076.9 11098.8 11103.2 11162.0 4047.0 4072.3 4102.7 4127.4 4130.5 9390.7 9441.0 9471.9 9490.6 9537.8 4740.8 4758.7 4776.1 4776.2 4784.5 3889.9 4363.0 4403.3 4415.9 4512.7 3595.3 3657.4 3689.1 3713.5 3724.6 1159.8 1188.1 1194.0 1194.4 1194.9 938.3 1010.0 1027.0 1037.8 1039.5 5533.1 5854.9 5859.3 5859.7 5930.0 1010.6 1030.1 1072.9 1079.9 1089.5 3986.9 4049.2 4056.5 4066.8 4069.2 9902.7 10046.7 10104.1 10243.4 10316.7 9954.3 9985.6 10029.0 10084.8 10098.5 7310.5 7535.1 7593.7 7792.4 7900.8 5807.2 5817.5 5853.2 5909.0 5931.7 8692.9 8794.4 8985.6 9000.4 9138.5 8991.8 9123.3 9221.4 9371.1 9394.8 7036.2 7037.3 7064.3 7109.6 7149.5 7835.2 7861.9 7907.4 7924.3 7942.5 7058.4 7180.0 7204.8 7335.7 7462.2 7035.8 7042.3 7073.2 7190.2 7270.2 6685.5 6692.8 6730.2 6732.4 6776.2 4854.2 4982.2 5124.2 5149.8 5193.2 5005.8 5046.2 5065.3 5104.4 5132.0 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | [#4] prototype.html Cycles:180 Average:5827.78 Median:6693.35 stddev:1807.22 (27.0%) stddev-sans-first:1764.72 17:17:52 INFO - PROCESS | 27694 | Values: 339.8 346.2 351.3 352.6 355.5 6438.1 6566.9 6600.3 6656.0 6739.2 6400.6 6493.8 6521.3 6560.0 6597.5 4887.1 4912.3 4919.1 4931.2 4937.9 4924.2 4931.0 4938.3 4941.6 4972.0 4844.0 4870.2 4892.9 4906.7 4909.0 4642.7 4799.0 4865.0 4895.8 4909.3 4206.1 4221.6 4223.3 4224.0 4229.4 6289.2 6296.0 6320.5 6368.5 6382.0 5746.1 5752.4 5763.6 5767.3 5777.4 6886.4 6894.9 6916.6 6925.1 6927.7 4569.0 4689.9 4710.2 4733.5 4740.7 7182.7 7262.8 7264.2 7290.7 7301.4 4838.8 4842.2 4845.8 4867.0 4873.3 4907.2 4911.9 4920.5 4936.3 4943.3 5710.9 5721.6 5736.8 5737.7 5758.6 6897.1 6951.3 7005.2 7009.3 7026.2 1747.4 1766.1 1775.3 1777.2 1784.1 1070.0 1117.1 1129.6 1139.2 1153.8 6582.3 6730.7 6795.4 6821.1 6836.3 7239.0 7258.9 7293.0 7302.8 7302.9 6758.1 6796.6 6803.5 6806.2 6842.1 3864.3 3917.9 3960.4 3972.4 3975.4 7522.0 7566.5 7608.4 7647.0 7761.8 7352.8 7365.1 7379.2 7379.6 7381.3 7545.5 7555.6 7565.2 7569.9 7591.0 7143.6 7255.0 7277.7 7284.7 7339.3 7190.9 7225.5 7266.9 7278.8 7321.6 7544.4 7567.7 7569.4 7593.3 7600.2 4672.8 4673.4 4683.8 4684.7 4692.4 7103.9 7211.2 7213.2 7238.3 7274.9 7041.3 7079.0 7100.5 7107.8 7150.4 7002.4 7031.8 7032.6 7036.3 7037.5 6782.4 6865.2 6878.2 6893.6 6907.7 6976.2 7040.1 7099.9 7108.4 7120.8 6648.3 6877.6 6888.2 6892.7 6932.2 17:17:52 INFO - PROCESS | 27694 | 17:17:52 INFO - PROCESS | 27694 | [#5] yui.html Cycles:180 Average:15640.24 Median:4574.23 stddev:18791.72 (410.8%) stddev-sans-first:18811.62 17:17:52 INFO - PROCESS | 27694 | Values: 851.6 854.1 876.5 886.3 931.0 14892.8 14912.3 14956.3 14974.6 15028.9 13588.2 13663.7 13705.6 13738.3 13779.4 748.6 864.5 893.3 895.7 900.7 905.9 906.0 907.5 909.1 913.7 959.3 961.7 962.3 965.0 965.8 951.7 960.7 963.4 964.5 966.2 706.0 706.2 706.6 709.6 709.9 13028.1 13085.9 13165.2 13194.9 13291.5 12498.9 12649.4 12824.0 12996.4 13086.2 11022.0 11030.1 11059.6 11299.3 11453.0 3967.1 3976.3 4002.5 4022.6 4048.9 55184.7 56670.7 58349.0 58470.0 58854.1 10838.7 11120.0 11325.7 11652.3 11683.4 21153.5 21183.7 21245.0 21245.6 21330.7 8341.2 8380.7 8628.2 8631.7 8794.0 4553.6 4594.8 4639.4 4726.0 4773.4 3317.6 3392.0 3399.2 3407.7 3410.2 564.9 600.4 604.3 610.5 611.8 727.3 753.4 759.4 767.8 785.7 8516.1 8566.3 8636.4 8695.5 8888.2 496.1 771.2 773.2 810.9 819.8 4043.2 4200.6 4220.1 4301.7 4306.7 61770.7 63665.4 63861.7 63929.4 70948.6 58479.7 60238.7 60702.0 62631.4 64452.7 54798.0 54991.7 55152.2 55388.4 55446.7 9210.8 9300.9 9388.9 9450.8 9575.9 36332.6 37209.6 37236.8 37239.8 38551.0 53558.5 54065.2 54350.5 54535.2 55159.2 12059.6 12316.9 12373.7 12516.8 12775.1 12871.3 13157.1 13522.5 13792.9 13832.2 11980.3 11992.3 12029.6 12312.2 12736.3 11752.6 11928.6 12021.4 12189.6 12289.9 12084.2 12220.7 12312.8 12423.1 12674.4 10252.2 10350.2 10680.3 10693.7 10705.8 10704.5 10991.5 11135.7 11170.2 11297.5 17:17:52 INFO - PROCESS | 27694 | -------- Summary: end -------- 17:17:52 INFO - PROCESS | 27694 | 17:17:53 INFO - TEST-INFO | 27694: exit 0 17:17:53 INFO - TEST-OK | dromaeo_css | took 1106717ms 17:17:53 INFO - TEST-START | kraken 17:17:53 INFO - operating with platform_type : linux_ 17:17:53 INFO - Initialising browser for kraken test... 17:17:53 INFO - TEST-INFO | started process 27937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Dm5kY/profile http://localhost:35470/getInfo.html) 17:17:56 INFO - PROCESS | 27937 | 17:17:56 INFO - PROCESS | 27937 | (process:28015): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:17:57 INFO - PROCESS | 27937 | __metrics Screen width/height:1600/1200 17:17:57 INFO - PROCESS | 27937 | colorDepth:24 17:17:57 INFO - PROCESS | 27937 | Browser inner width/height: 1024/697 17:17:57 INFO - PROCESS | 27937 | __metrics 17:17:58 ERROR - PROCESS | 27937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:17:58 INFO - TEST-INFO | 27937: exit 0 17:17:58 INFO - Browser initialized. 17:17:58 INFO - Running cycle 1/1 for kraken test... 17:17:58 INFO - TEST-INFO | started process 28066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_Dm5kY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:00 INFO - PROCESS | 28066 | 17:18:00 INFO - PROCESS | 28066 | (process:28133): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:18:10 INFO - PROCESS | 28066 | RSS: Main: 151298048 17:18:10 INFO - PROCESS | 28066 | 17:18:12 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35470/tests/kraken/driver.html?testName=audio-beat-detection) 17:18:13 INFO - PROCESS | 28066 | RSS: Main: 156520448 17:18:13 INFO - PROCESS | 28066 | 17:18:16 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35470/tests/kraken/driver.html?testName=audio-dft) 17:18:16 INFO - PROCESS | 28066 | RSS: Main: 156045312 17:18:16 INFO - PROCESS | 28066 | 17:18:19 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35470/tests/kraken/driver.html?testName=audio-fft) 17:18:20 INFO - PROCESS | 28066 | RSS: Main: 156377088 17:18:20 INFO - PROCESS | 28066 | 17:18:22 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35470/tests/kraken/driver.html?testName=audio-oscillator) 17:18:22 INFO - PROCESS | 28066 | RSS: Main: 156352512 17:18:22 INFO - PROCESS | 28066 | 17:18:25 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:25 INFO - PROCESS | 28066 | RSS: Main: 156254208 17:18:25 INFO - PROCESS | 28066 | 17:18:28 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35470/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:29 INFO - PROCESS | 28066 | RSS: Main: 156819456 17:18:29 INFO - PROCESS | 28066 | 17:18:32 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35470/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:33 INFO - PROCESS | 28066 | RSS: Main: 156696576 17:18:33 INFO - PROCESS | 28066 | 17:18:36 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35470/tests/kraken/driver.html?testName=json-parse-financial) 17:18:36 INFO - PROCESS | 28066 | RSS: Main: 156221440 17:18:36 INFO - PROCESS | 28066 | 17:18:38 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:38 INFO - PROCESS | 28066 | RSS: Main: 156483584 17:18:38 INFO - PROCESS | 28066 | 17:18:40 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:41 INFO - PROCESS | 28066 | RSS: Main: 156573696 17:18:41 INFO - PROCESS | 28066 | 17:18:42 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:43 INFO - PROCESS | 28066 | RSS: Main: 156700672 17:18:43 INFO - PROCESS | 28066 | 17:18:46 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:46 INFO - PROCESS | 28066 | RSS: Main: 156934144 17:18:46 INFO - PROCESS | 28066 | 17:18:49 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:49 INFO - PROCESS | 28066 | RSS: Main: 157470720 17:18:49 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | Cycle 1(1): loaded http://localhost:35470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35470/tests/kraken/driver.html?testName=ai-astar) 17:18:51 INFO - PROCESS | 28066 | RSS: Main: 159027200 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | __start_tp_report 17:18:51 INFO - PROCESS | 28066 | _x_x_mozilla_page_load 17:18:51 INFO - PROCESS | 28066 | _x_x_mozilla_page_load_details 17:18:51 INFO - PROCESS | 28066 | |i|pagename|runs| 17:18:51 INFO - PROCESS | 28066 | |0;ai-astar;110;114;107;113;114;116;104;112;111;112 17:18:51 INFO - PROCESS | 28066 | |1;audio-beat-detection;157;129;155;175;131;155;154;132;175;140 17:18:51 INFO - PROCESS | 28066 | |2;audio-dft;164;164;164;169;163;176;163;165;166;166 17:18:51 INFO - PROCESS | 28066 | |3;audio-fft;75;75;85;167;74;77;74;77;158;75 17:18:51 INFO - PROCESS | 28066 | |4;audio-oscillator;94;94;143;94;92;93;136;93;93;135 17:18:51 INFO - PROCESS | 28066 | |5;imaging-gaussian-blur;121;119;118;118;119;119;119;119;120;119 17:18:51 INFO - PROCESS | 28066 | |6;imaging-darkroom;149;148;150;149;148;147;147;149;149;148 17:18:51 INFO - PROCESS | 28066 | |7;imaging-desaturate;96;96;97;96;97;96;97;95;97;96 17:18:51 INFO - PROCESS | 28066 | |8;json-parse-financial;55;58;57;56;57;56;57;68;54;54 17:18:51 INFO - PROCESS | 28066 | |9;json-stringify-tinderbox;59;59;58;59;60;59;59;59;60;62 17:18:51 INFO - PROCESS | 28066 | |10;stanford-crypto-aes;76;75;75;77;82;76;78;80;78;76 17:18:51 INFO - PROCESS | 28066 | |11;stanford-crypto-ccm;119;133;133;122;129;117;125;120;131;133 17:18:51 INFO - PROCESS | 28066 | |12;stanford-crypto-pbkdf2;162;163;163;163;164;165;162;165;162;166 17:18:51 INFO - PROCESS | 28066 | |13;stanford-crypto-sha256-iterative;67;68;70;68;68;65;67;66;68;67 17:18:51 INFO - PROCESS | 28066 | __end_tp_report 17:18:51 INFO - PROCESS | 28066 | __start_cc_report 17:18:51 INFO - PROCESS | 28066 | _x_x_mozilla_cycle_collect,742 17:18:51 INFO - PROCESS | 28066 | __end_cc_report 17:18:51 INFO - PROCESS | 28066 | __startTimestamp1462839531840__endTimestamp 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | ------- Summary: start ------- 17:18:51 INFO - PROCESS | 28066 | Number of tests: 14 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.56 (3.2%) stddev-sans-first:3.75 17:18:51 INFO - PROCESS | 28066 | Values: 110.0 114.0 107.0 113.0 114.0 116.0 104.0 112.0 111.0 112.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:155.00 stddev:16.96 (10.9%) stddev-sans-first:17.82 17:18:51 INFO - PROCESS | 28066 | Values: 157.0 129.0 155.0 175.0 131.0 155.0 154.0 132.0 175.0 140.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.50 stddev:3.94 (2.4%) stddev-sans-first:4.12 17:18:51 INFO - PROCESS | 28066 | Values: 164.0 164.0 164.0 169.0 163.0 176.0 163.0 165.0 166.0 166.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:36.46 (48.6%) stddev-sans-first:38.04 17:18:51 INFO - PROCESS | 28066 | Values: 75.0 75.0 85.0 167.0 74.0 77.0 74.0 77.0 158.0 75.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:21.71 (23.3%) stddev-sans-first:22.53 17:18:51 INFO - PROCESS | 28066 | Values: 94.0 94.0 143.0 94.0 92.0 93.0 136.0 93.0 93.0 135.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:119.00 stddev:0.88 (0.7%) stddev-sans-first:0.60 17:18:51 INFO - PROCESS | 28066 | Values: 121.0 119.0 118.0 118.0 119.0 119.0 119.0 119.0 120.0 119.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 17:18:51 INFO - PROCESS | 28066 | Values: 149.0 148.0 150.0 149.0 148.0 147.0 147.0 149.0 149.0 148.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:18:51 INFO - PROCESS | 28066 | Values: 96.0 96.0 97.0 96.0 97.0 96.0 97.0 95.0 97.0 96.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:4.02 (7.1%) stddev-sans-first:4.19 17:18:51 INFO - PROCESS | 28066 | Values: 55.0 58.0 57.0 56.0 57.0 56.0 57.0 68.0 54.0 54.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.07 (1.8%) stddev-sans-first:1.13 17:18:51 INFO - PROCESS | 28066 | Values: 59.0 59.0 58.0 59.0 60.0 59.0 59.0 59.0 60.0 62.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.50 stddev:2.26 (2.9%) stddev-sans-first:2.35 17:18:51 INFO - PROCESS | 28066 | Values: 76.0 75.0 75.0 77.0 82.0 76.0 78.0 80.0 78.0 76.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:130.00 stddev:6.36 (4.9%) stddev-sans-first:6.18 17:18:51 INFO - PROCESS | 28066 | Values: 119.0 133.0 133.0 122.0 129.0 117.0 125.0 120.0 131.0 133.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.50 Median:163.50 stddev:1.43 (0.9%) stddev-sans-first:1.41 17:18:51 INFO - PROCESS | 28066 | Values: 162.0 163.0 163.0 163.0 164.0 165.0 162.0 165.0 162.0 166.0 17:18:51 INFO - PROCESS | 28066 | 17:18:51 INFO - PROCESS | 28066 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 17:18:51 INFO - PROCESS | 28066 | Values: 67.0 68.0 70.0 68.0 68.0 65.0 67.0 66.0 68.0 67.0 17:18:51 INFO - PROCESS | 28066 | -------- Summary: end -------- 17:18:51 INFO - PROCESS | 28066 | 17:18:52 INFO - TEST-INFO | 28066: exit 0 17:18:52 INFO - TEST-OK | kraken | took 59155ms 17:18:52 INFO - SUITE-END | took 1165s 17:18:53 INFO - Completed test suite (00:19:26) 17:18:53 INFO - javascript benchmark 17:18:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.2673398485335, 3324.7672662913596, 3343.715784158346, 3376.27410106827, 3380.188754698873, 5305.257263983045, 5352.491513306235, 5355.656875202436, 5361.490658387456, 5374.516293533581, 5350.30446042015, 5359.38367087785, 5390.487903649157, 5394.083005888999, 5395.622306438551, 4853.029394121172, 4882.536159064884, 4890.364252647151, 4913.3612630358, 4919.926201106986, 4800.0, 4868.002059577778, 4958.67768595042, 4972.154733695263, 5013.373328333958, 4959.851204463872, 4983.078130545842, 5005.474425185358, 5015.072211640858, 5060.038592667382, 4981.676191047571, 4990.076835785373, 5017.046761115376, 5024.84925452237, 5052.191649336125, 4848.733319667417, 4868.9756551217015, 4958.504149585013, 4962.230854217602, 4968.850934471971, 5294.576433885319, 5337.386200586943, 5375.381831089436, 5382.650127741685, 5429.375621803503, 5651.971740141273, 5684.0, 5754.74103665336, 5836.182934389189, 5850.707464626794, 5839.562032847553, 5875.618084824516, 5886.7939622113445, 5927.525797936155, 5962.821115366502, 5455.0453670607485, 5480.150576660624, 5483.8080667176455, 5485.945140548583, 5490.972545137289, 5640.182173584889, 5944.256967879015, 5962.940370596239, 5974.954382982961, 5979.671118088547, 5444.782208711607, 5630.296212973379, 5688.857778555569, 5742.253507044057, 5767.423257674199, 5892.646441213541, 5897.764089436375, 5905.320888097838, 5906.881862362815, 5917.378675239124, 5739.626924249994, 5853.09277062056, 5868.735906884115, 5891.528677705774, 5892.911606325909, 5719.599628025998, 5764.510016648632, 5764.827055188351, 5773.855653608609, 5789.247397838254, 4370.956290437055, 4406.184855801623, 4408.096340250241, 4420.911581768347, 4438.511763705989, 3913.5890731473355, 3915.138669492764, 3975.5229372475487, 3979.2041591681777, 3996.3805610130476, 5507.394186639466, 5547.55619550435, 5643.774249030075, 5673.063944449203, 5707.20099186106, 5839.941600584025, 5900.468957793819, 5909.793157239476, 5911.940880591225, 5917.993941030035, 5496.642718223303, 5528.695921724263, 5567.47109024642, 5600.803971860965, 5630.690312032795, 4865.1242776300605, 4892.046051020017, 4933.901321973541, 4942.827001054946, 4976.0794253063295, 6022.18700475439, 6078.574499784972, 6081.6351018939, 6087.452129308295, 6089.208402907594, 5551.583631227593, 5861.296644402699, 5900.055991041413, 5918.112283157475, 5955.553333499918, 5970.283565972111, 5983.790567330123, 5989.981703110395, 5998.670073146019, 6079.969600151971, 5702.144678298288, 5713.571482138773, 5716.885662286814, 5741.311042674905, 5763.308402991668, 5646.181303710857, 5821.621594596338, 5821.7089145543405, 5856.0630299151935, 5924.170616113662, 5636.408177141341, 5639.971800140973, 5654.15187721845, 5667.886642267049, 5685.545156387562, 5584.301962254718, 5607.915881261702, 5622.606417550732, 5626.38109807929, 5667.4332566743, 5476.424975377528, 5516.751746171351, 5569.916451253153, 5600.43995600453, 5643.209950606836, 5496.203050557727, 5586.581006424616, 5590.329160500603, 5597.216389705363, 5602.887942241214, 5409.2427060212385, 5425.538829199404, 5451.37309209446, 5467.589930755289, 5468.56251499887], "value": 5357.60226995133, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.2111034544747, 612.6201754911954, 631.1290419221475, 633.3666333666333, 644.3942693867764, 39286.60713392865, 39782.40326395106, 40087.0, 40117.0, 40288.1942361153, 42462.0, 43292.0, 43321.0, 43377.0, 43437.34843977343, 8634.309255259595, 8765.386422950396, 8792.384533082655, 8816.8677469838, 8835.93968723751, 8611.61247743853, 8715.825683486326, 8761.342899282547, 8923.73228803137, 9014.86477702835, 8932.196102350787, 9064.365494415393, 9064.818703625957, 9070.863937040916, 9122.954385228099, 9002.594883230271, 9015.819683606323, 9024.007359190451, 9026.0, 9099.454032758056, 8830.823383532357, 8896.822063558693, 8904.73285801427, 8921.776955576162, 8990.37067405282, 43398.349024764655, 44096.0, 44176.0, 44417.33373999393, 44434.777826110985, 3605.441156620728, 3657.0674478007936, 3669.5141910502543, 3786.962130378716, 4177.770222637754, 33052.3389532208, 33337.66662333394, 33576.328473430396, 33637.15907102342, 34850.0, 3907.882763517099, 3949.921001579981, 3980.900477488057, 3987.581303963071, 4034.838606455738, 313591.0, 314099.0, 314146.0, 315372.0, 317384.0653983669, 38132.237355253295, 38966.80516597399, 60716.69641651763, 60915.0, 61329.38670613326, 36478.0, 36620.63379366226, 36687.449688254696, 36719.26561468756, 36819.81590092032, 14645.780313295309, 14772.926135369255, 14775.26123693811, 14823.0, 14956.326965286587, 12035.097367697457, 12100.636980890587, 12150.0, 12190.268583884996, 12211.511539538318, 8980.012198658142, 9133.40632858862, 9221.585028673591, 9230.35387522867, 9244.491552964651, 3479.008482582452, 3572.4462708280257, 3578.6063533011347, 3593.011921721495, 3597.2625611749527, 1079.3200283821143, 1113.9164562657834, 1200.9819852702217, 1210.6852218423273, 1243.0, 28589.142325730263, 28853.134405967856, 29137.125886223446, 29221.561676574867, 29394.559081613792, 1156.7028489162801, 1209.449700386322, 1268.9594532483275, 1281.88463038327, 1325.8077578751027, 16244.350225991064, 16304.184790760415, 16401.0, 16496.092714900795, 16595.66808663844, 558227.0, 582495.0, 642006.0, 648895.0, 651646.0, 58282.7085864568, 58791.4120858786, 59254.11118833221, 59315.40684593185, 59566.40433595609, 1292.6380613428255, 1301.5509649171022, 1301.9674508137373, 1303.3701142318787, 1519.3239008641049, 30384.79318795294, 33601.0, 33871.49192762061, 34209.31581368309, 34292.0, 55912.0, 56485.71757141188, 56556.71721641366, 56802.43197567971, 56901.430985689614, 471462.0, 478577.0, 480833.0, 480845.0, 482220.0, 30901.69098309078, 31025.68974310228, 31436.842815785774, 31536.369272614877, 31536.526952096196, 50582.0, 50695.0, 50881.0, 51689.224661629356, 51820.0, 43092.35361469643, 43483.56516434795, 43530.13047516332, 48003.279950801465, 48108.518914810404, 41427.58572414237, 41490.37764433596, 41721.1655766889, 42435.36346954737, 42511.57488425076, 40977.59022409857, 42051.1589768209, 42052.0, 42057.78971105125, 42085.78957105195, 35984.0, 36606.63393366139, 37196.81401592975, 37279.81360093182, 37432.0, 29101.85449072826, 29300.56049159307, 29300.70699293065, 29383.0, 29529.557056644597], "value": 19329.064983098597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.7744018230156, 425.25367979196506, 426.4647866927006, 435.5231022030879, 439.5297032175572, 18313.7252941206, 18355.908220458896, 19001.239950401985, 19086.42740717779, 19207.0, 18444.170012349445, 18691.626167476643, 19076.236950521998, 19089.14098865551, 19093.0, 5051.974740126294, 5484.369297530775, 5674.432556744334, 5706.600537962355, 5726.0, 5621.550275977932, 5663.3204015518195, 5665.603407761459, 5670.659760414368, 5733.283339582552, 5462.180672899057, 5594.216809646653, 5600.415215243173, 5628.774849006035, 5651.745671444774, 5498.890022199554, 5553.972230138864, 5555.694436805994, 5558.6942718150485, 5574.581906357019, 4825.131476334259, 4935.185694360426, 4935.235038569028, 4972.0, 4973.403191617029, 22348.10607575695, 22658.09367625293, 22679.77320226793, 22686.77313226863, 22700.318990430147, 2479.727230004698, 2483.8509689418693, 2530.4180038591226, 2637.894484220629, 3251.7011536530767, 14130.15219086858, 14277.428902843978, 14422.92788536061, 14442.277886105652, 14648.560543183721, 2025.2000459818437, 2026.6149431608094, 2071.730675012254, 2134.253011445997, 2206.580749657576, 72910.0, 80873.76504939796, 82255.17744822535, 82556.9999999994, 83824.0, 11239.0, 11287.209895307415, 11382.260153090023, 11463.598774042868, 11524.539018439169, 15717.371305147895, 15794.447194348373, 15799.289031993589, 15857.682846343008, 15976.440824571317, 8315.792105197297, 8320.66717331312, 8326.50040997542, 8398.0, 8460.661573537112, 7845.058592968766, 7874.72438464651, 7900.644470998819, 7956.443048986515, 7970.2826745593175, 4857.53853383928, 4934.876628084255, 4934.925976110361, 4937.358143441402, 5024.472430394756, 2002.449326435242, 2078.231054509841, 2136.3804496695784, 2166.967495487569, 2184.6067707812426, 1030.9278350515542, 1054.6935357653658, 1090.7327704712395, 1146.2148428326623, 1189.4469071881445, 17980.9100954497, 18121.275148994155, 18251.361202357853, 18771.249150033847, 18772.342967996054, 1056.1339701444742, 1072.104792498257, 1093.8468614393992, 1094.0, 1106.4523061084653, 10232.72516883297, 10447.94776026115, 10480.213983951235, 10516.211284153718, 10677.412742299093, 481423.0, 485750.0, 497455.0, 500106.0, 503516.0, 57164.28507144792, 92778.0, 94454.52772736092, 95804.0, 97996.51001744946, 1059.5073290919759, 1062.5059347403494, 1067.882532921378, 1071.2233630617895, 1085.9511321990528, 16214.18929053519, 16341.101239431946, 16410.671786563962, 16484.587885302964, 16858.74711879347, 37775.62224377721, 38895.805520972215, 40298.1940361197, 40832.0, 41350.9662258446, 58004.4199557999, 58163.418365817495, 58289.70855145697, 58454.70772646109, 58730.119048213455, 8306.460080094774, 8441.077122830477, 8591.226789588967, 8609.913900861162, 8731.912680873364, 12080.697982550506, 12785.87214127884, 12876.22742635445, 13268.53560125391, 13450.46198152063, 11026.779464410827, 11754.76490470203, 11906.345151016778, 11986.820197696867, 12015.939920300343, 11229.101671866394, 11375.31748095117, 11504.0, 11675.416229188337, 11822.527098916291, 6195.039768835838, 9385.671501497414, 11169.832452513056, 11567.074634029426, 11966.700832479257, 8398.874016889873, 8450.873236901329, 8508.0, 8655.48067115975, 8676.609552570024, 11461.4269286537, 11782.882171178522, 11787.351695656478, 11841.407929603312, 11991.580294689644], "value": 9328.447884051466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.7760074789153, 1576.2197712132497, 1756.8155343688911, 1851.5093500222451, 1874.4938866506036, 7273.963630181855, 7699.846003079935, 8033.959830200848, 8199.590020498974, 8233.217844304789, 7954.522728636286, 8005.759827205193, 8035.799105022377, 8058.959705201481, 8081.959590202056, 2184.1045171479695, 2184.453886528364, 2216.9113235470563, 2220.589190999662, 2222.655488399301, 2192.484766079978, 2204.0412420597013, 2257.3566533537946, 2269.092363054783, 2275.4425165834396, 2194.2868567715477, 2209.668549717539, 2209.7569267380577, 2223.055201539339, 2232.598132336179, 2219.6670499425054, 2229.63211070174, 2232.3303009097367, 2238.2613737466595, 2247.9438014049615, 2226.5769503794227, 2231.7098777159026, 2236.821054315667, 2239.0931672672596, 2246.3710161154904, 8028.879566806502, 8223.301019413357, 8226.794330141734, 8238.958805205995, 8268.710595129201, 4714.5521175488275, 4792.544708252711, 4794.856154315376, 4819.566239038469, 4829.985703002374, 3027.6366835979825, 3141.921451963696, 3239.2549713566013, 3257.641659417462, 3261.2010057535817, 1078.0354026427324, 1088.205609904766, 1100.3397961223282, 1103.172620534599, 1112.554978008795, 10871.891281087246, 11076.944615276952, 11098.778024439465, 11103.222774405795, 11161.99542041212, 4046.979765101156, 4072.328065869158, 4102.733322334098, 4127.380892866094, 4130.545639979599, 9390.718278451657, 9440.952795236117, 9471.857922131174, 9490.620375184915, 9537.809243815223, 4740.810367585258, 4758.666893317504, 4776.116418462526, 4776.188048031843, 4784.521547845257, 3889.86385476507, 4363.0, 4403.3174857897075, 4415.911681766347, 4512.706674066175, 3595.2989167112687, 3657.4330978698345, 3689.0592898810633, 3713.4615480755137, 3724.627537246308, 1159.8260260960756, 1188.1148544334526, 1194.0, 1194.3848917807336, 1194.9103817213743, 938.3244064273712, 1009.9798004040025, 1026.958921643126, 1037.8391349340864, 1039.5374058544026, 5533.142362933751, 5854.882902342015, 5859.267591551056, 5859.707014649251, 5929.970350148222, 1010.5957616953277, 1030.1449796668746, 1072.8658917635296, 1079.8758142813676, 1089.5369467976236, 3986.920261594752, 4049.2104039712563, 4056.492938382702, 4066.7763273019677, 4069.1658210066867, 9902.712647355942, 10046.69859904204, 10104.141148002502, 10243.436610986468, 10316.742081447874, 9954.30319877616, 9985.550650220757, 10029.0, 10084.848727269096, 10098.545565449573, 7310.488265821447, 7535.13345965221, 7593.734219302298, 7792.376609871197, 7900.762977110696, 5807.245058142584, 5817.485373991917, 5853.209816674695, 5908.970455147697, 5931.673757943355, 8692.91307086921, 8794.42836215644, 8985.640574376952, 9000.414973026733, 9138.543072846463, 8991.775205619912, 9123.27013838878, 9221.400608960395, 9371.062893710847, 9394.81210375775, 7036.19083805369, 7037.296270373126, 7064.32888875556, 7109.573425594481, 7149.463790215651, 7835.216478352119, 7861.882071769042, 7907.406944479072, 7924.326432253092, 7942.523448593103, 7058.400035996998, 7180.0, 7204.819879503054, 7335.7432489862595, 7462.179160292255, 7035.839086550866, 7042.295770423121, 7073.2219455858785, 7190.1731300901065, 7270.200277969525, 6685.532012759255, 6692.76575319881, 6730.158730158731, 6732.394084532416, 6776.15298087739, 4854.19905715553, 4982.153033984304, 5124.205748109049, 5149.845504634717, 5193.221016847503, 5005.849824505271, 5046.243063540352, 5065.3161823153405, 5104.440793580232, 5131.974340128276], "value": 4400.823457580341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.76386411444054, 346.2175483407499, 351.3131827277672, 352.5557797175558, 355.48454740626084, 6438.098666186737, 6566.901496477557, 6600.339966003397, 6655.966720166404, 6739.191297044355, 6400.551961362695, 6493.772717954873, 6521.282658907517, 6560.048792925023, 6597.538172327939, 4887.071456423286, 4912.287718280847, 4919.11455937931, 4931.186354251544, 4937.901241975158, 4924.187509061001, 4930.950690493085, 4938.333325001115, 4941.555260026596, 4971.950280497203, 4844.031193761261, 4870.220764677652, 4892.902141957159, 4906.681065730734, 4908.950910490885, 4642.675012749109, 4799.016201678647, 4864.951350486503, 4895.8041678333, 4909.288153217782, 4206.116715489751, 4221.577842215754, 4223.303154979425, 4224.049588842486, 4229.429027081335, 6289.150964619764, 6295.968520157416, 6320.462760665349, 6368.458681012119, 6381.968090159566, 5746.080627099644, 5752.424757524256, 5763.596548241625, 5767.279090113736, 5777.422257774231, 6886.449084073262, 6894.931050689479, 6916.585004899722, 6925.065116209348, 6927.653617319113, 4569.0, 4689.929651055237, 4710.175719249118, 4733.502982186856, 4740.739259340735, 7182.676779544933, 7262.818429539251, 7264.20093789688, 7290.744823931137, 7301.415886729049, 4838.758062096881, 4842.15262329091, 4845.75771211438, 4866.975665121652, 4873.342098816685, 4907.214845624754, 4911.943932054625, 4920.5325494078725, 4936.259561065869, 4943.307936888838, 5710.885782284414, 5721.628094173865, 5736.799212027642, 5737.655740655574, 5758.62568933018, 6897.1033765611155, 6951.339622735832, 7005.1593808742255, 7009.334113259232, 7026.227115017344, 1747.3534792126995, 1766.055160489132, 1775.334249656379, 1777.2357886109098, 1784.1346946730825, 1070.0423121306387, 1117.0728295514866, 1129.5594718059963, 1139.2480962564832, 1153.798085335063, 6582.341765823475, 6730.730770769114, 6795.354441328066, 6821.113255276782, 6836.316368363224, 7238.963805180941, 7258.891116633255, 7292.96353518229, 7302.8174295641975, 7302.853942921111, 6758.121444212221, 6796.592204467748, 6803.523753337317, 6806.18325800907, 6842.076319696777, 3864.2851072551666, 3917.9216415671526, 3960.4257382679352, 3972.4041393790585, 3975.423563583322, 7521.962390188014, 7566.508176968479, 7608.429367797437, 7647.044119485065, 7761.767146985487, 7352.77941661751, 7365.079365079365, 7379.1513975892385, 7379.631018449056, 7381.261873812683, 7545.547267163988, 7555.622218889033, 7565.205653406533, 7569.886451703229, 7591.0, 7143.642817858982, 7255.0, 7277.672504737194, 7284.745033923788, 7339.302766237199, 7190.856182876418, 7225.458090643117, 7266.854662906607, 7278.818029549304, 7321.59731214767, 7544.358729507834, 7567.659455324413, 7569.432292577969, 7593.316601505891, 7600.239976002355, 4672.813087476598, 4673.415823022122, 4683.765811709469, 4684.718916864999, 4692.4369075709765, 7103.928960710534, 7211.206767255702, 7213.242609525924, 7238.27617238272, 7274.8908766367485, 7041.3310735480045, 7078.973548835493, 7100.467464940047, 7107.786766397016, 7150.356467917913, 7002.404795592432, 7031.824204394727, 7032.578045317297, 7036.311285291391, 7037.472189585904, 6782.389584937379, 6865.210500792473, 6878.209005964378, 6893.586384816927, 6907.6891539881835, 6976.162860456778, 7040.119985001875, 7099.893501597583, 7108.431325493844, 7120.786376408716, 6648.335166483313, 6877.58734475913, 6888.173419189729, 6892.655367231719, 6932.168139823253], "value": 5231.050570041253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.6210286422545, 854.1330549492267, 876.4828751036891, 886.31310734181, 930.9906900930989, 14892.77660835087, 14912.25438728062, 14956.25218739064, 14974.625634359147, 15028.924855375735, 13588.184708917448, 13663.658408539792, 13705.588832335021, 13738.313084345793, 13779.448822047107, 748.577053964511, 864.4813112132733, 893.3121496447732, 895.7088946092546, 900.653248499326, 905.9094090590954, 906.0441234497603, 907.5054095517926, 909.0909090909091, 913.6528119314651, 959.2853324273426, 961.6826447272383, 962.2542529539593, 964.9903500965006, 965.7633879699483, 951.7430293820698, 960.7165886063593, 963.3834346018554, 964.4599024546277, 966.1980556138388, 705.9752908648172, 706.2372637551432, 706.5654622407183, 709.6309918842225, 709.8544798316333, 13028.088033837636, 13085.934570327183, 13165.210087394787, 13194.868051319556, 13291.468341266338, 12498.875011249953, 12649.367531623382, 12824.0, 12996.415161317764, 13086.214827110309, 11022.008019278222, 11030.109352374231, 11059.557617695282, 11299.322040677504, 11453.026492748126, 3967.107400834818, 3976.264391087658, 4002.479677641917, 4022.557518672944, 4048.8785336439955, 55184.72407637936, 56670.716646416506, 58349.0, 58470.0, 58854.11718824221, 10838.729031774268, 11120.0, 11325.71685707864, 11652.30086194831, 11683.357415342238, 21153.471163220736, 21183.669796322392, 21245.0, 21245.575088498143, 21330.680039799416, 8341.16588341161, 8380.664773409117, 8628.223459888515, 8631.654733810577, 8793.956030219935, 4553.635709143261, 4594.816207351735, 4639.396878405853, 4726.007538416902, 4773.355596994431, 3317.6350601433824, 3392.0163152685936, 3399.201187720884, 3407.6762707542744, 3410.1815564264894, 564.8700798816295, 600.4115966352998, 604.3322129047427, 610.4688920639072, 611.8011646214998, 727.3017902813252, 753.3596443023387, 759.3659294489163, 767.769669099268, 785.7446329942677, 8516.148385161558, 8566.271866891384, 8636.395452318404, 8695.521746303888, 8888.200061994452, 496.13919849061847, 771.1915558016442, 773.1881524399358, 810.9148539403278, 819.7745619954441, 4043.1913617276073, 4200.558941311118, 4220.092680073799, 4301.720388174758, 4306.741595504217, 61770.69114654398, 63665.36334636687, 63861.680691596244, 63929.36070639327, 70948.64525677338, 58479.70760146172, 60238.69880650657, 60702.0, 62631.37368626255, 64452.67773661196, 54798.0, 54991.725041374535, 55152.172717409274, 55388.44611553913, 55446.72276638591, 9210.769730756785, 9300.860487092563, 9388.859167112361, 9450.763730906507, 9575.856362154434, 36332.63667363292, 37209.62790372062, 37236.81381593075, 37239.813800930824, 38551.0, 53558.46441535691, 54065.18902216391, 54350.45649543612, 54535.18197227124, 55159.17261241165, 12059.577914773292, 12316.938415307866, 12373.690657733629, 12516.812247816108, 12775.105742597929, 12871.292078935749, 13157.144785588906, 13522.459101636217, 13792.862071379157, 13832.170069795442, 11980.341081240615, 11992.280463171888, 12029.639110826689, 12312.199707019015, 12736.299503527394, 11752.647420577396, 11928.642140735792, 12021.398930053638, 12189.57336493254, 12289.877101228873, 12084.214526055779, 12220.69448263765, 12312.81530777057, 12423.130380873252, 12674.429650665557, 10252.179825614083, 10350.171986241234, 10680.305780124267, 10693.732656683645, 10705.839412408975, 10704.464776760975, 10991.450427478754, 11135.665930022113, 11170.218084733991, 11297.548098075986], "value": 6975.681939729239, "unit": "score"}], "name": "dromaeo_css", "value": 7330.323380740494, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 107.0, 113.0, 114.0, 116.0, 104.0, 112.0, 111.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 155.0, 175.0, 131.0, 155.0, 154.0, 132.0, 175.0, 140.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 169.0, 163.0, 176.0, 163.0, 165.0, 166.0, 166.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 85.0, 167.0, 74.0, 77.0, 74.0, 77.0, 158.0, 75.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 143.0, 94.0, 92.0, 93.0, 136.0, 93.0, 93.0, 135.0], "value": 106.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 118.0, 118.0, 119.0, 119.0, 119.0, 119.0, 120.0, 119.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 150.0, 149.0, 148.0, 147.0, 147.0, 149.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 95.0, 97.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 57.0, 56.0, 57.0, 56.0, 57.0, 68.0, 54.0, 54.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 62.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 77.0, 82.0, 76.0, 78.0, 80.0, 78.0, 76.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 133.0, 133.0, 122.0, 129.0, 117.0, 125.0, 120.0, 131.0, 133.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 163.0, 164.0, 165.0, 162.0, 165.0, 162.0, 166.0], "value": 163.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 68.0, 68.0, 65.0, 67.0, 66.0, 68.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1542.8000000000002, "alertThreshold": 2.0}]} 17:18:53 INFO - Return code: 0 17:18:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:18:53 ERROR - # TBPL SUCCESS # 17:18:53 INFO - Running post-action listener: _resource_record_post_action 17:18:53 INFO - Running post-run listener: _resource_record_post_run 17:18:54 INFO - Total resource usage - Wall time: 1183s; CPU: 25.0%; Read bytes: 266240; Write bytes: 496349184; Read time: 24; Write time: 398124 17:18:54 INFO - install - Wall time: 16s; CPU: 27.0%; Read bytes: 0; Write bytes: 255090688; Read time: 0; Write time: 256524 17:18:54 INFO - run-tests - Wall time: 1168s; CPU: 25.0%; Read bytes: 266240; Write bytes: 240660480; Read time: 24; Write time: 141600 17:18:54 INFO - Running post-run listener: _upload_blobber_files 17:18:54 INFO - Blob upload gear active. 17:18:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:54 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 17:18:54 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'] 17:18:54 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 17:18:54 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:18:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:18:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:55 INFO - (blobuploader) - INFO - Done attempting. 17:18:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:18:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:18:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:56 INFO - (blobuploader) - INFO - Done attempting. 17:18:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:56 INFO - Return code: 0 17:18:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57a566b42acbf06ede44aa7c12b5662092cecd5122ad86651d5fb5e2d92b2a536b694da1fead519811daa269d33a9b9b3fcb432570c42c0c6aeffd5f10a19fb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47437df9d7538b0d5868201145be574c744e40e7ec5c9e8b447e06582e157d0f3db2dd83b013857e75016519e670d3cffcc7aa523c25561baaad28cc0b5bbbbb"} 17:18:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:56 INFO - Contents: 17:18:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57a566b42acbf06ede44aa7c12b5662092cecd5122ad86651d5fb5e2d92b2a536b694da1fead519811daa269d33a9b9b3fcb432570c42c0c6aeffd5f10a19fb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47437df9d7538b0d5868201145be574c744e40e7ec5c9e8b447e06582e157d0f3db2dd83b013857e75016519e670d3cffcc7aa523c25561baaad28cc0b5bbbbb"} 17:18:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:56 INFO - Copying logs to upload dir... 17:18:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.884401 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-05-09 17:18:56.073979) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:18:56.077983) ========= 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=920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726 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/57a566b42acbf06ede44aa7c12b5662092cecd5122ad86651d5fb5e2d92b2a536b694da1fead519811daa269d33a9b9b3fcb432570c42c0c6aeffd5f10a19fb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47437df9d7538b0d5868201145be574c744e40e7ec5c9e8b447e06582e157d0f3db2dd83b013857e75016519e670d3cffcc7aa523c25561baaad28cc0b5bbbbb"} build_url:https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005405 build_url: 'https://queue.taskcluster.net/v1/task/KveNPLauTYCMM51QsZjpOA/artifacts/public/build/firefox-48.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/57a566b42acbf06ede44aa7c12b5662092cecd5122ad86651d5fb5e2d92b2a536b694da1fead519811daa269d33a9b9b3fcb432570c42c0c6aeffd5f10a19fb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47437df9d7538b0d5868201145be574c744e40e7ec5c9e8b447e06582e157d0f3db2dd83b013857e75016519e670d3cffcc7aa523c25561baaad28cc0b5bbbbb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 17:18:56.093247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:18:56.093596) ========= 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=920470bf432669ad7e3a5387000001ca-1462837852.614836-911354726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002181 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 17:18:56.175280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:18:56.175609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 17:18:56.175909) ========= ========= Total master_lag: 0.18 =========