builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1464145555.82 results: success (0) buildid: 20160524172038 builduid: 9fc0ea4b20ba4ca598a90d24ce8c98d6 revision: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:55.818998) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:55.819508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:55.819839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:55.833128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:55.833554) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 20:05:55-- 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% 23.4M=0s 2016-05-24 20:05:56 (23.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150671 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:55.999035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:55.999419) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020205 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:56.049394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 20:05:56.049790) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 14079be66b19b1fa8c60fa34239bcff57ca51ab0 --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 14079be66b19b1fa8c60fa34239bcff57ca51ab0 --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=337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 20:05:56,140 truncating revision to first 12 chars 2016-05-24 20:05:56,140 Setting DEBUG logging. 2016-05-24 20:05:56,140 attempt 1/10 2016-05-24 20:05:56,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/14079be66b19?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 20:05:57,380 unpacking tar archive at: mozilla-aurora-14079be66b19/testing/mozharness/ program finished with exit code 0 elapsedTime=1.508713 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 20:05:57.572944) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:57.573394) ========= script_repo_revision: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:57.573951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:57.574275) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 20:05:57.583963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-24 20:05:57.584389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:57 INFO - MultiFileLogger online at 20160524 20:05:57 in /builds/slave/test 20:05:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:05:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:57 INFO - {'append_to_log': False, 20:05:57 INFO - 'base_work_dir': '/builds/slave/test', 20:05:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:05:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:57 INFO - 'branch': 'Mozilla-Aurora', 20:05:57 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:57 INFO - 'config_files': ('talos/linux_config.py',), 20:05:57 INFO - 'default_actions': ('clobber', 20:05:57 INFO - 'read-buildbot-config', 20:05:57 INFO - 'download-and-extract', 20:05:57 INFO - 'populate-webroot', 20:05:57 INFO - 'create-virtualenv', 20:05:57 INFO - 'install', 20:05:57 INFO - 'run-tests'), 20:05:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:57 INFO - 'download_minidump_stackwalk': True, 20:05:57 INFO - 'download_symbols': 'ondemand', 20:05:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:57 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:57 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:57 INFO - 'installer_path': 'installer.exe', 20:05:57 INFO - 'log_level': 'info', 20:05:57 INFO - 'log_name': 'talos', 20:05:57 INFO - 'log_to_console': True, 20:05:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:57 INFO - 'opt_config_files': (), 20:05:57 INFO - 'pip_index': False, 20:05:57 INFO - 'sps_profile': False, 20:05:57 INFO - 'sps_profile_interval': 0, 20:05:57 INFO - 'suite': 'dromaeojs', 20:05:57 INFO - 'system_bits': '32', 20:05:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:57 INFO - 'title': 'talos-linux64-ix-060', 20:05:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:57 INFO - 'use_talos_json': True, 20:05:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:57 INFO - 'work_dir': 'build'} 20:05:57 INFO - ##### 20:05:57 INFO - ##### Running clobber step. 20:05:57 INFO - ##### 20:05:57 INFO - Running pre-action listener: _resource_record_pre_action 20:05:57 INFO - Running main action method: clobber 20:05:57 INFO - rmtree: /builds/slave/test/build 20:05:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:58 INFO - Running post-action listener: _resource_record_post_action 20:05:58 INFO - ##### 20:05:58 INFO - ##### Running read-buildbot-config step. 20:05:58 INFO - ##### 20:05:58 INFO - Running pre-action listener: _resource_record_pre_action 20:05:58 INFO - Running main action method: read_buildbot_config 20:05:58 INFO - Using buildbot properties: 20:05:58 INFO - { 20:05:58 INFO - "project": "", 20:05:58 INFO - "product": "firefox", 20:05:58 INFO - "script_repo_revision": "production", 20:05:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 20:05:58 INFO - "repository": "", 20:05:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 20:05:58 INFO - "buildid": "20160524172038", 20:05:58 INFO - "pgo_build": "True", 20:05:58 INFO - "basedir": "/builds/slave/test", 20:05:58 INFO - "buildnumber": 255, 20:05:58 INFO - "slavename": "talos-linux64-ix-060", 20:05:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:05:58 INFO - "platform": "ubuntu64_hw", 20:05:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 20:05:58 INFO - "branch": "mozilla-aurora", 20:05:58 INFO - "repo_path": "releases/mozilla-aurora", 20:05:58 INFO - "revision": "14079be66b19b1fa8c60fa34239bcff57ca51ab0", 20:05:58 INFO - "stage_platform": "linux64-pgo", 20:05:58 INFO - "builduid": "9fc0ea4b20ba4ca598a90d24ce8c98d6", 20:05:58 INFO - "slavebuilddir": "test" 20:05:58 INFO - } 20:05:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 20:05:58 INFO - Running post-action listener: _resource_record_post_action 20:05:58 INFO - ##### 20:05:58 INFO - ##### Running download-and-extract step. 20:05:58 INFO - ##### 20:05:58 INFO - Running pre-action listener: _resource_record_pre_action 20:05:58 INFO - Running main action method: download_and_extract 20:05:58 INFO - mkdir: /builds/slave/test/build/tests 20:05:58 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')]} 20:05:58 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:05:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:05:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:59 INFO - Downloaded 1361 bytes. 20:05:59 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 20:05:59 INFO - Using the following test package requirements: 20:05:59 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:05:59 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:59 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 20:05:59 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'jsshell-linux-x86_64.zip'], 20:05:59 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:59 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 20:05:59 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 20:05:59 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 20:05:59 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:59 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 20:05:59 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:59 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:59 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:06:00 INFO - Downloaded 24136092 bytes. 20:06:00 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'] 20:06:00 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 20:06:01 INFO - Return code: 0 20:06:01 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 20:06:01 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')]} 20:06:01 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:06:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:06:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 20:06:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:06:02 INFO - Downloaded 24136092 bytes. 20:06:02 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'] 20:06:02 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 20:06:04 INFO - Return code: 0 20:06: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')]} 20:06:04 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:06:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:06:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 20:06:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:06:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:06:05 INFO - Downloaded 10840145 bytes. 20:06:05 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'] 20:06:05 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 20:06:05 INFO - Return code: 0 20:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:05 INFO - https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:06:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:06:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:06:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/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 20:06:06 INFO - Downloaded 62733260 bytes. 20:06:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:06:06 INFO - mkdir: /builds/slave/test/properties 20:06:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:06 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:06 INFO - Contents: 20:06:06 INFO - build_url:https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 20:06:07 INFO - Running post-action listener: _resource_record_post_action 20:06:07 INFO - Running post-action listener: set_extra_try_arguments 20:06:07 INFO - ##### 20:06:07 INFO - ##### Running populate-webroot step. 20:06:07 INFO - ##### 20:06:07 INFO - Running pre-action listener: _resource_record_pre_action 20:06:07 INFO - Running main action method: populate_webroot 20:06:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:07 INFO - '--tppagecycles', 20:06:07 INFO - '7'], 20:06:07 INFO - 'tests': ['tsvgm']}}, 20:06:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['damp', 'tps']}, 20:06:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'tests': ['damp', 'tps']}, 20:06:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['dromaeo_dom']}, 20:06:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['a11yr', 20:06:07 INFO - 'ts_paint', 20:06:07 INFO - 'tpaint', 20:06:07 INFO - 'sessionrestore', 20:06:07 INFO - 'sessionrestore_no_auto_restore', 20:06:07 INFO - 'tabpaint']}, 20:06:07 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:07 INFO - 'ts_paint', 20:06:07 INFO - 'tpaint', 20:06:07 INFO - 'sessionrestore', 20:06:07 INFO - 'sessionrestore_no_auto_restore', 20:06:07 INFO - 'tabpaint']}, 20:06:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:07 INFO - 'ts_paint', 20:06:07 INFO - 'tpaint', 20:06:07 INFO - 'sessionrestore', 20:06:07 INFO - 'sessionrestore_no_auto_restore', 20:06:07 INFO - 'tabpaint']}, 20:06:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:07 INFO - 'ts_paint', 20:06:07 INFO - 'tpaint', 20:06:07 INFO - 'sessionrestore', 20:06:07 INFO - 'sessionrestore_no_auto_restore', 20:06:07 INFO - 'tabpaint']}, 20:06:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['a11yr', 20:06:07 INFO - 'ts_paint', 20:06:07 INFO - 'tpaint', 20:06:07 INFO - 'sessionrestore', 20:06:07 INFO - 'sessionrestore_no_auto_restore', 20:06:07 INFO - 'tabpaint']}, 20:06:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['a11yr', 20:06:07 INFO - 'ts_paint', 20:06:07 INFO - 'tpaint', 20:06:07 INFO - 'sessionrestore', 20:06:07 INFO - 'sessionrestore_no_auto_restore', 20:06:07 INFO - 'tabpaint']}, 20:06:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['tsvgx', 20:06:07 INFO - 'tsvgr_opacity', 20:06:07 INFO - 'tart', 20:06:07 INFO - 'tscrollx', 20:06:07 INFO - 'cart']}, 20:06:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:07 INFO - 'tsvgr_opacity', 20:06:07 INFO - 'tart', 20:06:07 INFO - 'tscrollx', 20:06:07 INFO - 'cart']}, 20:06:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'talos_options': ['--disable-e10s'], 20:06:07 INFO - 'tests': ['tp5o']}, 20:06:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'tests': ['tp5o']}, 20:06:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'talos_options': ['--disable-e10s', 20:06:07 INFO - '--xperf_path', 20:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:07 INFO - 'tests': ['tp5n']}, 20:06:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:07 INFO - 'talos_options': ['--xperf_path', 20:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:07 INFO - 'tests': ['tp5n']}}, 20:06:07 INFO - 'talos.zip': {'path': '', 20:06:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:07 INFO - Running post-action listener: _resource_record_post_action 20:06:07 INFO - ##### 20:06:07 INFO - ##### Running create-virtualenv step. 20:06:07 INFO - ##### 20:06:07 INFO - Running pre-action listener: _resource_record_pre_action 20:06:07 INFO - Running main action method: create_virtualenv 20:06:07 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:07 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 20:06:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:07 INFO - Using real prefix '/usr' 20:06:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:08 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:10 INFO - Installing pip.................done. 20:06:10 INFO - Return code: 0 20:06:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 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 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:10 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 20:06:10 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 20:06:10 INFO - Using env: {'DISPLAY': ':0', 20:06:10 INFO - 'HOME': '/home/cltbld', 20:06:10 INFO - 'LANG': 'en_US.UTF-8', 20:06:10 INFO - 'LANGUAGE': 'en_US:en', 20:06:10 INFO - 'LOGNAME': 'cltbld', 20:06:10 INFO - 'MAIL': '/var/mail/cltbld', 20:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:10 INFO - 'MOZ_NO_REMOTE': '1', 20:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:10 INFO - 'NO_EM_RESTART': '1', 20:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:10 INFO - 'PWD': '/builds/slave/test', 20:06:10 INFO - 'SHELL': '/bin/bash', 20:06:10 INFO - 'SHLVL': '1', 20:06:10 INFO - 'TERM': 'linux', 20:06:10 INFO - 'TMOUT': '86400', 20:06:10 INFO - 'USER': 'cltbld', 20:06:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:10 INFO - '_': '/tools/buildbot/bin/python'} 20:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:10 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 20:06:10 INFO - Cleaning up... 20:06:10 INFO - Return code: 0 20:06:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:10 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 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:10 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 20:06:10 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 20:06:10 INFO - Using env: {'DISPLAY': ':0', 20:06:10 INFO - 'HOME': '/home/cltbld', 20:06:10 INFO - 'LANG': 'en_US.UTF-8', 20:06:10 INFO - 'LANGUAGE': 'en_US:en', 20:06:10 INFO - 'LOGNAME': 'cltbld', 20:06:10 INFO - 'MAIL': '/var/mail/cltbld', 20:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:10 INFO - 'MOZ_NO_REMOTE': '1', 20:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:10 INFO - 'NO_EM_RESTART': '1', 20:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:10 INFO - 'PWD': '/builds/slave/test', 20:06:10 INFO - 'SHELL': '/bin/bash', 20:06:10 INFO - 'SHLVL': '1', 20:06:10 INFO - 'TERM': 'linux', 20:06:10 INFO - 'TMOUT': '86400', 20:06:10 INFO - 'USER': 'cltbld', 20:06:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:10 INFO - '_': '/tools/buildbot/bin/python'} 20:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:10 INFO - Downloading/unpacking psutil>=0.7.1 20:06:10 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 20:06:10 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 20:06:10 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 20:06:10 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 20:06:10 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 20:06:10 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 20:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:12 INFO - Installing collected packages: psutil 20:06:12 INFO - Running setup.py install for psutil 20:06:12 INFO - building 'psutil._psutil_linux' extension 20:06:12 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 20:06:12 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 20:06:12 INFO - building 'psutil._psutil_posix' extension 20:06:12 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 20:06:12 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 20:06:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:12 INFO - Successfully installed psutil 20:06:12 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:13 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 20:06:13 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 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:13 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 20:06:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:06:15 INFO - Installing collected packages: mozsystemmonitor 20:06:15 INFO - Running setup.py install for mozsystemmonitor 20:06:15 INFO - Successfully installed mozsystemmonitor 20:06:15 INFO - Cleaning up... 20:06:15 INFO - Return code: 0 20:06:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:15 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')]} 20:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:15 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')]} 20:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:15 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 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:15 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 20:06:15 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 20:06:15 INFO - Using env: {'DISPLAY': ':0', 20:06:15 INFO - 'HOME': '/home/cltbld', 20:06:15 INFO - 'LANG': 'en_US.UTF-8', 20:06:15 INFO - 'LANGUAGE': 'en_US:en', 20:06:15 INFO - 'LOGNAME': 'cltbld', 20:06:15 INFO - 'MAIL': '/var/mail/cltbld', 20:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:15 INFO - 'MOZ_NO_REMOTE': '1', 20:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:15 INFO - 'NO_EM_RESTART': '1', 20:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:15 INFO - 'PWD': '/builds/slave/test', 20:06:15 INFO - 'SHELL': '/bin/bash', 20:06:15 INFO - 'SHLVL': '1', 20:06:15 INFO - 'TERM': 'linux', 20:06:15 INFO - 'TMOUT': '86400', 20:06:15 INFO - 'USER': 'cltbld', 20:06:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:15 INFO - '_': '/tools/buildbot/bin/python'} 20:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:15 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 20:06:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:18 INFO - Downloading docopt-0.6.1.tar.gz 20:06:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:18 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:18 INFO - Running setup.py install for blobuploader 20:06:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:18 INFO - Running setup.py install for requests 20:06:18 INFO - Running setup.py install for docopt 20:06:18 INFO - Successfully installed blobuploader requests docopt 20:06:18 INFO - Cleaning up... 20:06:18 INFO - Return code: 0 20:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:18 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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:18 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 20:06:18 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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:19 INFO - Running setup.py (path:/tmp/pip-O8wjOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:19 INFO - Running setup.py (path:/tmp/pip-zJsI3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:19 INFO - Running setup.py (path:/tmp/pip-FfyrLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:19 INFO - Running setup.py (path:/tmp/pip-PG5cAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:19 INFO - Running setup.py (path:/tmp/pip-cijLKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:19 INFO - Running setup.py (path:/tmp/pip-cSepGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:19 INFO - Running setup.py (path:/tmp/pip-Axh07m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:19 INFO - Running setup.py (path:/tmp/pip-Jyam5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:19 INFO - Running setup.py (path:/tmp/pip-my4et3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:19 INFO - Running setup.py (path:/tmp/pip-YlL9Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:19 INFO - Running setup.py (path:/tmp/pip-LKkhE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:19 INFO - Running setup.py (path:/tmp/pip-roFz8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:19 INFO - Running setup.py (path:/tmp/pip-k2KiYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:19 INFO - Running setup.py (path:/tmp/pip-D6b7DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:20 INFO - Running setup.py (path:/tmp/pip-0yJ0Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:20 INFO - Running setup.py (path:/tmp/pip-HxLyQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:20 INFO - Running setup.py (path:/tmp/pip-FtSKth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:20 INFO - Running setup.py install for manifestparser 20:06:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:20 INFO - Running setup.py install for mozcrash 20:06:20 INFO - Running setup.py install for mozdebug 20:06:20 INFO - Running setup.py install for mozdevice 20:06:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:20 INFO - Running setup.py install for mozfile 20:06:20 INFO - Running setup.py install for mozhttpd 20:06:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:20 INFO - Running setup.py install for mozinfo 20:06:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:20 INFO - Running setup.py install for mozInstall 20:06:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Running setup.py install for mozleak 20:06:21 INFO - Running setup.py install for mozlog 20:06:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Running setup.py install for moznetwork 20:06:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Running setup.py install for mozprocess 20:06:21 INFO - Running setup.py install for mozprofile 20:06:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Running setup.py install for mozrunner 20:06:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:21 INFO - Running setup.py install for mozscreenshot 20:06:21 INFO - Running setup.py install for moztest 20:06:21 INFO - Running setup.py install for mozversion 20:06:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:22 INFO - Cleaning up... 20:06:22 INFO - Return code: 0 20:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:22 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')]} 20:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:22 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')]} 20:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:22 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 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:22 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 20:06:22 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 20:06:22 INFO - Using env: {'DISPLAY': ':0', 20:06:22 INFO - 'HOME': '/home/cltbld', 20:06:22 INFO - 'LANG': 'en_US.UTF-8', 20:06:22 INFO - 'LANGUAGE': 'en_US:en', 20:06:22 INFO - 'LOGNAME': 'cltbld', 20:06:22 INFO - 'MAIL': '/var/mail/cltbld', 20:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:22 INFO - 'MOZ_NO_REMOTE': '1', 20:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:22 INFO - 'NO_EM_RESTART': '1', 20:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:22 INFO - 'PWD': '/builds/slave/test', 20:06:22 INFO - 'SHELL': '/bin/bash', 20:06:22 INFO - 'SHLVL': '1', 20:06:22 INFO - 'TERM': 'linux', 20:06:22 INFO - 'TMOUT': '86400', 20:06:22 INFO - 'USER': 'cltbld', 20:06:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:22 INFO - '_': '/tools/buildbot/bin/python'} 20:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:22 INFO - Running setup.py (path:/tmp/pip-gllG59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:22 INFO - Running setup.py (path:/tmp/pip-qm8VT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:22 INFO - Running setup.py (path:/tmp/pip-BKZcOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:22 INFO - Running setup.py (path:/tmp/pip-CeSiOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:22 INFO - Running setup.py (path:/tmp/pip-BmoKFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:22 INFO - Running setup.py (path:/tmp/pip-kiqpVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:22 INFO - Running setup.py (path:/tmp/pip-dfP4Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:22 INFO - Running setup.py (path:/tmp/pip-n7V8L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:22 INFO - Running setup.py (path:/tmp/pip-T7JVl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:22 INFO - Running setup.py (path:/tmp/pip-WdDYVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:22 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)) 20:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:22 INFO - Running setup.py (path:/tmp/pip-Qn_fv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:23 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)) 20:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:23 INFO - Running setup.py (path:/tmp/pip-K_KejG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:23 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)) 20:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:23 INFO - Running setup.py (path:/tmp/pip-llODm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:23 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)) 20:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:23 INFO - Running setup.py (path:/tmp/pip-GUxsqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:23 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)) 20:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:23 INFO - Running setup.py (path:/tmp/pip-yA7SrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:23 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)) 20:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:23 INFO - Running setup.py (path:/tmp/pip-ZijKTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:23 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)) 20:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:23 INFO - Running setup.py (path:/tmp/pip-zO4Mg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:23 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)) 20:06:23 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)) 20:06:23 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)) 20:06:23 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)) 20:06:23 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)) 20:06:23 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)) 20:06:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:25 INFO - Downloading blessings-1.6.tar.gz 20:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:25 INFO - Installing collected packages: blessings 20:06:25 INFO - Running setup.py install for blessings 20:06:25 INFO - Successfully installed blessings 20:06:25 INFO - Cleaning up... 20:06:25 INFO - Return code: 0 20:06:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:25 INFO - Reading from file tmpfile_stdout 20:06:25 INFO - Current package versions: 20:06:25 INFO - argparse == 1.2.1 20:06:25 INFO - blessings == 1.6 20:06:25 INFO - blobuploader == 1.2.4 20:06:25 INFO - docopt == 0.6.1 20:06:25 INFO - manifestparser == 1.1 20:06:25 INFO - mozInstall == 1.12 20:06:25 INFO - mozcrash == 0.17 20:06:25 INFO - mozdebug == 0.1 20:06:25 INFO - mozdevice == 0.48 20:06:25 INFO - mozfile == 1.2 20:06:25 INFO - mozhttpd == 0.7 20:06:25 INFO - mozinfo == 0.9 20:06:25 INFO - mozleak == 0.1 20:06:25 INFO - mozlog == 3.1 20:06:25 INFO - moznetwork == 0.27 20:06:25 INFO - mozprocess == 0.22 20:06:25 INFO - mozprofile == 0.28 20:06:25 INFO - mozrunner == 6.11 20:06:25 INFO - mozscreenshot == 0.1 20:06:25 INFO - mozsystemmonitor == 0.0 20:06:25 INFO - moztest == 0.7 20:06:25 INFO - mozversion == 1.4 20:06:25 INFO - psutil == 3.1.1 20:06:25 INFO - requests == 1.2.3 20:06:25 INFO - wsgiref == 0.1.2 20:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:25 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 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:25 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 20:06:25 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 20:06:25 INFO - Using env: {'DISPLAY': ':0', 20:06:25 INFO - 'HOME': '/home/cltbld', 20:06:25 INFO - 'LANG': 'en_US.UTF-8', 20:06:25 INFO - 'LANGUAGE': 'en_US:en', 20:06:25 INFO - 'LOGNAME': 'cltbld', 20:06:25 INFO - 'MAIL': '/var/mail/cltbld', 20:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:25 INFO - 'MOZ_NO_REMOTE': '1', 20:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:25 INFO - 'NO_EM_RESTART': '1', 20:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:25 INFO - 'PWD': '/builds/slave/test', 20:06:25 INFO - 'SHELL': '/bin/bash', 20:06:25 INFO - 'SHLVL': '1', 20:06:25 INFO - 'TERM': 'linux', 20:06:25 INFO - 'TMOUT': '86400', 20:06:25 INFO - 'USER': 'cltbld', 20:06:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:25 INFO - '_': '/tools/buildbot/bin/python'} 20:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 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)) 20:06:26 INFO - Cleaning up... 20:06:26 INFO - Return code: 0 20:06:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:06:26 INFO - Using env: {'DISPLAY': ':0', 20:06:26 INFO - 'HOME': '/home/cltbld', 20:06:26 INFO - 'LANG': 'en_US.UTF-8', 20:06:26 INFO - 'LANGUAGE': 'en_US:en', 20:06:26 INFO - 'LOGNAME': 'cltbld', 20:06:26 INFO - 'MAIL': '/var/mail/cltbld', 20:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:26 INFO - 'MOZ_NO_REMOTE': '1', 20:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:26 INFO - 'NO_EM_RESTART': '1', 20:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:26 INFO - 'PWD': '/builds/slave/test', 20:06:26 INFO - 'SHELL': '/bin/bash', 20:06:26 INFO - 'SHLVL': '1', 20:06:26 INFO - 'TERM': 'linux', 20:06:26 INFO - 'TMOUT': '86400', 20:06:26 INFO - 'USER': 'cltbld', 20:06:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:26 INFO - '_': '/tools/buildbot/bin/python'} 20:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:26 INFO - Downloading/unpacking jsonschema 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:28 INFO - Downloading/unpacking functools32 (from jsonschema) 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:28 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:28 INFO - warning: no files found matching '*.txt' 20:06:28 INFO - no previously-included directories found matching 'build' 20:06:28 INFO - no previously-included directories found matching 'dist' 20:06:28 INFO - no previously-included directories found matching '.git*' 20:06:28 INFO - Installing collected packages: jsonschema, functools32 20:06:28 INFO - Running setup.py install for functools32 20:06:28 INFO - warning: no files found matching '*.txt' 20:06:28 INFO - no previously-included directories found matching 'build' 20:06:28 INFO - no previously-included directories found matching 'dist' 20:06:28 INFO - no previously-included directories found matching '.git*' 20:06:28 INFO - Successfully installed jsonschema functools32 20:06:28 INFO - Cleaning up... 20:06:28 INFO - Return code: 0 20:06:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd9ac92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, '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': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', '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 20:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:06:28 INFO - Using env: {'DISPLAY': ':0', 20:06:28 INFO - 'HOME': '/home/cltbld', 20:06:28 INFO - 'LANG': 'en_US.UTF-8', 20:06:28 INFO - 'LANGUAGE': 'en_US:en', 20:06:28 INFO - 'LOGNAME': 'cltbld', 20:06:28 INFO - 'MAIL': '/var/mail/cltbld', 20:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:28 INFO - 'MOZ_NO_REMOTE': '1', 20:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:28 INFO - 'NO_EM_RESTART': '1', 20:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:28 INFO - 'PWD': '/builds/slave/test', 20:06:28 INFO - 'SHELL': '/bin/bash', 20:06:28 INFO - 'SHLVL': '1', 20:06:28 INFO - 'TERM': 'linux', 20:06:28 INFO - 'TMOUT': '86400', 20:06:28 INFO - 'USER': 'cltbld', 20:06:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:28 INFO - '_': '/tools/buildbot/bin/python'} 20:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:28 INFO - Downloading/unpacking flake8 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:31 INFO - no previously-included directories found matching 'docs/_build' 20:06:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:31 INFO - Running setup.py install for pep8 20:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:31 INFO - no previously-included directories found matching 'docs/_build' 20:06:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:31 INFO - Cleaning up... 20:06:31 INFO - Return code: 0 20:06:31 INFO - Running post-action listener: _resource_record_post_action 20:06:31 INFO - Running post-action listener: _start_resource_monitoring 20:06:31 INFO - Starting resource monitoring. 20:06:31 INFO - ##### 20:06:31 INFO - ##### Running install step. 20:06:31 INFO - ##### 20:06:31 INFO - Running pre-action listener: _resource_record_pre_action 20:06:31 INFO - Running main action method: install 20:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:31 INFO - Reading from file tmpfile_stdout 20:06:31 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:31 INFO - Reading from file tmpfile_stdout 20:06:31 INFO - Output received: 20:06:31 INFO - Usage: mozinstall [options] installer 20:06:31 INFO - Options: 20:06:31 INFO - -h, --help show this help message and exit 20:06:31 INFO - -d DEST, --destination=DEST 20:06:31 INFO - Directory to install application into. [default: 20:06:31 INFO - "/builds/slave/test"] 20:06:31 INFO - --app=APP Application being installed. [default: firefox] 20:06:31 INFO - mkdir: /builds/slave/test/build/application 20:06:31 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'] 20:06:31 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 20:06:47 INFO - Reading from file tmpfile_stdout 20:06:47 INFO - Output received: 20:06:47 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:47 INFO - Running post-action listener: _resource_record_post_action 20:06:47 INFO - ##### 20:06:47 INFO - ##### Running run-tests step. 20:06:47 INFO - ##### 20:06:47 INFO - Running pre-action listener: _resource_record_pre_action 20:06:47 INFO - Running main action method: run_tests 20:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:47 INFO - Python 2.7.3 20:06:47 INFO - Return code: 0 20:06:47 INFO - grabbing minidump binary from tooltool 20:06:47 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')]} 20:06:47 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 0x2ac2410>, '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 0x2ac3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:47 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 20:06:47 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 20:06:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:47 INFO - Return code: 0 20:06:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:06:48 INFO - Return code: 0 20:06:48 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:06:48 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:06:48 INFO - Using env: {'DISPLAY': ':0', 20:06:48 INFO - 'HOME': '/home/cltbld', 20:06:48 INFO - 'LANG': 'en_US.UTF-8', 20:06:48 INFO - 'LANGUAGE': 'en_US:en', 20:06:48 INFO - 'LOGNAME': 'cltbld', 20:06:48 INFO - 'MAIL': '/var/mail/cltbld', 20:06:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:48 INFO - 'MOZ_NO_REMOTE': '1', 20:06:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:48 INFO - 'NO_EM_RESTART': '1', 20:06:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:48 INFO - 'PWD': '/builds/slave/test', 20:06:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:48 INFO - 'SHELL': '/bin/bash', 20:06:48 INFO - 'SHLVL': '1', 20:06:48 INFO - 'TERM': 'linux', 20:06:48 INFO - 'TMOUT': '86400', 20:06:48 INFO - 'USER': 'cltbld', 20:06:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366', 20:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:48 INFO - '_': '/tools/buildbot/bin/python'} 20:06:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:06:48 INFO - mozversion application_buildid: 20160524172038 20:06:48 INFO - mozversion application_changeset: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 20:06:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:06:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:48 INFO - mozversion application_name: Firefox 20:06:48 INFO - mozversion application_remotingname: firefox-dev 20:06:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:06:48 INFO - mozversion application_vendor: Mozilla 20:06:48 INFO - mozversion application_version: 48.0a2 20:06:48 INFO - mozversion platform_buildid: 20160524172038 20:06:48 INFO - mozversion platform_changeset: 14079be66b19b1fa8c60fa34239bcff57ca51ab0 20:06:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:06:48 INFO - mozversion platform_version: 48.0a2 20:06:48 INFO - using testdate: 1464145608 20:06:48 INFO - actual date: 1464145608 20:06:48 INFO - starting webserver on 'localhost:54500' 20:06:48 INFO - SUITE-START | Running 2 tests 20:06:48 INFO - TEST-START | dromaeo_css 20:06:48 INFO - operating with platform_type : linux_ 20:06:48 INFO - Initialising browser for dromaeo_css test... 20:06:48 INFO - TEST-INFO | started process 14063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyB1Kfh/profile http://localhost:54500/getInfo.html) 20:06:52 INFO - PROCESS | 14063 | __metrics Screen width/height:1600/1200 20:06:52 INFO - PROCESS | 14063 | colorDepth:24 20:06:52 INFO - PROCESS | 14063 | Browser inner width/height: 1024/697 20:06:52 INFO - PROCESS | 14063 | __metrics 20:06:53 ERROR - PROCESS | 14063 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:06:54 INFO - TEST-INFO | 14063: exit 0 20:06:54 INFO - Browser initialized. 20:06:54 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:54 INFO - TEST-INFO | started process 14154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyB1Kfh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:06 INFO - PROCESS | 14154 | RSS: Main: 141869056 20:07:06 INFO - PROCESS | 14154 | 20:07:57 INFO - PROCESS | 14154 | 1464145677558 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] 20:10:05 INFO - PROCESS | 14154 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54500/tests/dromaeo/cssquery-ext.html) 20:10:06 INFO - PROCESS | 14154 | RSS: Main: 256028672 20:10:06 INFO - PROCESS | 14154 | 20:13:08 INFO - PROCESS | 14154 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-ext.html (next: http://localhost:54500/tests/dromaeo/cssquery-jquery.html) 20:13:08 INFO - PROCESS | 14154 | RSS: Main: 217931776 20:13:08 INFO - PROCESS | 14154 | 20:16:10 INFO - PROCESS | 14154 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54500/tests/dromaeo/cssquery-mootools.html) 20:16:11 INFO - PROCESS | 14154 | RSS: Main: 214147072 20:16:11 INFO - PROCESS | 14154 | 20:19:13 INFO - PROCESS | 14154 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54500/tests/dromaeo/cssquery-prototype.html) 20:19:13 INFO - PROCESS | 14154 | RSS: Main: 218636288 20:19:13 INFO - PROCESS | 14154 | 20:22:16 INFO - PROCESS | 14154 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54500/tests/dromaeo/cssquery-yui.html) 20:22:16 INFO - PROCESS | 14154 | RSS: Main: 212430848 20:22:16 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | Cycle 1(1): loaded http://localhost:54500/tests/dromaeo/cssquery-yui.html (next: http://localhost:54500/tests/dromaeo/cssquery-dojo.html) 20:25:19 INFO - PROCESS | 14154 | RSS: Main: 259772416 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | __start_tp_report 20:25:19 INFO - PROCESS | 14154 | _x_x_mozilla_page_load 20:25:19 INFO - PROCESS | 14154 | _x_x_mozilla_page_load_details 20:25:19 INFO - PROCESS | 14154 | |i|pagename|runs| 20:25:19 INFO - PROCESS | 14154 | |0;dojo.html;3307.8180700061494;3381.6787405196496;3387.441072223083;3408.965910340896;3416.9487457688138;5557.6109672322955;5582.5254853337465;5599.7480113394895;5606.21512988182;5608.074667679828;5585.3297604287445;5640.294963129609;5641.943580564193;5643.209950606918;5644.068728659766;4835.685680430778;5070.67040642358;5157.742112894341;5199.610029247802;5228.372595288571;5005.199168133099;5083.923741143886;5087.949120508803;5088.363954505687;5089.389273287211;5033.295338652591;5058.696478211301;5069.569086627623;5074.13739664258;5080.822171224008;5106.693598384109;5142.408623008365;5151.639385243035;5154.4072431670465;5188.6367954243215;4927.359443272388;4977.1538838397555;5041.873953151164;5049.671771334888;5055.74721263939;5333.706646134461;5403.810866619689;5451.454854514556;5460.972695136499;5477.370102438231;5770.711464426804;5773.451522105393;5775.902578510069;5777.913331300034;5784.68184249866;5863.413658634145;5975;6086.522130082916;6101.420365065312;6141.969290153521;5603.691796951166;5641.041023026054;5647.802326918538;5654.293213348332;5655.293088363914;5921.881562368814;6132.448079672851;6160.599561028519;6167.982282923357;6168.19813424252;5827.24245848037;5865.736041878125;5870.119482077637;5880.117982302689;5889.146073819272;5893.086571581412;5896.823095307148;5900.291964964232;5901.468867801918;5904.055351143882;5806.274215723035;5865.94134058654;5866.325372582122;5873.471387575139;5913.2608423947;5818.6217895836635;5819.621724587888;5824.941750582525;5825.650460972271;5862.325832529228;4450.109978004412;4460.0633866887665;4461.397711308931;4477.3731677565165;4490.977545112253;4027.4160246764054;4035.778032208198;4057.229126465962;4058.228936502055;4118.094019315806;5675.943240567624;5694.259746233046;5697.6296540724725;5700.629459085146;5715.942840571541;5968.850778730566;5969.522438204933;5969.641821490724;5972.8805423892145;5978.461938425563;5441.646292990943;5598.86002849932;5692.459216374438;5694.914576281359;5697.658140511582;5079.974600126976;5092.872678183001;5093.2105523643895;5094.057599344133;5102.030614183293;6146.569740118149;6147.385261473906;6147.569670123138;6150.3849615039035;6151.72317245716;5907.940920590825;6019.277686677627;6059.0608455689435;6098.573099882966;6120.418560236771;6104.908426373519;6118.541109416722;6122.357152498924;6128.264608247039;6128.448439640276;5731.799387021434;5766.94233057664;5770.740316685843;5773.942260577341;5775.9133612995;5928.051511758271;5983.940160598512;5984.281886173687;5986.910196346971;6022.307434645072;5799.884002319845;5815.709214539172;5828.388019258086;5830.2129212555765;5834.533237340917;5748.109043098327;5760.94239057604;5796.0436527972415;5800.477956983892;5839.854003649943;5752.395998420106;5760.0783874579865;5763.250777398911;5763.567732420169;5799.043157878903;5840.328362238227;5858.560607954506;5869.413058694267;5873.119032145212;5900.055991041413;5624.550035997192;5704.486596206361;5711.8000869969355;5781.132830075354;5802.65184088956 20:25:19 INFO - PROCESS | 14154 | |1;ext.html;667.4260136282796;685.5920727167335;686.9141357330337;738.0000099864685;749.1571981520789;34684.47973280399;41595.37606935894;41720.16559668805;41923;41953;44825;45672.77163614186;45731.08537829242;45744;45769.54230457703;8154.184581541828;8753.16844899735;8944.776380590472;10279.948600256988;10496.580136794519;10376.169906407507;10500.264981451262;10502.527386267637;10504.474776261195;10513.947430262877;10488.632897848576;10538.104261137813;10545;10553.366797992107;10554.630587929423;8433.114522975091;10226.590936362536;10392.06471417576;10398.272120951537;10399.220058495643;10479.161667066617;10553.894461055444;10563.73590660232;10595.25833191677;10604.840927386096;40769.38845917313;41524.584754152376;41546.79226603878;41570.37644435336;41606.79196604028;3825.387937929918;3855.9421608675893;4415.470143582758;4503.166914120898;4668.813247470097;34602.6539734602;34841.82579087114;35084;35262.47106293408;35435;4543.250363689987;4625.4911959684405;4677.4620918594455;4694.413198350207;4714.740689262089;334154;336060;336816;336874;337832.3108384467;40554.39168412476;40805;65800;67331.66334168396;67353.66323168353;38276.23447531034;38422.23155536874;38721.61278387236;38730.22539549193;38736.418953715714;16703.6659266814;17686.380976665754;17881.910590446965;17890.373836915645;17893.19480623375;15184.316705748268;15467;15472.458463953708;15481.845181548266;15531.301091450912;9238.307126965505;9260.768480788034;9266.768330791785;9302.674406395743;9316.068393160765;3545.840437180333;3630.09247688078;3631.2737452509605;3671.7796932184156;3689.6310368963427;1147.9483423245974;1157.1552766480347;1166.119579717325;1237.9876201238053;1299.818025476434;33638.327233455195;33719.22662415417;33940.1514962123;33997;34655.30689386198;1275.8787915148046;1281.423359488234;1329.946802127904;1331.3609467455676;1333.1800942420537;17715.55711107207;17754.5561360967;17800.287988480573;18142.45572632823;18303.26786928508;498478;498555;501321;502611;503789;64794;65212;65312.67343663251;65337.346626534076;65418.67290663516;1374.7731624281882;1476.9778453323424;1524.1921781455846;1601.9587268275714;1621.9862585883823;31691.52462713015;33707.91004168396;33725.662743373236;34151;34211;49751.502484974684;49915.75042124766;50169.99660006706;50184.49815501798;50254.74872625613;306195;306405;306849;307312;308023;27882.721172788824;31284.37431251408;31814;32099.358012839144;32261.677383225866;45415.545844541135;46101.76949115233;47205.527944721485;47254.291185631555;54867.45132548783;41693.374599380426;41937;42007.78996105;42153.156936861706;42955.7852210737;41437.79281103575;42445.363319549615;42684.146317074104;43383.783081084395;43555;43006;43321.78339108411;43620.78189609032;44116.77941610271;44276.33585496156;35722.642773572974;37340;37724.62275377211;37933.430998534495;38659.42010869783;28863.090073107593;29090;29121.7087829119;29355.41289174162;29631.555526667547 20:25:19 INFO - PROCESS | 14154 | |2;jquery.html;423.6907057847769;426.6224391413599;431.81494766697256;442.1628135098665;449.63130233208784;18789.060546972665;18833.246670133194;19515.512112197186;19621.70567441486;19773.406797796088;18905.62188756224;19153.329633462832;19870.205191792313;19880.10539525721;19911.40265792025;5715.428457154272;5780.306363236417;5935.10973353996;5939.198208241897;5946.672932988684;5865.120231965218;5935.10973353996;5939;5948.732307046172;5951.821445356646;5689.288838895138;5914.674692891889;5925.940740592582;5935.080062590306;5936.614120082181;5863.472287494124;5867.647941123525;5876.2067120938555;5882.5588080893895;5884.823455296348;5217.113090774577;5303.443138470482;5450.890982180374;5457.454254574551;5469.07025805614;14447.711045779131;14569.417223311055;17775.466735997812;23513.17703880356;23533.76466235333;2540.1109611635966;2647.6160956661174;2771.3348796288947;2899.7390234878962;2928.3557617324154;10013.949930250303;10364.067233948981;10670.893291067068;10771.946140269327;10872.238943273975;2052.48687828043;2061.072517367191;2100.705901173837;2138.893055347242;2183.6724491326268;78787.6060619699;83312.58343708303;86553;86695;87176.564117179;11587.536498540132;11655.708607284716;11677.35774532392;11693.88306116945;11759.17732751425;16635.334586616642;16779;16783;16795.580110497336;16820.6635867282;9071.228945539571;9086.45481271126;9192.310576706774;9235.353525253302;9343.626254949726;9013.594388252544;9090.727278181534;9091.681791137278;9183.632654693738;9260.7684807879;4962.851114466572;5001.174806156943;5031.874203144877;5055.87360315995;5108.565771909355;2036.7553549609813;2042.805933436321;2055.3320170944503;2061.7835127311714;2170.4899348653053;959.9280053995979;1041.911202793083;1085.4355735017746;1118.9104871610252;1150.5455345138791;18472.353467628567;18558.72161917572;19281.903590481958;19516.609667806566;19520.70718939217;1012.2408193854609;1012.8075665623508;1015.2740790334946;1025.179856115105;1047.8428235764695;10532.947335263274;10789;10794.406307652998;10912.34525928431;10966.122710183166;539977;544596;553458;576197;582450;94224;97008;97088.51455742677;98187.50906245566;98302;1066.7013236293851;1090.138790355626;1094.1684319916922;1113.6380676280241;1118.8601424821898;16101.516954491384;16313.429029983894;16476.176191190632;16857.91571042137;16889.577760555592;38380.80809595934;38904;39807;40146.39780403238;40258.79870600628;56026;57277.713611431675;57718.42281577131;57725;57872.421275786706;9272.907270927204;9314.906850931675;9439.180080881726;9462.479563624067;9477.857832132662;12679.492820287454;13774.862251377357;13929.23389213603;14123.2938353084;14258.928705356408;8468.645016797283;12277.938610306892;12335.198212116542;12344.876551234373;12449.875501244871;11617.88382116168;12024.939875300568;12143.635690929286;12217.328046957502;12906.806397904227;12281.69295767613;12359.3820308986;12466.75066498683;12796.872031279569;12899.097063205485;8981.640734370552;9167.44995300284;9231.676891308773;9317.86023209639;9437.716868493957;10592.735181620214;11649.602047753984;12965;13057.477700891857;13324.200547967153 20:25:19 INFO - PROCESS | 14154 | |3;mootools.html;1407.6691977385306;1569.693909687611;1596.1620149421549;1844.9907750461246;1931.9323823666166;7626.466147369686;8341.833163336729;8540.572971351423;8544.829103417927;8567.057623661392;8322.708705195319;8501.91498085019;8503.574821258942;8515.574221288942;8523.275521580657;2172.0985790896757;2440.8291419600546;2458.6189140683177;2483.1433155561303;2505.0856437400307;2504.611785173301;2538.9492210155786;2553.0553695132826;2553.885075171622;2554.3869471326934;2422.757724227572;2430.0401341470197;2431.8176136789725;2431.878406079689;2433.452473193526;2142.592907347599;2409.144753612469;2454.2882564056313;2457.3733697907096;2463.9876800615884;2310.27226423676;2376.2158487699016;2385.666006759055;2390.4621460171497;2392.820538459605;8528.530930798803;8568.914310856873;8589.484630922103;8597.054324024351;8600.483970961763;5391.083515802323;5460.372057213432;5498.505134537871;5511.283533140706;5512.035393806108;3348.782329148622;3396.5414669019615;3415.214500664861;3496.4580490024086;3525.1363415962996;1078.7141407527013;1112.227002233448;1116.7096554895704;1127.5320741892106;1135.080584726366;12526;12567.497300107985;12579.937100314532;12600.243985360816;12624.242545447303;4803.3995750531185;4814.662973591815;4876.463589005207;4882.292067650242;4908.01839632075;10503.317284376491;10504.42225677595;10506.789864202674;10508.21188410857;10533.57865685364;4893.363862697826;5502.064649009678;5549.916751248735;5551.528120109755;5555.694436805934;4974.27872958419;5034.672746271481;5044.722540260321;5059.367579052619;5062.038212739568;4023.8390464381096;4054.2296963576828;4085.3259212230246;4115.464989551399;4123.835046598102;1390.2145287912297;1408.8168538089983;1420.509924076192;1422.2106730764524;1433.1329545624956;957.4973139102027;1053.6312290698195;1058.655936820521;1081.0648788797791;1086.4187659602076;6213.5339849511465;6220.191375121205;6251.3123556408755;6335.1447554579545;6346.857565638137;502.6682389622831;503.63989747330834;507.2467385931888;508.36708298169015;514.1388174807183;4331.631811296075;4332.870013899588;4354.912901742011;4361.6510679145595;4371.5628437156665;10384.636537721295;10967.067799237155;10978.725531861768;11004.669859904216;11043.503042363112;10793.136549076213;10803.405812680377;10828.837567436494;10857.837132443019;10883.891161088446;8018.278354948083;8163.102058773649;8354.540500272422;8423.199796019368;8453.070162282143;5965.791197308074;6066.666333351532;6123.785667501616;6152.876942461036;6162.537809664383;9117.270618350383;9410.529473526432;9569.282303827102;9644.373115747454;9665;9310.394824336396;9576.664816731382;9629.807403852024;9736.561854716696;9799.167070799062;7528.661210245662;7924.167962364099;7992.240737129963;8004.5597492138495;8194.303484203909;8344.791380215544;8359.832803344021;8387.580620969049;8429.620667069874;8443.282321002784;7195.244499327495;7227.927720722725;7282;7485.66314515859;7519.248075192437;7001.474889383215;7130.108736407949;7197.748078817216;7318.707251710085;7392.4825262231125;6914.688839002157;6933.7226510939;6984.126984126984;6987.441004719712;6993.545419547713;5137.666051706777;5174.534291913746;5373.919391209057;5464.071107911585;5487;5210.869728256824;5271.393789714079;5291.391489978548;5305.681659100466;5392.487713667196 20:25:19 INFO - PROCESS | 14154 | |4;prototype.html;360.0781998084903;372.26849241240956;372.3037919091299;375.94924685167496;380.4901432081011;6153.876922461548;6175.969120154393;6187.4431301182885;6212.720427580758;6212.968935155323;5950.494207992315;6126.23422072241;6127.724252408641;6139.4167554082405;6157.0456579230295;4709.27006314021;4775.403074615673;4809.879753006186;4812;4820.301056346828;4715.622750179978;4748.786304616283;4809.5430934061205;4825.155597770394;4827.710337379751;4544.84093056743;4774.68964517307;4788.736619485927;4788.78450469728;4798.184308667535;4648.349231107648;4653.1856925038155;4654.418197725267;4755.857324280277;4760.452547956995;4183.560726123774;4207.0954744729725;4214.873553793391;4219.978900105511;4221.5567365426805;5965.671888046156;5971;5984.521238300926;5993.970030149865;6003.159557661931;5529.364123125812;5537.8061767838335;5543.473370029841;5560.2493663355335;5561.5272701820395;6393.7442502299855;6491.383318584727;6528.6409247491365;6532.444742196919;6536.411722944958;4658.650601204889;4666.2767271073035;4667.486576476585;4670.089332580148;4674.602658774008;6738.292479289702;6767.627780472072;6776.491763117737;6779.796606101825;6801.4558835293055;4775.044991001813;4777.187878060738;4777.259524773596;4777.474477807438;4785.258284965836;4840.661153719206;4845.927311090337;4849.733264670477;4850.151223535867;4861.732604706775;5507.03626865297;5511.118221084607;5520.972395138079;5524.392316845144;5528;6362.522810789209;6575.473962083021;6588.308227636029;6603.306652801482;6605.07528945948;1651.4962936304541;1662.7755253040928;1664.1512828457574;1667.641457086732;1668.9582760431085;1016.6949915025463;1083.685731137961;1087.608460954056;1123.1464087293716;1123.4045955643521;6349.714262858182;6484.157059582224;6491.545591808623;6508.772192973223;6512.902306465407;6864.7940561783225;6877.140357455318;6879.931200688029;6882.827929301708;6886.48351373639;6471.352864713585;6484.805455836333;6489.026646003137;6492.740290388426;6495.545311828221;3668.834902429397;3683.797391143459;3700.648438398348;3708.740388172802;3710.6474884885893;6904.1024666794;7080.858382832314;7110.253423390573;7117.786466406016;7152.499325047301;6942.757003504954;6988.79033628992;6996.755113571001;7002.3697867192195;7004.649767511604;7113.288671132846;7119.110111236096;7126.465515086285;7132.643367831588;7135.857282854314;6819.420349270169;6844.93155068443;6855.314468553105;6859.176898772179;6871.175458944958;6524.445422139172;6746.291639377795;6768.560043597347;6773.085633439423;6778.491613129134;7011.859762804614;7025.437964962893;7030.402415794715;7035.718571257093;7039.507234493536;4716.481187069351;4761.262004389325;4763.3807605011125;4768.4516280626785;4769.403824521934;6832.385085342343;6836.863262734817;6846.726130954706;6848.589084654936;6849.452043836581;6460.644664543495;6695.263521012587;6697.899531506934;6703.497237707289;6705.22889867652;6619.0733297339375;6651.368120028589;6653.035309879943;6656.5340426169705;6662.167229096363;6544.934550654623;6549.1486106807715;6555.246146693191;6557.704903279459;6559.672016399257;6712.39588437043;6712.865742685021;6716.059751634677;6718.563293385914;6720.0591917132615;6363.87272254543;6468.223813142453;6518.445932095636;6531.608103513804;6535.967320163369 20:25:19 INFO - PROCESS | 14154 | |5;yui.html;815.9469634473759;866.1901122450505;902.9615941667084;912.6851236323469;933.2673851026946;13796.862031379684;14782.113073215614;14787.038842475231;14791.55625331239;14805.555833325017;13289.335533223324;13331.266780327078;13367.532136375228;13373.732525349511;13400;769.7190525458224;913.4975763330175;924.159015296079;933.7012156110047;934.9158575728183;921.5714692667908;926.9536523173814;930.3394589841221;931.2968708624978;931.7158266728645;970.4468452981803;979.4172467381932;979.8285300072458;980.0640388429033;981.1807141037242;808.7856717969743;939.0468674295596;952.3286083311249;954.5179684259474;968.7626531499757;699.3496048674731;704.3660705365161;704.9964750176216;706.1526168597703;707.5330282013846;13167.60497185086;13262.86737132626;13315.667108322272;13331.200127992352;13375.398107085204;14885.404583816635;15072.54782356531;15363.385464581403;15369.923150384288;15747.763783543256;11268.943655281753;11534.423278836024;11579.652610421701;11586.073114150848;11914.582989595408;4023.5574086850424;4025.4565633639377;4047.736897101679;4065.451164092839;4188.539260681323;56623;56867.43132568663;56894.43105568974;56978.71510642461;57029.42970570282;11392.088632909348;11658.708532286591;11992.340421276913;12128.272303661808;12273.447694853752;22335.441613959458;22400;22403.21588744386;22412.103515859508;22430.775692243194;8493.235608795238;8573.528455934858;8898.59956301968;8940.3741738079;9030.954845225864;4964.453910069889;4974.701517908937;4979.90040199194;5053.469385714447;5123.308353372322;3591.0842735102906;3642.0712718256673;3643.28955853606;3649.1424515238896;3652.36083685354;641.3938827807771;664.0371461381017;664.1896885799317;670.1054092786185;674.2044387622554;644.3009334871716;662.7812821768805;783.4985609210111;802.5545822068691;810.3193317613233;9133.725988220363;9259.212966897754;9353.719388418222;9527.78689258119;9778.364406313567;661.4047357378302;790.6402586822982;829.3199576347337;831.6465502161557;833.6207025803245;4509.458864936229;4553.5218802025975;4603.4015577975315;4619.953800461953;4653.092646933883;68981;69005;69568;69618.3038169622;69653.65173174102;60089.39910600925;61149;61201.08198377028;61958.0706289406;62025;53721.73139134279;53913;53978.19032714512;54580.18129727978;55266.44733552613;9168.724938251864;9247.398919070509;9332.440053596805;9421.481818500048;9456.290778191526;40467;40623;40978.385324220755;41260.58739412567;41564;47466;49666;52569.47430525646;53220;53717;11387.943060284646;11485.081193504666;11553.942230288794;11730.76538469243;12197;12091.57679481214;12608.621741347773;12868.678283042998;13106.2136271824;13295.268760218281;12179.512819487121;12459.190152640049;12561.811572826233;12647.494100235888;12729.236245825281;13036.283004434468;13433.731325373634;13434.126781759154;13553.728925421634;13812.792808108088;12203.20679155852;12267.69330766738;12551.93724031374;12949.352532373532;13075.934620327218;11125.554977801121;11567.652970410902;11895.702607434883;11910.583129590423;12639.810402843781;10751.784964300514;11211.529920203046;11273.661790146309;11328.093752499615;11474.139439542234 20:25:19 INFO - PROCESS | 14154 | __end_tp_report 20:25:19 INFO - PROCESS | 14154 | __start_cc_report 20:25:19 INFO - PROCESS | 14154 | _x_x_mozilla_cycle_collect,902 20:25:19 INFO - PROCESS | 14154 | __end_cc_report 20:25:19 INFO - PROCESS | 14154 | __startTimestamp1464146719510__endTimestamp 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | ------- Summary: start ------- 20:25:19 INFO - PROCESS | 14154 | Number of tests: 6 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | [#0] dojo.html Cycles:165 Average:5526.73 Median:5760.94 stddev:609.67 (10.6%) stddev-sans-first:586.16 20:25:19 INFO - PROCESS | 14154 | Values: 3307.8 3381.7 3387.4 3409.0 3416.9 5557.6 5582.5 5599.7 5606.2 5608.1 5585.3 5640.3 5641.9 5643.2 5644.1 4835.7 5070.7 5157.7 5199.6 5228.4 5005.2 5083.9 5087.9 5088.4 5089.4 5033.3 5058.7 5069.6 5074.1 5080.8 5106.7 5142.4 5151.6 5154.4 5188.6 4927.4 4977.2 5041.9 5049.7 5055.7 5333.7 5403.8 5451.5 5461.0 5477.4 5770.7 5773.5 5775.9 5777.9 5784.7 5863.4 5975.0 6086.5 6101.4 6142.0 5603.7 5641.0 5647.8 5654.3 5655.3 5921.9 6132.4 6160.6 6168.0 6168.2 5827.2 5865.7 5870.1 5880.1 5889.1 5893.1 5896.8 5900.3 5901.5 5904.1 5806.3 5865.9 5866.3 5873.5 5913.3 5818.6 5819.6 5824.9 5825.7 5862.3 4450.1 4460.1 4461.4 4477.4 4491.0 4027.4 4035.8 4057.2 4058.2 4118.1 5675.9 5694.3 5697.6 5700.6 5715.9 5968.9 5969.5 5969.6 5972.9 5978.5 5441.6 5598.9 5692.5 5694.9 5697.7 5080.0 5092.9 5093.2 5094.1 5102.0 6146.6 6147.4 6147.6 6150.4 6151.7 5907.9 6019.3 6059.1 6098.6 6120.4 6104.9 6118.5 6122.4 6128.3 6128.4 5731.8 5766.9 5770.7 5773.9 5775.9 5928.1 5983.9 5984.3 5986.9 6022.3 5799.9 5815.7 5828.4 5830.2 5834.5 5748.1 5760.9 5796.0 5800.5 5839.9 5752.4 5760.1 5763.3 5763.6 5799.0 5840.3 5858.6 5869.4 5873.1 5900.1 5624.6 5704.5 5711.8 5781.1 5802.7 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | [#1] ext.html Cycles:180 Average:55199.47 Median:3651.53 stddev:103262.94 (2827.9%) stddev-sans-first:103471.45 20:25:19 INFO - PROCESS | 14154 | Values: 667.4 685.6 686.9 738.0 749.2 34684.5 41595.4 41720.2 41923.0 41953.0 44825.0 45672.8 45731.1 45744.0 45769.5 8154.2 8753.2 8944.8 10279.9 10496.6 10376.2 10500.3 10502.5 10504.5 10513.9 10488.6 10538.1 10545.0 10553.4 10554.6 8433.1 10226.6 10392.1 10398.3 10399.2 10479.2 10553.9 10563.7 10595.3 10604.8 40769.4 41524.6 41546.8 41570.4 41606.8 3825.4 3855.9 4415.5 4503.2 4668.8 34602.7 34841.8 35084.0 35262.5 35435.0 4543.3 4625.5 4677.5 4694.4 4714.7 334154.0 336060.0 336816.0 336874.0 337832.3 40554.4 40805.0 65800.0 67331.7 67353.7 38276.2 38422.2 38721.6 38730.2 38736.4 16703.7 17686.4 17881.9 17890.4 17893.2 15184.3 15467.0 15472.5 15481.8 15531.3 9238.3 9260.8 9266.8 9302.7 9316.1 3545.8 3630.1 3631.3 3671.8 3689.6 1147.9 1157.2 1166.1 1238.0 1299.8 33638.3 33719.2 33940.2 33997.0 34655.3 1275.9 1281.4 1329.9 1331.4 1333.2 17715.6 17754.6 17800.3 18142.5 18303.3 498478.0 498555.0 501321.0 502611.0 503789.0 64794.0 65212.0 65312.7 65337.3 65418.7 1374.8 1477.0 1524.2 1602.0 1622.0 31691.5 33707.9 33725.7 34151.0 34211.0 49751.5 49915.8 50170.0 50184.5 50254.7 306195.0 306405.0 306849.0 307312.0 308023.0 27882.7 31284.4 31814.0 32099.4 32261.7 45415.5 46101.8 47205.5 47254.3 54867.5 41693.4 41937.0 42007.8 42153.2 42955.8 41437.8 42445.4 42684.1 43383.8 43555.0 43006.0 43321.8 43620.8 44116.8 44276.3 35722.6 37340.0 37724.6 37933.4 38659.4 28863.1 29090.0 29121.7 29355.4 29631.6 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | [#2] jquery.html Cycles:180 Average:31235.08 Median:12848.42 stddev:92024.09 (716.2%) stddev-sans-first:92253.16 20:25:19 INFO - PROCESS | 14154 | Values: 423.7 426.6 431.8 442.2 449.6 18789.1 18833.2 19515.5 19621.7 19773.4 18905.6 19153.3 19870.2 19880.1 19911.4 5715.4 5780.3 5935.1 5939.2 5946.7 5865.1 5935.1 5939.0 5948.7 5951.8 5689.3 5914.7 5925.9 5935.1 5936.6 5863.5 5867.6 5876.2 5882.6 5884.8 5217.1 5303.4 5450.9 5457.5 5469.1 14447.7 14569.4 17775.5 23513.2 23533.8 2540.1 2647.6 2771.3 2899.7 2928.4 10013.9 10364.1 10670.9 10771.9 10872.2 2052.5 2061.1 2100.7 2138.9 2183.7 78787.6 83312.6 86553.0 86695.0 87176.6 11587.5 11655.7 11677.4 11693.9 11759.2 16635.3 16779.0 16783.0 16795.6 16820.7 9071.2 9086.5 9192.3 9235.4 9343.6 9013.6 9090.7 9091.7 9183.6 9260.8 4962.9 5001.2 5031.9 5055.9 5108.6 2036.8 2042.8 2055.3 2061.8 2170.5 959.9 1041.9 1085.4 1118.9 1150.5 18472.4 18558.7 19281.9 19516.6 19520.7 1012.2 1012.8 1015.3 1025.2 1047.8 10532.9 10789.0 10794.4 10912.3 10966.1 539977.0 544596.0 553458.0 576197.0 582450.0 94224.0 97008.0 97088.5 98187.5 98302.0 1066.7 1090.1 1094.2 1113.6 1118.9 16101.5 16313.4 16476.2 16857.9 16889.6 38380.8 38904.0 39807.0 40146.4 40258.8 56026.0 57277.7 57718.4 57725.0 57872.4 9272.9 9314.9 9439.2 9462.5 9477.9 12679.5 13774.9 13929.2 14123.3 14258.9 8468.6 12277.9 12335.2 12344.9 12449.9 11617.9 12024.9 12143.6 12217.3 12906.8 12281.7 12359.4 12466.8 12796.9 12899.1 8981.6 9167.4 9231.7 9317.9 9437.7 10592.7 11649.6 12965.0 13057.5 13324.2 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | [#3] mootools.html Cycles:180 Average:5803.08 Median:5060.70 stddev:3219.77 (63.6%) stddev-sans-first:3211.86 20:25:19 INFO - PROCESS | 14154 | Values: 1407.7 1569.7 1596.2 1845.0 1931.9 7626.5 8341.8 8540.6 8544.8 8567.1 8322.7 8501.9 8503.6 8515.6 8523.3 2172.1 2440.8 2458.6 2483.1 2505.1 2504.6 2538.9 2553.1 2553.9 2554.4 2422.8 2430.0 2431.8 2431.9 2433.5 2142.6 2409.1 2454.3 2457.4 2464.0 2310.3 2376.2 2385.7 2390.5 2392.8 8528.5 8568.9 8589.5 8597.1 8600.5 5391.1 5460.4 5498.5 5511.3 5512.0 3348.8 3396.5 3415.2 3496.5 3525.1 1078.7 1112.2 1116.7 1127.5 1135.1 12526.0 12567.5 12579.9 12600.2 12624.2 4803.4 4814.7 4876.5 4882.3 4908.0 10503.3 10504.4 10506.8 10508.2 10533.6 4893.4 5502.1 5549.9 5551.5 5555.7 4974.3 5034.7 5044.7 5059.4 5062.0 4023.8 4054.2 4085.3 4115.5 4123.8 1390.2 1408.8 1420.5 1422.2 1433.1 957.5 1053.6 1058.7 1081.1 1086.4 6213.5 6220.2 6251.3 6335.1 6346.9 502.7 503.6 507.2 508.4 514.1 4331.6 4332.9 4354.9 4361.7 4371.6 10384.6 10967.1 10978.7 11004.7 11043.5 10793.1 10803.4 10828.8 10857.8 10883.9 8018.3 8163.1 8354.5 8423.2 8453.1 5965.8 6066.7 6123.8 6152.9 6162.5 9117.3 9410.5 9569.3 9644.4 9665.0 9310.4 9576.7 9629.8 9736.6 9799.2 7528.7 7924.2 7992.2 8004.6 8194.3 8344.8 8359.8 8387.6 8429.6 8443.3 7195.2 7227.9 7282.0 7485.7 7519.2 7001.5 7130.1 7197.7 7318.7 7392.5 6914.7 6933.7 6984.1 6987.4 6993.5 5137.7 5174.5 5373.9 5464.1 5487.0 5210.9 5271.4 5291.4 5305.7 5392.5 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | [#4] prototype.html Cycles:180 Average:5548.57 Median:6356.12 stddev:1666.42 (26.2%) stddev-sans-first:1624.95 20:25:19 INFO - PROCESS | 14154 | Values: 360.1 372.3 372.3 375.9 380.5 6153.9 6176.0 6187.4 6212.7 6213.0 5950.5 6126.2 6127.7 6139.4 6157.0 4709.3 4775.4 4809.9 4812.0 4820.3 4715.6 4748.8 4809.5 4825.2 4827.7 4544.8 4774.7 4788.7 4788.8 4798.2 4648.3 4653.2 4654.4 4755.9 4760.5 4183.6 4207.1 4214.9 4220.0 4221.6 5965.7 5971.0 5984.5 5994.0 6003.2 5529.4 5537.8 5543.5 5560.2 5561.5 6393.7 6491.4 6528.6 6532.4 6536.4 4658.7 4666.3 4667.5 4670.1 4674.6 6738.3 6767.6 6776.5 6779.8 6801.5 4775.0 4777.2 4777.3 4777.5 4785.3 4840.7 4845.9 4849.7 4850.2 4861.7 5507.0 5511.1 5521.0 5524.4 5528.0 6362.5 6575.5 6588.3 6603.3 6605.1 1651.5 1662.8 1664.2 1667.6 1669.0 1016.7 1083.7 1087.6 1123.1 1123.4 6349.7 6484.2 6491.5 6508.8 6512.9 6864.8 6877.1 6879.9 6882.8 6886.5 6471.4 6484.8 6489.0 6492.7 6495.5 3668.8 3683.8 3700.6 3708.7 3710.6 6904.1 7080.9 7110.3 7117.8 7152.5 6942.8 6988.8 6996.8 7002.4 7004.6 7113.3 7119.1 7126.5 7132.6 7135.9 6819.4 6844.9 6855.3 6859.2 6871.2 6524.4 6746.3 6768.6 6773.1 6778.5 7011.9 7025.4 7030.4 7035.7 7039.5 4716.5 4761.3 4763.4 4768.5 4769.4 6832.4 6836.9 6846.7 6848.6 6849.5 6460.6 6695.3 6697.9 6703.5 6705.2 6619.1 6651.4 6653.0 6656.5 6662.2 6544.9 6549.1 6555.2 6557.7 6559.7 6712.4 6712.9 6716.1 6718.6 6720.1 6363.9 6468.2 6518.4 6531.6 6536.0 20:25:19 INFO - PROCESS | 14154 | 20:25:19 INFO - PROCESS | 14154 | [#5] yui.html Cycles:180 Average:15970.49 Median:26215.23 stddev:18957.24 (72.3%) stddev-sans-first:18976.26 20:25:19 INFO - PROCESS | 14154 | Values: 815.9 866.2 903.0 912.7 933.3 13796.9 14782.1 14787.0 14791.6 14805.6 13289.3 13331.3 13367.5 13373.7 13400.0 769.7 913.5 924.2 933.7 934.9 921.6 927.0 930.3 931.3 931.7 970.4 979.4 979.8 980.1 981.2 808.8 939.0 952.3 954.5 968.8 699.3 704.4 705.0 706.2 707.5 13167.6 13262.9 13315.7 13331.2 13375.4 14885.4 15072.5 15363.4 15369.9 15747.8 11268.9 11534.4 11579.7 11586.1 11914.6 4023.6 4025.5 4047.7 4065.5 4188.5 56623.0 56867.4 56894.4 56978.7 57029.4 11392.1 11658.7 11992.3 12128.3 12273.4 22335.4 22400.0 22403.2 22412.1 22430.8 8493.2 8573.5 8898.6 8940.4 9031.0 4964.5 4974.7 4979.9 5053.5 5123.3 3591.1 3642.1 3643.3 3649.1 3652.4 641.4 664.0 664.2 670.1 674.2 644.3 662.8 783.5 802.6 810.3 9133.7 9259.2 9353.7 9527.8 9778.4 661.4 790.6 829.3 831.6 833.6 4509.5 4553.5 4603.4 4620.0 4653.1 68981.0 69005.0 69568.0 69618.3 69653.7 60089.4 61149.0 61201.1 61958.1 62025.0 53721.7 53913.0 53978.2 54580.2 55266.4 9168.7 9247.4 9332.4 9421.5 9456.3 40467.0 40623.0 40978.4 41260.6 41564.0 47466.0 49666.0 52569.5 53220.0 53717.0 11387.9 11485.1 11553.9 11730.8 12197.0 12091.6 12608.6 12868.7 13106.2 13295.3 12179.5 12459.2 12561.8 12647.5 12729.2 13036.3 13433.7 13434.1 13553.7 13812.8 12203.2 12267.7 12551.9 12949.4 13075.9 11125.6 11567.7 11895.7 11910.6 12639.8 10751.8 11211.5 11273.7 11328.1 11474.1 20:25:19 INFO - PROCESS | 14154 | -------- Summary: end -------- 20:25:19 INFO - PROCESS | 14154 | 20:25:20 INFO - TEST-INFO | 14154: exit 0 20:25:20 INFO - TEST-OK | dromaeo_css | took 1111419ms 20:25:20 INFO - TEST-START | kraken 20:25:20 INFO - operating with platform_type : linux_ 20:25:20 INFO - Initialising browser for kraken test... 20:25:20 INFO - TEST-INFO | started process 14345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE9FFw2/profile http://localhost:54500/getInfo.html) 20:25:24 INFO - PROCESS | 14345 | __metrics Screen width/height:1600/1200 20:25:24 INFO - PROCESS | 14345 | colorDepth:24 20:25:24 INFO - PROCESS | 14345 | Browser inner width/height: 1024/697 20:25:24 INFO - PROCESS | 14345 | __metrics 20:25:25 ERROR - PROCESS | 14345 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:25:25 INFO - TEST-INFO | 14345: exit 0 20:25:25 INFO - Browser initialized. 20:25:25 INFO - Running cycle 1/1 for kraken test... 20:25:25 INFO - TEST-INFO | started process 14433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE9FFw2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:37 INFO - PROCESS | 14433 | RSS: Main: 142266368 20:25:37 INFO - PROCESS | 14433 | 20:25:40 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:41 INFO - PROCESS | 14433 | RSS: Main: 196603904 20:25:41 INFO - PROCESS | 14433 | 20:25:43 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-dft) 20:25:44 INFO - PROCESS | 14433 | RSS: Main: 181538816 20:25:44 INFO - PROCESS | 14433 | 20:25:47 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-fft) 20:25:47 INFO - PROCESS | 14433 | RSS: Main: 271765504 20:25:47 INFO - PROCESS | 14433 | 20:25:49 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54500/tests/kraken/driver.html?testName=audio-oscillator) 20:25:50 INFO - PROCESS | 14433 | RSS: Main: 178315264 20:25:50 INFO - PROCESS | 14433 | 20:25:52 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:53 INFO - PROCESS | 14433 | RSS: Main: 176857088 20:25:53 INFO - PROCESS | 14433 | 20:25:56 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54500/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:56 INFO - PROCESS | 14433 | RSS: Main: 211582976 20:25:56 INFO - PROCESS | 14433 | 20:26:00 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54500/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:00 INFO - PROCESS | 14433 | RSS: Main: 211136512 20:26:00 INFO - PROCESS | 14433 | 20:26:03 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54500/tests/kraken/driver.html?testName=json-parse-financial) 20:26:04 INFO - PROCESS | 14433 | RSS: Main: 211468288 20:26:04 INFO - PROCESS | 14433 | 20:26:05 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:06 INFO - PROCESS | 14433 | RSS: Main: 191352832 20:26:06 INFO - PROCESS | 14433 | 20:26:07 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:08 INFO - PROCESS | 14433 | RSS: Main: 194953216 20:26:08 INFO - PROCESS | 14433 | 20:26:10 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:11 INFO - PROCESS | 14433 | RSS: Main: 209883136 20:26:11 INFO - PROCESS | 14433 | 20:26:13 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:14 INFO - PROCESS | 14433 | RSS: Main: 211566592 20:26:14 INFO - PROCESS | 14433 | 20:26:16 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:17 INFO - PROCESS | 14433 | RSS: Main: 212447232 20:26:17 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | Cycle 1(1): loaded http://localhost:54500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54500/tests/kraken/driver.html?testName=ai-astar) 20:26:19 INFO - PROCESS | 14433 | RSS: Main: 275849216 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | __start_tp_report 20:26:19 INFO - PROCESS | 14433 | _x_x_mozilla_page_load 20:26:19 INFO - PROCESS | 14433 | _x_x_mozilla_page_load_details 20:26:19 INFO - PROCESS | 14433 | |i|pagename|runs| 20:26:19 INFO - PROCESS | 14433 | |0;ai-astar;110;110;109;110;110;111;107;110;109;109 20:26:19 INFO - PROCESS | 14433 | |1;audio-beat-detection;160;135;151;174;129;152;153;130;180;127 20:26:19 INFO - PROCESS | 14433 | |2;audio-dft;161;160;161;161;159;161;161;160;160;159 20:26:19 INFO - PROCESS | 14433 | |3;audio-fft;77;75;76;179;77;74;76;76;163;73 20:26:19 INFO - PROCESS | 14433 | |4;audio-oscillator;92;92;147;93;92;92;151;92;93;151 20:26:19 INFO - PROCESS | 14433 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;116;116 20:26:19 INFO - PROCESS | 14433 | |6;imaging-darkroom;146;145;145;145;146;145;146;146;145;146 20:26:19 INFO - PROCESS | 14433 | |7;imaging-desaturate;96;95;95;95;94;97;95;94;94;94 20:26:19 INFO - PROCESS | 14433 | |8;json-parse-financial;54;54;52;53;55;53;56;79;52;52 20:26:19 INFO - PROCESS | 14433 | |9;json-stringify-tinderbox;61;60;59;60;59;59;59;60;59;58 20:26:19 INFO - PROCESS | 14433 | |10;stanford-crypto-aes;73;72;73;72;75;72;75;73;74;80 20:26:19 INFO - PROCESS | 14433 | |11;stanford-crypto-ccm;116;123;121;115;121;112;111;116;158;122 20:26:19 INFO - PROCESS | 14433 | |12;stanford-crypto-pbkdf2;163;166;164;162;167;163;159;163;162;160 20:26:19 INFO - PROCESS | 14433 | |13;stanford-crypto-sha256-iterative;68;68;66;67;65;75;69;66;66;66 20:26:19 INFO - PROCESS | 14433 | __end_tp_report 20:26:19 INFO - PROCESS | 14433 | __start_cc_report 20:26:19 INFO - PROCESS | 14433 | _x_x_mozilla_cycle_collect,1590 20:26:19 INFO - PROCESS | 14433 | __end_cc_report 20:26:19 INFO - PROCESS | 14433 | __startTimestamp1464146779427__endTimestamp 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | ------- Summary: start ------- 20:26:19 INFO - PROCESS | 14433 | Number of tests: 14 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.08 (1.0%) stddev-sans-first:1.13 20:26:19 INFO - PROCESS | 14433 | Values: 110.0 110.0 109.0 110.0 110.0 111.0 107.0 110.0 109.0 109.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:152.50 stddev:18.79 (12.3%) stddev-sans-first:19.51 20:26:19 INFO - PROCESS | 14433 | Values: 160.0 135.0 151.0 174.0 129.0 152.0 153.0 130.0 180.0 127.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 20:26:19 INFO - PROCESS | 14433 | Values: 161.0 160.0 161.0 161.0 159.0 161.0 161.0 160.0 160.0 159.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:40.46 (53.2%) stddev-sans-first:42.41 20:26:19 INFO - PROCESS | 14433 | Values: 77.0 75.0 76.0 179.0 77.0 74.0 76.0 76.0 163.0 73.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:92.00 stddev:27.74 (30.2%) stddev-sans-first:28.69 20:26:19 INFO - PROCESS | 14433 | Values: 92.0 92.0 147.0 93.0 92.0 92.0 151.0 92.0 93.0 151.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:26:19 INFO - PROCESS | 14433 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 116.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:26:19 INFO - PROCESS | 14433 | Values: 146.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:0.97 20:26:19 INFO - PROCESS | 14433 | Values: 96.0 95.0 95.0 95.0 94.0 97.0 95.0 94.0 94.0 94.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:8.19 (15.2%) stddev-sans-first:8.66 20:26:19 INFO - PROCESS | 14433 | Values: 54.0 54.0 52.0 53.0 55.0 53.0 56.0 79.0 52.0 52.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.84 (1.4%) stddev-sans-first:0.67 20:26:19 INFO - PROCESS | 14433 | Values: 61.0 60.0 59.0 60.0 59.0 59.0 59.0 60.0 59.0 58.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:73.50 stddev:2.42 (3.3%) stddev-sans-first:2.55 20:26:19 INFO - PROCESS | 14433 | Values: 73.0 72.0 73.0 72.0 75.0 72.0 75.0 73.0 74.0 80.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:121.00 stddev:13.49 (11.2%) stddev-sans-first:14.16 20:26:19 INFO - PROCESS | 14433 | Values: 116.0 123.0 121.0 115.0 121.0 112.0 111.0 116.0 158.0 122.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:163.00 stddev:2.42 (1.5%) stddev-sans-first:2.57 20:26:19 INFO - PROCESS | 14433 | Values: 163.0 166.0 164.0 162.0 167.0 163.0 159.0 163.0 162.0 160.0 20:26:19 INFO - PROCESS | 14433 | 20:26:19 INFO - PROCESS | 14433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.88 (4.3%) stddev-sans-first:3.05 20:26:19 INFO - PROCESS | 14433 | Values: 68.0 68.0 66.0 67.0 65.0 75.0 69.0 66.0 66.0 66.0 20:26:19 INFO - PROCESS | 14433 | -------- Summary: end -------- 20:26:19 INFO - PROCESS | 14433 | 20:26:20 INFO - TEST-INFO | 14433: exit 0 20:26:20 INFO - TEST-OK | kraken | took 60160ms 20:26:20 INFO - SUITE-END | took 1171s 20:26:20 INFO - Completed test suite (00:19:31) 20:26:20 INFO - javascript benchmark 20:26:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.8180700061494, 3381.6787405196496, 3387.441072223083, 3408.965910340896, 3416.9487457688138, 5557.6109672322955, 5582.5254853337465, 5599.7480113394895, 5606.21512988182, 5608.074667679828, 5585.3297604287445, 5640.294963129609, 5641.943580564193, 5643.209950606918, 5644.068728659766, 4835.685680430778, 5070.67040642358, 5157.742112894341, 5199.610029247802, 5228.372595288571, 5005.199168133099, 5083.923741143886, 5087.949120508803, 5088.363954505687, 5089.389273287211, 5033.295338652591, 5058.696478211301, 5069.569086627623, 5074.13739664258, 5080.822171224008, 5106.693598384109, 5142.408623008365, 5151.639385243035, 5154.4072431670465, 5188.6367954243215, 4927.359443272388, 4977.1538838397555, 5041.873953151164, 5049.671771334888, 5055.74721263939, 5333.706646134461, 5403.810866619689, 5451.454854514556, 5460.972695136499, 5477.370102438231, 5770.711464426804, 5773.451522105393, 5775.902578510069, 5777.913331300034, 5784.68184249866, 5863.413658634145, 5975.0, 6086.522130082916, 6101.420365065312, 6141.969290153521, 5603.691796951166, 5641.041023026054, 5647.802326918538, 5654.293213348332, 5655.293088363914, 5921.881562368814, 6132.448079672851, 6160.599561028519, 6167.982282923357, 6168.19813424252, 5827.24245848037, 5865.736041878125, 5870.119482077637, 5880.117982302689, 5889.146073819272, 5893.086571581412, 5896.823095307148, 5900.291964964232, 5901.468867801918, 5904.055351143882, 5806.274215723035, 5865.94134058654, 5866.325372582122, 5873.471387575139, 5913.2608423947, 5818.6217895836635, 5819.621724587888, 5824.941750582525, 5825.650460972271, 5862.325832529228, 4450.109978004412, 4460.0633866887665, 4461.397711308931, 4477.3731677565165, 4490.977545112253, 4027.4160246764054, 4035.778032208198, 4057.229126465962, 4058.228936502055, 4118.094019315806, 5675.943240567624, 5694.259746233046, 5697.6296540724725, 5700.629459085146, 5715.942840571541, 5968.850778730566, 5969.522438204933, 5969.641821490724, 5972.8805423892145, 5978.461938425563, 5441.646292990943, 5598.86002849932, 5692.459216374438, 5694.914576281359, 5697.658140511582, 5079.974600126976, 5092.872678183001, 5093.2105523643895, 5094.057599344133, 5102.030614183293, 6146.569740118149, 6147.385261473906, 6147.569670123138, 6150.3849615039035, 6151.72317245716, 5907.940920590825, 6019.277686677627, 6059.0608455689435, 6098.573099882966, 6120.418560236771, 6104.908426373519, 6118.541109416722, 6122.357152498924, 6128.264608247039, 6128.448439640276, 5731.799387021434, 5766.94233057664, 5770.740316685843, 5773.942260577341, 5775.9133612995, 5928.051511758271, 5983.940160598512, 5984.281886173687, 5986.910196346971, 6022.307434645072, 5799.884002319845, 5815.709214539172, 5828.388019258086, 5830.2129212555765, 5834.533237340917, 5748.109043098327, 5760.94239057604, 5796.0436527972415, 5800.477956983892, 5839.854003649943, 5752.395998420106, 5760.0783874579865, 5763.250777398911, 5763.567732420169, 5799.043157878903, 5840.328362238227, 5858.560607954506, 5869.413058694267, 5873.119032145212, 5900.055991041413, 5624.550035997192, 5704.486596206361, 5711.8000869969355, 5781.132830075354, 5802.65184088956], "value": 5487.468867701108, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.4260136282796, 685.5920727167335, 686.9141357330337, 738.0000099864685, 749.1571981520789, 34684.47973280399, 41595.37606935894, 41720.16559668805, 41923.0, 41953.0, 44825.0, 45672.77163614186, 45731.08537829242, 45744.0, 45769.54230457703, 8154.184581541828, 8753.16844899735, 8944.776380590472, 10279.948600256988, 10496.580136794519, 10376.169906407507, 10500.264981451262, 10502.527386267637, 10504.474776261195, 10513.947430262877, 10488.632897848576, 10538.104261137813, 10545.0, 10553.366797992107, 10554.630587929423, 8433.114522975091, 10226.590936362536, 10392.06471417576, 10398.272120951537, 10399.220058495643, 10479.161667066617, 10553.894461055444, 10563.73590660232, 10595.25833191677, 10604.840927386096, 40769.38845917313, 41524.584754152376, 41546.79226603878, 41570.37644435336, 41606.79196604028, 3825.387937929918, 3855.9421608675893, 4415.470143582758, 4503.166914120898, 4668.813247470097, 34602.6539734602, 34841.82579087114, 35084.0, 35262.47106293408, 35435.0, 4543.250363689987, 4625.4911959684405, 4677.4620918594455, 4694.413198350207, 4714.740689262089, 334154.0, 336060.0, 336816.0, 336874.0, 337832.3108384467, 40554.39168412476, 40805.0, 65800.0, 67331.66334168396, 67353.66323168353, 38276.23447531034, 38422.23155536874, 38721.61278387236, 38730.22539549193, 38736.418953715714, 16703.6659266814, 17686.380976665754, 17881.910590446965, 17890.373836915645, 17893.19480623375, 15184.316705748268, 15467.0, 15472.458463953708, 15481.845181548266, 15531.301091450912, 9238.307126965505, 9260.768480788034, 9266.768330791785, 9302.674406395743, 9316.068393160765, 3545.840437180333, 3630.09247688078, 3631.2737452509605, 3671.7796932184156, 3689.6310368963427, 1147.9483423245974, 1157.1552766480347, 1166.119579717325, 1237.9876201238053, 1299.818025476434, 33638.327233455195, 33719.22662415417, 33940.1514962123, 33997.0, 34655.30689386198, 1275.8787915148046, 1281.423359488234, 1329.946802127904, 1331.3609467455676, 1333.1800942420537, 17715.55711107207, 17754.5561360967, 17800.287988480573, 18142.45572632823, 18303.26786928508, 498478.0, 498555.0, 501321.0, 502611.0, 503789.0, 64794.0, 65212.0, 65312.67343663251, 65337.346626534076, 65418.67290663516, 1374.7731624281882, 1476.9778453323424, 1524.1921781455846, 1601.9587268275714, 1621.9862585883823, 31691.52462713015, 33707.91004168396, 33725.662743373236, 34151.0, 34211.0, 49751.502484974684, 49915.75042124766, 50169.99660006706, 50184.49815501798, 50254.74872625613, 306195.0, 306405.0, 306849.0, 307312.0, 308023.0, 27882.721172788824, 31284.37431251408, 31814.0, 32099.358012839144, 32261.677383225866, 45415.545844541135, 46101.76949115233, 47205.527944721485, 47254.291185631555, 54867.45132548783, 41693.374599380426, 41937.0, 42007.78996105, 42153.156936861706, 42955.7852210737, 41437.79281103575, 42445.363319549615, 42684.146317074104, 43383.783081084395, 43555.0, 43006.0, 43321.78339108411, 43620.78189609032, 44116.77941610271, 44276.33585496156, 35722.642773572974, 37340.0, 37724.62275377211, 37933.430998534495, 38659.42010869783, 28863.090073107593, 29090.0, 29121.7087829119, 29355.41289174162, 29631.555526667547], "value": 20123.722259788705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.6907057847769, 426.6224391413599, 431.81494766697256, 442.1628135098665, 449.63130233208784, 18789.060546972665, 18833.246670133194, 19515.512112197186, 19621.70567441486, 19773.406797796088, 18905.62188756224, 19153.329633462832, 19870.205191792313, 19880.10539525721, 19911.40265792025, 5715.428457154272, 5780.306363236417, 5935.10973353996, 5939.198208241897, 5946.672932988684, 5865.120231965218, 5935.10973353996, 5939.0, 5948.732307046172, 5951.821445356646, 5689.288838895138, 5914.674692891889, 5925.940740592582, 5935.080062590306, 5936.614120082181, 5863.472287494124, 5867.647941123525, 5876.2067120938555, 5882.5588080893895, 5884.823455296348, 5217.113090774577, 5303.443138470482, 5450.890982180374, 5457.454254574551, 5469.07025805614, 14447.711045779131, 14569.417223311055, 17775.466735997812, 23513.17703880356, 23533.76466235333, 2540.1109611635966, 2647.6160956661174, 2771.3348796288947, 2899.7390234878962, 2928.3557617324154, 10013.949930250303, 10364.067233948981, 10670.893291067068, 10771.946140269327, 10872.238943273975, 2052.48687828043, 2061.072517367191, 2100.705901173837, 2138.893055347242, 2183.6724491326268, 78787.6060619699, 83312.58343708303, 86553.0, 86695.0, 87176.564117179, 11587.536498540132, 11655.708607284716, 11677.35774532392, 11693.88306116945, 11759.17732751425, 16635.334586616642, 16779.0, 16783.0, 16795.580110497336, 16820.6635867282, 9071.228945539571, 9086.45481271126, 9192.310576706774, 9235.353525253302, 9343.626254949726, 9013.594388252544, 9090.727278181534, 9091.681791137278, 9183.632654693738, 9260.7684807879, 4962.851114466572, 5001.174806156943, 5031.874203144877, 5055.87360315995, 5108.565771909355, 2036.7553549609813, 2042.805933436321, 2055.3320170944503, 2061.7835127311714, 2170.4899348653053, 959.9280053995979, 1041.911202793083, 1085.4355735017746, 1118.9104871610252, 1150.5455345138791, 18472.353467628567, 18558.72161917572, 19281.903590481958, 19516.609667806566, 19520.70718939217, 1012.2408193854609, 1012.8075665623508, 1015.2740790334946, 1025.179856115105, 1047.8428235764695, 10532.947335263274, 10789.0, 10794.406307652998, 10912.34525928431, 10966.122710183166, 539977.0, 544596.0, 553458.0, 576197.0, 582450.0, 94224.0, 97008.0, 97088.51455742677, 98187.50906245566, 98302.0, 1066.7013236293851, 1090.138790355626, 1094.1684319916922, 1113.6380676280241, 1118.8601424821898, 16101.516954491384, 16313.429029983894, 16476.176191190632, 16857.91571042137, 16889.577760555592, 38380.80809595934, 38904.0, 39807.0, 40146.39780403238, 40258.79870600628, 56026.0, 57277.713611431675, 57718.42281577131, 57725.0, 57872.421275786706, 9272.907270927204, 9314.906850931675, 9439.180080881726, 9462.479563624067, 9477.857832132662, 12679.492820287454, 13774.862251377357, 13929.23389213603, 14123.2938353084, 14258.928705356408, 8468.645016797283, 12277.938610306892, 12335.198212116542, 12344.876551234373, 12449.875501244871, 11617.88382116168, 12024.939875300568, 12143.635690929286, 12217.328046957502, 12906.806397904227, 12281.69295767613, 12359.3820308986, 12466.75066498683, 12796.872031279569, 12899.097063205485, 8981.640734370552, 9167.44995300284, 9231.676891308773, 9317.86023209639, 9437.716868493957, 10592.735181620214, 11649.602047753984, 12965.0, 13057.477700891857, 13324.200547967153], "value": 9601.582126914183, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.6691977385306, 1569.693909687611, 1596.1620149421549, 1844.9907750461246, 1931.9323823666166, 7626.466147369686, 8341.833163336729, 8540.572971351423, 8544.829103417927, 8567.057623661392, 8322.708705195319, 8501.91498085019, 8503.574821258942, 8515.574221288942, 8523.275521580657, 2172.0985790896757, 2440.8291419600546, 2458.6189140683177, 2483.1433155561303, 2505.0856437400307, 2504.611785173301, 2538.9492210155786, 2553.0553695132826, 2553.885075171622, 2554.3869471326934, 2422.757724227572, 2430.0401341470197, 2431.8176136789725, 2431.878406079689, 2433.452473193526, 2142.592907347599, 2409.144753612469, 2454.2882564056313, 2457.3733697907096, 2463.9876800615884, 2310.27226423676, 2376.2158487699016, 2385.666006759055, 2390.4621460171497, 2392.820538459605, 8528.530930798803, 8568.914310856873, 8589.484630922103, 8597.054324024351, 8600.483970961763, 5391.083515802323, 5460.372057213432, 5498.505134537871, 5511.283533140706, 5512.035393806108, 3348.782329148622, 3396.5414669019615, 3415.214500664861, 3496.4580490024086, 3525.1363415962996, 1078.7141407527013, 1112.227002233448, 1116.7096554895704, 1127.5320741892106, 1135.080584726366, 12526.0, 12567.497300107985, 12579.937100314532, 12600.243985360816, 12624.242545447303, 4803.3995750531185, 4814.662973591815, 4876.463589005207, 4882.292067650242, 4908.01839632075, 10503.317284376491, 10504.42225677595, 10506.789864202674, 10508.21188410857, 10533.57865685364, 4893.363862697826, 5502.064649009678, 5549.916751248735, 5551.528120109755, 5555.694436805934, 4974.27872958419, 5034.672746271481, 5044.722540260321, 5059.367579052619, 5062.038212739568, 4023.8390464381096, 4054.2296963576828, 4085.3259212230246, 4115.464989551399, 4123.835046598102, 1390.2145287912297, 1408.8168538089983, 1420.509924076192, 1422.2106730764524, 1433.1329545624956, 957.4973139102027, 1053.6312290698195, 1058.655936820521, 1081.0648788797791, 1086.4187659602076, 6213.5339849511465, 6220.191375121205, 6251.3123556408755, 6335.1447554579545, 6346.857565638137, 502.6682389622831, 503.63989747330834, 507.2467385931888, 508.36708298169015, 514.1388174807183, 4331.631811296075, 4332.870013899588, 4354.912901742011, 4361.6510679145595, 4371.5628437156665, 10384.636537721295, 10967.067799237155, 10978.725531861768, 11004.669859904216, 11043.503042363112, 10793.136549076213, 10803.405812680377, 10828.837567436494, 10857.837132443019, 10883.891161088446, 8018.278354948083, 8163.102058773649, 8354.540500272422, 8423.199796019368, 8453.070162282143, 5965.791197308074, 6066.666333351532, 6123.785667501616, 6152.876942461036, 6162.537809664383, 9117.270618350383, 9410.529473526432, 9569.282303827102, 9644.373115747454, 9665.0, 9310.394824336396, 9576.664816731382, 9629.807403852024, 9736.561854716696, 9799.167070799062, 7528.661210245662, 7924.167962364099, 7992.240737129963, 8004.5597492138495, 8194.303484203909, 8344.791380215544, 8359.832803344021, 8387.580620969049, 8429.620667069874, 8443.282321002784, 7195.244499327495, 7227.927720722725, 7282.0, 7485.66314515859, 7519.248075192437, 7001.474889383215, 7130.108736407949, 7197.748078817216, 7318.707251710085, 7392.4825262231125, 6914.688839002157, 6933.7226510939, 6984.126984126984, 6987.441004719712, 6993.545419547713, 5137.666051706777, 5174.534291913746, 5373.919391209057, 5464.071107911585, 5487.0, 5210.869728256824, 5271.393789714079, 5291.391489978548, 5305.681659100466, 5392.487713667196], "value": 4639.320094446072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.0781998084903, 372.26849241240956, 372.3037919091299, 375.94924685167496, 380.4901432081011, 6153.876922461548, 6175.969120154393, 6187.4431301182885, 6212.720427580758, 6212.968935155323, 5950.494207992315, 6126.23422072241, 6127.724252408641, 6139.4167554082405, 6157.0456579230295, 4709.27006314021, 4775.403074615673, 4809.879753006186, 4812.0, 4820.301056346828, 4715.622750179978, 4748.786304616283, 4809.5430934061205, 4825.155597770394, 4827.710337379751, 4544.84093056743, 4774.68964517307, 4788.736619485927, 4788.78450469728, 4798.184308667535, 4648.349231107648, 4653.1856925038155, 4654.418197725267, 4755.857324280277, 4760.452547956995, 4183.560726123774, 4207.0954744729725, 4214.873553793391, 4219.978900105511, 4221.5567365426805, 5965.671888046156, 5971.0, 5984.521238300926, 5993.970030149865, 6003.159557661931, 5529.364123125812, 5537.8061767838335, 5543.473370029841, 5560.2493663355335, 5561.5272701820395, 6393.7442502299855, 6491.383318584727, 6528.6409247491365, 6532.444742196919, 6536.411722944958, 4658.650601204889, 4666.2767271073035, 4667.486576476585, 4670.089332580148, 4674.602658774008, 6738.292479289702, 6767.627780472072, 6776.491763117737, 6779.796606101825, 6801.4558835293055, 4775.044991001813, 4777.187878060738, 4777.259524773596, 4777.474477807438, 4785.258284965836, 4840.661153719206, 4845.927311090337, 4849.733264670477, 4850.151223535867, 4861.732604706775, 5507.03626865297, 5511.118221084607, 5520.972395138079, 5524.392316845144, 5528.0, 6362.522810789209, 6575.473962083021, 6588.308227636029, 6603.306652801482, 6605.07528945948, 1651.4962936304541, 1662.7755253040928, 1664.1512828457574, 1667.641457086732, 1668.9582760431085, 1016.6949915025463, 1083.685731137961, 1087.608460954056, 1123.1464087293716, 1123.4045955643521, 6349.714262858182, 6484.157059582224, 6491.545591808623, 6508.772192973223, 6512.902306465407, 6864.7940561783225, 6877.140357455318, 6879.931200688029, 6882.827929301708, 6886.48351373639, 6471.352864713585, 6484.805455836333, 6489.026646003137, 6492.740290388426, 6495.545311828221, 3668.834902429397, 3683.797391143459, 3700.648438398348, 3708.740388172802, 3710.6474884885893, 6904.1024666794, 7080.858382832314, 7110.253423390573, 7117.786466406016, 7152.499325047301, 6942.757003504954, 6988.79033628992, 6996.755113571001, 7002.3697867192195, 7004.649767511604, 7113.288671132846, 7119.110111236096, 7126.465515086285, 7132.643367831588, 7135.857282854314, 6819.420349270169, 6844.93155068443, 6855.314468553105, 6859.176898772179, 6871.175458944958, 6524.445422139172, 6746.291639377795, 6768.560043597347, 6773.085633439423, 6778.491613129134, 7011.859762804614, 7025.437964962893, 7030.402415794715, 7035.718571257093, 7039.507234493536, 4716.481187069351, 4761.262004389325, 4763.3807605011125, 4768.4516280626785, 4769.403824521934, 6832.385085342343, 6836.863262734817, 6846.726130954706, 6848.589084654936, 6849.452043836581, 6460.644664543495, 6695.263521012587, 6697.899531506934, 6703.497237707289, 6705.22889867652, 6619.0733297339375, 6651.368120028589, 6653.035309879943, 6656.5340426169705, 6662.167229096363, 6544.934550654623, 6549.1486106807715, 6555.246146693191, 6557.704903279459, 6559.672016399257, 6712.39588437043, 6712.865742685021, 6716.059751634677, 6718.563293385914, 6720.0591917132615, 6363.87272254543, 6468.223813142453, 6518.445932095636, 6531.608103513804, 6535.967320163369], "value": 5009.208351801746, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.9469634473759, 866.1901122450505, 902.9615941667084, 912.6851236323469, 933.2673851026946, 13796.862031379684, 14782.113073215614, 14787.038842475231, 14791.55625331239, 14805.555833325017, 13289.335533223324, 13331.266780327078, 13367.532136375228, 13373.732525349511, 13400.0, 769.7190525458224, 913.4975763330175, 924.159015296079, 933.7012156110047, 934.9158575728183, 921.5714692667908, 926.9536523173814, 930.3394589841221, 931.2968708624978, 931.7158266728645, 970.4468452981803, 979.4172467381932, 979.8285300072458, 980.0640388429033, 981.1807141037242, 808.7856717969743, 939.0468674295596, 952.3286083311249, 954.5179684259474, 968.7626531499757, 699.3496048674731, 704.3660705365161, 704.9964750176216, 706.1526168597703, 707.5330282013846, 13167.60497185086, 13262.86737132626, 13315.667108322272, 13331.200127992352, 13375.398107085204, 14885.404583816635, 15072.54782356531, 15363.385464581403, 15369.923150384288, 15747.763783543256, 11268.943655281753, 11534.423278836024, 11579.652610421701, 11586.073114150848, 11914.582989595408, 4023.5574086850424, 4025.4565633639377, 4047.736897101679, 4065.451164092839, 4188.539260681323, 56623.0, 56867.43132568663, 56894.43105568974, 56978.71510642461, 57029.42970570282, 11392.088632909348, 11658.708532286591, 11992.340421276913, 12128.272303661808, 12273.447694853752, 22335.441613959458, 22400.0, 22403.21588744386, 22412.103515859508, 22430.775692243194, 8493.235608795238, 8573.528455934858, 8898.59956301968, 8940.3741738079, 9030.954845225864, 4964.453910069889, 4974.701517908937, 4979.90040199194, 5053.469385714447, 5123.308353372322, 3591.0842735102906, 3642.0712718256673, 3643.28955853606, 3649.1424515238896, 3652.36083685354, 641.3938827807771, 664.0371461381017, 664.1896885799317, 670.1054092786185, 674.2044387622554, 644.3009334871716, 662.7812821768805, 783.4985609210111, 802.5545822068691, 810.3193317613233, 9133.725988220363, 9259.212966897754, 9353.719388418222, 9527.78689258119, 9778.364406313567, 661.4047357378302, 790.6402586822982, 829.3199576347337, 831.6465502161557, 833.6207025803245, 4509.458864936229, 4553.5218802025975, 4603.4015577975315, 4619.953800461953, 4653.092646933883, 68981.0, 69005.0, 69568.0, 69618.3038169622, 69653.65173174102, 60089.39910600925, 61149.0, 61201.08198377028, 61958.0706289406, 62025.0, 53721.73139134279, 53913.0, 53978.19032714512, 54580.18129727978, 55266.44733552613, 9168.724938251864, 9247.398919070509, 9332.440053596805, 9421.481818500048, 9456.290778191526, 40467.0, 40623.0, 40978.385324220755, 41260.58739412567, 41564.0, 47466.0, 49666.0, 52569.47430525646, 53220.0, 53717.0, 11387.943060284646, 11485.081193504666, 11553.942230288794, 11730.76538469243, 12197.0, 12091.57679481214, 12608.621741347773, 12868.678283042998, 13106.2136271824, 13295.268760218281, 12179.512819487121, 12459.190152640049, 12561.811572826233, 12647.494100235888, 12729.236245825281, 13036.283004434468, 13433.731325373634, 13434.126781759154, 13553.728925421634, 13812.792808108088, 12203.20679155852, 12267.69330766738, 12551.93724031374, 12949.352532373532, 13075.934620327218, 11125.554977801121, 11567.652970410902, 11895.702607434883, 11910.583129590423, 12639.810402843781, 10751.784964300514, 11211.529920203046, 11273.661790146309, 11328.093752499615, 11474.139439542234], "value": 7186.2411294202175, "unit": "score"}], "name": "dromaeo_css", "value": 7493.72747262105, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 107.0, 110.0, 109.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 135.0, 151.0, 174.0, 129.0, 152.0, 153.0, 130.0, 180.0, 127.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 159.0, 161.0, 161.0, 160.0, 160.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 179.0, 77.0, 74.0, 76.0, 76.0, 163.0, 73.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 147.0, 93.0, 92.0, 92.0, 151.0, 92.0, 93.0, 151.0], "value": 109.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 97.0, 95.0, 94.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 53.0, 55.0, 53.0, 56.0, 79.0, 52.0, 52.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 58.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 72.0, 75.0, 72.0, 75.0, 73.0, 74.0, 80.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 123.0, 121.0, 115.0, 121.0, 112.0, 111.0, 116.0, 158.0, 122.0], "value": 121.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 162.0, 167.0, 163.0, 159.0, 163.0, 162.0, 160.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 65.0, 75.0, 69.0, 66.0, 66.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1521.6000000000001, "alertThreshold": 2.0}]} 20:26:20 INFO - Return code: 0 20:26:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:26:20 ERROR - # TBPL SUCCESS # 20:26:20 INFO - Running post-action listener: _resource_record_post_action 20:26:20 INFO - Running post-run listener: _resource_record_post_run 20:26:21 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 500371456; Read time: 24; Write time: 399316 20:26:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255692800; Read time: 0; Write time: 247856 20:26:21 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 244678656; Read time: 24; Write time: 151460 20:26:21 INFO - Running post-run listener: _upload_blobber_files 20:26:21 INFO - Blob upload gear active. 20:26:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:21 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 20:26:21 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'] 20:26:21 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 20:26:22 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:22 INFO - (blobuploader) - INFO - Done attempting. 20:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:25 INFO - (blobuploader) - INFO - Done attempting. 20:26:25 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:25 INFO - Return code: 0 20:26:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a3622698fee6bc429e87ea0d861aaa147be2503f047dec002c8d8acc21e3e7fffc866781695c8d88e7ea81cc96d36031922411fec8ea2302cae8f9c8de2d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8f31f96ac87eb590f24adb3d5d2a574cff99f2af29a446809203b9823dd1fe796ae6e20c059e88b744889867c6b0cef9bfb2fd8ca0505be0682aa9bc772f7c6"} 20:26:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:25 INFO - Contents: 20:26:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a3622698fee6bc429e87ea0d861aaa147be2503f047dec002c8d8acc21e3e7fffc866781695c8d88e7ea81cc96d36031922411fec8ea2302cae8f9c8de2d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8f31f96ac87eb590f24adb3d5d2a574cff99f2af29a446809203b9823dd1fe796ae6e20c059e88b744889867c6b0cef9bfb2fd8ca0505be0682aa9bc772f7c6"} 20:26:25 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:25 INFO - Copying logs to upload dir... 20:26:25 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.589750 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-05-24 20:26:25.187145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:25.190936) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a3622698fee6bc429e87ea0d861aaa147be2503f047dec002c8d8acc21e3e7fffc866781695c8d88e7ea81cc96d36031922411fec8ea2302cae8f9c8de2d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8f31f96ac87eb590f24adb3d5d2a574cff99f2af29a446809203b9823dd1fe796ae6e20c059e88b744889867c6b0cef9bfb2fd8ca0505be0682aa9bc772f7c6"} build_url:https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/EUlgSmJ4QJKj6MS9BhB_Ag/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5a3622698fee6bc429e87ea0d861aaa147be2503f047dec002c8d8acc21e3e7fffc866781695c8d88e7ea81cc96d36031922411fec8ea2302cae8f9c8de2d9bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8f31f96ac87eb590f24adb3d5d2a574cff99f2af29a446809203b9823dd1fe796ae6e20c059e88b744889867c6b0cef9bfb2fd8ca0505be0682aa9bc772f7c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:25.216329) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:25.216672) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464145555.208488-457587366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 20:26:25.298325) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:26:25.298691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 20:26:25.298976) ========= ========= Total master_lag: 0.16 =========