builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1463678783.98 results: success (0) buildid: 20160519004038 builduid: 60029db4a31e478bb3de011137e28f13 revision: c41ee7132426780f38bbffc58435548d92d2b327 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:23.978338) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:23.978995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:23.979290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:23.996820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:23.997156) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 10:26:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.7M=0s 2016-05-19 10:26:24 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125491 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.137604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.137953) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014096 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.187876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.188531) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c41ee7132426780f38bbffc58435548d92d2b327 --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 c41ee7132426780f38bbffc58435548d92d2b327 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 10:26:25,097 truncating revision to first 12 chars 2016-05-19 10:26:25,097 Setting DEBUG logging. 2016-05-19 10:26:25,097 attempt 1/10 2016-05-19 10:26:25,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c41ee7132426?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 10:26:25,348 unpacking tar archive at: mozilla-aurora-c41ee7132426/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.728226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.728563) ========= script_repo_revision: c41ee7132426780f38bbffc58435548d92d2b327 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.729018) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.729301) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 10:26:24.740374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-19 10:26:24.741038) ========= /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=920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:26:25 INFO - MultiFileLogger online at 20160519 10:26:25 in /builds/slave/test 10:26:25 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 10:26:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:26:25 INFO - {'append_to_log': False, 10:26:25 INFO - 'base_work_dir': '/builds/slave/test', 10:26:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:26:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:26:25 INFO - 'branch': 'Mozilla-Aurora', 10:26:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:26:25 INFO - 'config_files': ('talos/linux_config.py',), 10:26:25 INFO - 'default_actions': ('clobber', 10:26:25 INFO - 'read-buildbot-config', 10:26:25 INFO - 'download-and-extract', 10:26:25 INFO - 'populate-webroot', 10:26:25 INFO - 'create-virtualenv', 10:26:25 INFO - 'install', 10:26:25 INFO - 'run-tests'), 10:26:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:26:25 INFO - 'download_minidump_stackwalk': True, 10:26:25 INFO - 'download_symbols': 'ondemand', 10:26:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:26:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:26:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:26:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:26:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:26:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:26:25 INFO - 'installer_path': 'installer.exe', 10:26:25 INFO - 'log_level': 'info', 10:26:25 INFO - 'log_name': 'talos', 10:26:25 INFO - 'log_to_console': True, 10:26:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:26:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:26:25 INFO - 'opt_config_files': (), 10:26:25 INFO - 'pip_index': False, 10:26:25 INFO - 'sps_profile': False, 10:26:25 INFO - 'sps_profile_interval': 0, 10:26:25 INFO - 'suite': 'dromaeojs', 10:26:25 INFO - 'system_bits': '32', 10:26:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:26:25 INFO - 'title': 'talos-linux64-ix-053', 10:26:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:26:25 INFO - 'use_talos_json': True, 10:26:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:26:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:26:25 INFO - 'work_dir': 'build'} 10:26:25 INFO - ##### 10:26:25 INFO - ##### Running clobber step. 10:26:25 INFO - ##### 10:26:25 INFO - Running pre-action listener: _resource_record_pre_action 10:26:25 INFO - Running main action method: clobber 10:26:25 INFO - rmtree: /builds/slave/test/build 10:26:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:26:26 INFO - Running post-action listener: _resource_record_post_action 10:26:26 INFO - ##### 10:26:26 INFO - ##### Running read-buildbot-config step. 10:26:26 INFO - ##### 10:26:26 INFO - Running pre-action listener: _resource_record_pre_action 10:26:26 INFO - Running main action method: read_buildbot_config 10:26:26 INFO - Using buildbot properties: 10:26:26 INFO - { 10:26:26 INFO - "project": "", 10:26:26 INFO - "product": "firefox", 10:26:26 INFO - "script_repo_revision": "production", 10:26:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:26:26 INFO - "repository": "", 10:26:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:26:26 INFO - "buildid": "20160519004038", 10:26:26 INFO - "stage_platform": "linux64-pgo", 10:26:26 INFO - "basedir": "/builds/slave/test", 10:26:26 INFO - "nightly_build": "True", 10:26:26 INFO - "buildnumber": 336, 10:26:26 INFO - "slavename": "talos-linux64-ix-053", 10:26:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:26:26 INFO - "platform": "ubuntu64_hw", 10:26:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:26:26 INFO - "branch": "mozilla-aurora", 10:26:26 INFO - "repo_path": "releases/mozilla-aurora", 10:26:26 INFO - "revision": "c41ee7132426780f38bbffc58435548d92d2b327", 10:26:26 INFO - "pgo_build": "True", 10:26:26 INFO - "builduid": "60029db4a31e478bb3de011137e28f13", 10:26:26 INFO - "slavebuilddir": "test" 10:26:26 INFO - } 10:26:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 10:26:26 INFO - Running post-action listener: _resource_record_post_action 10:26:26 INFO - ##### 10:26:26 INFO - ##### Running download-and-extract step. 10:26:26 INFO - ##### 10:26:26 INFO - Running pre-action listener: _resource_record_pre_action 10:26:26 INFO - Running main action method: download_and_extract 10:26:26 INFO - mkdir: /builds/slave/test/build/tests 10:26: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')]} 10:26:26 INFO - https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:27 INFO - Downloaded 1361 bytes. 10:26:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 10:26:27 INFO - Using the following test package requirements: 10:26:27 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:26:27 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:26:27 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:26:27 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'jsshell-linux-x86_64.zip'], 10:26:27 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:26:27 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 10:26:27 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:26:27 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:26:27 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:26:27 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 10:26:27 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:26:27 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:26:27 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')]} 10:26:27 INFO - https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:26:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:26:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:26:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:29 INFO - Downloaded 23812015 bytes. 10:26:29 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'] 10:26:29 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 10:26:30 INFO - Return code: 0 10:26:30 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 10:26:30 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')]} 10:26:30 INFO - https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:26:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:26:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 10:26:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:32 INFO - Downloaded 23812015 bytes. 10:26:32 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'] 10:26:32 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 10:26:34 INFO - Return code: 0 10:26:34 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')]} 10:26:34 INFO - https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:26:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:26:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 10:26:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:36 INFO - Downloaded 10840145 bytes. 10:26:36 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'] 10:26:36 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 10:26:36 INFO - Return code: 0 10:26:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:36 INFO - https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:26:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:26:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:26:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5uTXz16QCivdKgpOLX-zw/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 10:26:42 INFO - Downloaded 62676925 bytes. 10:26:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:26:42 INFO - mkdir: /builds/slave/test/properties 10:26:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:26:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:26:42 INFO - Contents: 10:26:42 INFO - build_url:https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 10:26:42 INFO - Running post-action listener: _resource_record_post_action 10:26:42 INFO - Running post-action listener: set_extra_try_arguments 10:26:42 INFO - ##### 10:26:42 INFO - ##### Running populate-webroot step. 10:26:42 INFO - ##### 10:26:42 INFO - Running pre-action listener: _resource_record_pre_action 10:26:42 INFO - Running main action method: populate_webroot 10:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:26:43 INFO - '--tppagecycles', 10:26:43 INFO - '7'], 10:26:43 INFO - 'tests': ['tsvgm']}}, 10:26:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:26:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:26:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:26:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['damp', 'tps']}, 10:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'tests': ['damp', 'tps']}, 10:26:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['dromaeo_dom']}, 10:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:26:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['a11yr', 10:26:43 INFO - 'ts_paint', 10:26:43 INFO - 'tpaint', 10:26:43 INFO - 'sessionrestore', 10:26:43 INFO - 'sessionrestore_no_auto_restore', 10:26:43 INFO - 'tabpaint']}, 10:26:43 INFO - 'other-e10s': {'tests': ['a11yr', 10:26:43 INFO - 'ts_paint', 10:26:43 INFO - 'tpaint', 10:26:43 INFO - 'sessionrestore', 10:26:43 INFO - 'sessionrestore_no_auto_restore', 10:26:43 INFO - 'tabpaint']}, 10:26:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:26:43 INFO - 'ts_paint', 10:26:43 INFO - 'tpaint', 10:26:43 INFO - 'sessionrestore', 10:26:43 INFO - 'sessionrestore_no_auto_restore', 10:26:43 INFO - 'tabpaint']}, 10:26:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:26:43 INFO - 'ts_paint', 10:26:43 INFO - 'tpaint', 10:26:43 INFO - 'sessionrestore', 10:26:43 INFO - 'sessionrestore_no_auto_restore', 10:26:43 INFO - 'tabpaint']}, 10:26:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['a11yr', 10:26:43 INFO - 'ts_paint', 10:26:43 INFO - 'tpaint', 10:26:43 INFO - 'sessionrestore', 10:26:43 INFO - 'sessionrestore_no_auto_restore', 10:26:43 INFO - 'tabpaint']}, 10:26:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['a11yr', 10:26:43 INFO - 'ts_paint', 10:26:43 INFO - 'tpaint', 10:26:43 INFO - 'sessionrestore', 10:26:43 INFO - 'sessionrestore_no_auto_restore', 10:26:43 INFO - 'tabpaint']}, 10:26:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['tsvgx', 10:26:43 INFO - 'tsvgr_opacity', 10:26:43 INFO - 'tart', 10:26:43 INFO - 'tscrollx', 10:26:43 INFO - 'cart']}, 10:26:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:26:43 INFO - 'tsvgr_opacity', 10:26:43 INFO - 'tart', 10:26:43 INFO - 'tscrollx', 10:26:43 INFO - 'cart']}, 10:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'talos_options': ['--disable-e10s'], 10:26:43 INFO - 'tests': ['tp5o']}, 10:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'tests': ['tp5o']}, 10:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'talos_options': ['--disable-e10s', 10:26:43 INFO - '--xperf_path', 10:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:26:43 INFO - 'tests': ['tp5n']}, 10:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:26:43 INFO - 'talos_options': ['--xperf_path', 10:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:26:43 INFO - 'tests': ['tp5n']}}, 10:26:43 INFO - 'talos.zip': {'path': '', 10:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:26:43 INFO - Running post-action listener: _resource_record_post_action 10:26:43 INFO - ##### 10:26:43 INFO - ##### Running create-virtualenv step. 10:26:43 INFO - ##### 10:26:43 INFO - Running pre-action listener: _resource_record_pre_action 10:26:43 INFO - Running main action method: create_virtualenv 10:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 10:26:43 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 10:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:26:43 INFO - Using real prefix '/usr' 10:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:26:43 INFO - Installing distribute.............................................................................................................................................................................................done. 10:26:45 INFO - Installing pip.................done. 10:26:45 INFO - Return code: 0 10:26:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:26:45 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')]} 10:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:45 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')]} 10:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:45 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:26:45 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 10:26:45 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 10:26:45 INFO - Using env: {'DISPLAY': ':0', 10:26:45 INFO - 'HOME': '/home/cltbld', 10:26:45 INFO - 'LANG': 'en_US.UTF-8', 10:26:45 INFO - 'LANGUAGE': 'en_US:en', 10:26:45 INFO - 'LOGNAME': 'cltbld', 10:26:45 INFO - 'MAIL': '/var/mail/cltbld', 10:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:45 INFO - 'MOZ_NO_REMOTE': '1', 10:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:45 INFO - 'NO_EM_RESTART': '1', 10:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:45 INFO - 'PWD': '/builds/slave/test', 10:26:45 INFO - 'SHELL': '/bin/bash', 10:26:45 INFO - 'SHLVL': '1', 10:26:45 INFO - 'TERM': 'linux', 10:26:45 INFO - 'TMOUT': '86400', 10:26:45 INFO - 'USER': 'cltbld', 10:26:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:45 INFO - '_': '/tools/buildbot/bin/python'} 10:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:45 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 10:26:45 INFO - Cleaning up... 10:26:45 INFO - Return code: 0 10:26:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:26:45 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')]} 10:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:45 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')]} 10:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:45 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:26:45 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 10:26:45 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 10:26:45 INFO - Using env: {'DISPLAY': ':0', 10:26:45 INFO - 'HOME': '/home/cltbld', 10:26:45 INFO - 'LANG': 'en_US.UTF-8', 10:26:45 INFO - 'LANGUAGE': 'en_US:en', 10:26:45 INFO - 'LOGNAME': 'cltbld', 10:26:45 INFO - 'MAIL': '/var/mail/cltbld', 10:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:45 INFO - 'MOZ_NO_REMOTE': '1', 10:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:45 INFO - 'NO_EM_RESTART': '1', 10:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:45 INFO - 'PWD': '/builds/slave/test', 10:26:45 INFO - 'SHELL': '/bin/bash', 10:26:45 INFO - 'SHLVL': '1', 10:26:45 INFO - 'TERM': 'linux', 10:26:45 INFO - 'TMOUT': '86400', 10:26:45 INFO - 'USER': 'cltbld', 10:26:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:45 INFO - '_': '/tools/buildbot/bin/python'} 10:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:46 INFO - Downloading/unpacking psutil>=0.7.1 10:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:26:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:48 INFO - Installing collected packages: psutil 10:26:48 INFO - Running setup.py install for psutil 10:26:48 INFO - building 'psutil._psutil_linux' extension 10:26:48 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 10:26:48 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 10:26:48 INFO - building 'psutil._psutil_posix' extension 10:26:48 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 10:26:48 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 10:26:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:48 INFO - Successfully installed psutil 10:26:48 INFO - Cleaning up... 10:26:48 INFO - Return code: 0 10:26:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:26:48 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')]} 10:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:48 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')]} 10:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:48 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:26:48 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 10:26:48 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 10:26:48 INFO - Using env: {'DISPLAY': ':0', 10:26:48 INFO - 'HOME': '/home/cltbld', 10:26:48 INFO - 'LANG': 'en_US.UTF-8', 10:26:48 INFO - 'LANGUAGE': 'en_US:en', 10:26:48 INFO - 'LOGNAME': 'cltbld', 10:26:48 INFO - 'MAIL': '/var/mail/cltbld', 10:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:48 INFO - 'MOZ_NO_REMOTE': '1', 10:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:48 INFO - 'NO_EM_RESTART': '1', 10:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:48 INFO - 'PWD': '/builds/slave/test', 10:26:48 INFO - 'SHELL': '/bin/bash', 10:26:48 INFO - 'SHLVL': '1', 10:26:48 INFO - 'TERM': 'linux', 10:26:48 INFO - 'TMOUT': '86400', 10:26:48 INFO - 'USER': 'cltbld', 10:26:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:48 INFO - '_': '/tools/buildbot/bin/python'} 10:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:26:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:26:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:26:50 INFO - Installing collected packages: mozsystemmonitor 10:26:50 INFO - Running setup.py install for mozsystemmonitor 10:26:50 INFO - Successfully installed mozsystemmonitor 10:26:50 INFO - Cleaning up... 10:26:50 INFO - Return code: 0 10:26:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:26:50 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')]} 10:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:50 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')]} 10:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:50 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:26:50 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 10:26:50 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 10:26:50 INFO - Using env: {'DISPLAY': ':0', 10:26:50 INFO - 'HOME': '/home/cltbld', 10:26:50 INFO - 'LANG': 'en_US.UTF-8', 10:26:50 INFO - 'LANGUAGE': 'en_US:en', 10:26:50 INFO - 'LOGNAME': 'cltbld', 10:26:50 INFO - 'MAIL': '/var/mail/cltbld', 10:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:50 INFO - 'MOZ_NO_REMOTE': '1', 10:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:50 INFO - 'NO_EM_RESTART': '1', 10:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:50 INFO - 'PWD': '/builds/slave/test', 10:26:50 INFO - 'SHELL': '/bin/bash', 10:26:50 INFO - 'SHLVL': '1', 10:26:50 INFO - 'TERM': 'linux', 10:26:50 INFO - 'TMOUT': '86400', 10:26:50 INFO - 'USER': 'cltbld', 10:26:50 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:50 INFO - '_': '/tools/buildbot/bin/python'} 10:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:51 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 10:26:51 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 10:26:51 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 10:26:51 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 10:26:51 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 10:26:51 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 10:26:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:26:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:26:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 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 10:26:53 INFO - Downloading docopt-0.6.1.tar.gz 10:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:26:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:53 INFO - Running setup.py install for blobuploader 10:26:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:26:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:26:53 INFO - Running setup.py install for requests 10:26:54 INFO - Running setup.py install for docopt 10:26:54 INFO - Successfully installed blobuploader requests docopt 10:26:54 INFO - Cleaning up... 10:26:54 INFO - Return code: 0 10:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:54 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:26:54 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 10:26:54 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 10:26:54 INFO - Using env: {'DISPLAY': ':0', 10:26:54 INFO - 'HOME': '/home/cltbld', 10:26:54 INFO - 'LANG': 'en_US.UTF-8', 10:26:54 INFO - 'LANGUAGE': 'en_US:en', 10:26:54 INFO - 'LOGNAME': 'cltbld', 10:26:54 INFO - 'MAIL': '/var/mail/cltbld', 10:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:54 INFO - 'MOZ_NO_REMOTE': '1', 10:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:54 INFO - 'NO_EM_RESTART': '1', 10:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:54 INFO - 'PWD': '/builds/slave/test', 10:26:54 INFO - 'SHELL': '/bin/bash', 10:26:54 INFO - 'SHLVL': '1', 10:26:54 INFO - 'TERM': 'linux', 10:26:54 INFO - 'TMOUT': '86400', 10:26:54 INFO - 'USER': 'cltbld', 10:26:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:54 INFO - '_': '/tools/buildbot/bin/python'} 10:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:54 INFO - Running setup.py (path:/tmp/pip-0Pw_Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:54 INFO - Running setup.py (path:/tmp/pip-PE9WCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:54 INFO - Running setup.py (path:/tmp/pip-DfKJg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:54 INFO - Running setup.py (path:/tmp/pip-Pko6BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:54 INFO - Running setup.py (path:/tmp/pip-nFIlqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:54 INFO - Running setup.py (path:/tmp/pip-F9iY0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:54 INFO - Running setup.py (path:/tmp/pip-Hi0uoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:55 INFO - Running setup.py (path:/tmp/pip-zQL0FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:55 INFO - Running setup.py (path:/tmp/pip-d9q_wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:55 INFO - Running setup.py (path:/tmp/pip-MpDeSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:55 INFO - Running setup.py (path:/tmp/pip-AR0mLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:55 INFO - Running setup.py (path:/tmp/pip-Ddh24n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:55 INFO - Running setup.py (path:/tmp/pip-_kfo_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:55 INFO - Running setup.py (path:/tmp/pip-tlx3JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:55 INFO - Running setup.py (path:/tmp/pip-C1rsZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:55 INFO - Running setup.py (path:/tmp/pip-pg_Wve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:55 INFO - Running setup.py (path:/tmp/pip-x7LJ0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:55 INFO - Running setup.py install for manifestparser 10:26:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:26:55 INFO - Running setup.py install for mozcrash 10:26:55 INFO - Running setup.py install for mozdebug 10:26:56 INFO - Running setup.py install for mozdevice 10:26:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Running setup.py install for mozfile 10:26:56 INFO - Running setup.py install for mozhttpd 10:26:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Running setup.py install for mozinfo 10:26:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Running setup.py install for mozInstall 10:26:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Running setup.py install for mozleak 10:26:56 INFO - Running setup.py install for mozlog 10:26:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Running setup.py install for moznetwork 10:26:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:26:56 INFO - Running setup.py install for mozprocess 10:26:56 INFO - Running setup.py install for mozprofile 10:26:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:26:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:26:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:26:57 INFO - Running setup.py install for mozrunner 10:26:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:26:57 INFO - Running setup.py install for mozscreenshot 10:26:57 INFO - Running setup.py install for moztest 10:26:57 INFO - Running setup.py install for mozversion 10:26:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:26:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:57 INFO - Cleaning up... 10:26:57 INFO - Return code: 0 10:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:57 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:26:57 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 10:26:57 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 10:26:57 INFO - Using env: {'DISPLAY': ':0', 10:26:57 INFO - 'HOME': '/home/cltbld', 10:26:57 INFO - 'LANG': 'en_US.UTF-8', 10:26:57 INFO - 'LANGUAGE': 'en_US:en', 10:26:57 INFO - 'LOGNAME': 'cltbld', 10:26:57 INFO - 'MAIL': '/var/mail/cltbld', 10:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:57 INFO - 'MOZ_NO_REMOTE': '1', 10:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:26:57 INFO - 'NO_EM_RESTART': '1', 10:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:57 INFO - 'PWD': '/builds/slave/test', 10:26:57 INFO - 'SHELL': '/bin/bash', 10:26:57 INFO - 'SHLVL': '1', 10:26:57 INFO - 'TERM': 'linux', 10:26:57 INFO - 'TMOUT': '86400', 10:26:57 INFO - 'USER': 'cltbld', 10:26:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:57 INFO - '_': '/tools/buildbot/bin/python'} 10:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:57 INFO - Running setup.py (path:/tmp/pip-QLOwax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:57 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)) 10:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:57 INFO - Running setup.py (path:/tmp/pip-qgSnvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:57 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)) 10:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:57 INFO - Running setup.py (path:/tmp/pip-QZHtHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:57 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)) 10:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:57 INFO - Running setup.py (path:/tmp/pip-xwX4zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:58 INFO - Running setup.py (path:/tmp/pip-FshFzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:58 INFO - Running setup.py (path:/tmp/pip-YbJJ30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:58 INFO - Running setup.py (path:/tmp/pip-nEnHyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:58 INFO - Running setup.py (path:/tmp/pip-dW4HWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:58 INFO - Running setup.py (path:/tmp/pip-w8cT0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:58 INFO - Running setup.py (path:/tmp/pip-JmDqI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:58 INFO - Running setup.py (path:/tmp/pip-2xHqYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:58 INFO - Running setup.py (path:/tmp/pip-WPJkbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:58 INFO - Running setup.py (path:/tmp/pip-I4Hy0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:58 INFO - Running setup.py (path:/tmp/pip-KyJCv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:58 INFO - Running setup.py (path:/tmp/pip-asLiW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:58 INFO - Running setup.py (path:/tmp/pip-1uzSfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:58 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)) 10:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:58 INFO - Running setup.py (path:/tmp/pip-ymhVBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:58 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)) 10:26:58 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)) 10:26:58 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)) 10:26:58 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)) 10:26:58 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)) 10:26:58 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)) 10:26:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:58 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 10:26:58 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 10:26:58 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 10:26:58 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 10:26:58 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 10:26:58 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 10:27:00 INFO - Downloading blessings-1.6.tar.gz 10:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:27:00 INFO - Installing collected packages: blessings 10:27:00 INFO - Running setup.py install for blessings 10:27:01 INFO - Successfully installed blessings 10:27:01 INFO - Cleaning up... 10:27:01 INFO - Return code: 0 10:27:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:27:01 INFO - Reading from file tmpfile_stdout 10:27:01 INFO - Current package versions: 10:27:01 INFO - argparse == 1.2.1 10:27:01 INFO - blessings == 1.6 10:27:01 INFO - blobuploader == 1.2.4 10:27:01 INFO - docopt == 0.6.1 10:27:01 INFO - manifestparser == 1.1 10:27:01 INFO - mozInstall == 1.12 10:27:01 INFO - mozcrash == 0.17 10:27:01 INFO - mozdebug == 0.1 10:27:01 INFO - mozdevice == 0.48 10:27:01 INFO - mozfile == 1.2 10:27:01 INFO - mozhttpd == 0.7 10:27:01 INFO - mozinfo == 0.9 10:27:01 INFO - mozleak == 0.1 10:27:01 INFO - mozlog == 3.1 10:27:01 INFO - moznetwork == 0.27 10:27:01 INFO - mozprocess == 0.22 10:27:01 INFO - mozprofile == 0.28 10:27:01 INFO - mozrunner == 6.11 10:27:01 INFO - mozscreenshot == 0.1 10:27:01 INFO - mozsystemmonitor == 0.0 10:27:01 INFO - moztest == 0.7 10:27:01 INFO - mozversion == 1.4 10:27:01 INFO - psutil == 3.1.1 10:27:01 INFO - requests == 1.2.3 10:27:01 INFO - wsgiref == 0.1.2 10:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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')]} 10:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:01 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:27:01 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 10:27:01 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 10:27:01 INFO - Using env: {'DISPLAY': ':0', 10:27:01 INFO - 'HOME': '/home/cltbld', 10:27:01 INFO - 'LANG': 'en_US.UTF-8', 10:27:01 INFO - 'LANGUAGE': 'en_US:en', 10:27:01 INFO - 'LOGNAME': 'cltbld', 10:27:01 INFO - 'MAIL': '/var/mail/cltbld', 10:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:01 INFO - 'MOZ_NO_REMOTE': '1', 10:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:01 INFO - 'NO_EM_RESTART': '1', 10:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:01 INFO - 'PWD': '/builds/slave/test', 10:27:01 INFO - 'SHELL': '/bin/bash', 10:27:01 INFO - 'SHLVL': '1', 10:27:01 INFO - 'TERM': 'linux', 10:27:01 INFO - 'TMOUT': '86400', 10:27:01 INFO - 'USER': 'cltbld', 10:27:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:01 INFO - '_': '/tools/buildbot/bin/python'} 10:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 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)) 10:27:01 INFO - Cleaning up... 10:27:01 INFO - Return code: 0 10:27:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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')]} 10:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:01 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 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:27:01 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 10:27:01 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 10:27:01 INFO - Using env: {'DISPLAY': ':0', 10:27:01 INFO - 'HOME': '/home/cltbld', 10:27:01 INFO - 'LANG': 'en_US.UTF-8', 10:27:01 INFO - 'LANGUAGE': 'en_US:en', 10:27:01 INFO - 'LOGNAME': 'cltbld', 10:27:01 INFO - 'MAIL': '/var/mail/cltbld', 10:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:01 INFO - 'MOZ_NO_REMOTE': '1', 10:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:01 INFO - 'NO_EM_RESTART': '1', 10:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:01 INFO - 'PWD': '/builds/slave/test', 10:27:01 INFO - 'SHELL': '/bin/bash', 10:27:01 INFO - 'SHLVL': '1', 10:27:01 INFO - 'TERM': 'linux', 10:27:01 INFO - 'TMOUT': '86400', 10:27:01 INFO - 'USER': 'cltbld', 10:27:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:01 INFO - '_': '/tools/buildbot/bin/python'} 10:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:01 INFO - Downloading/unpacking jsonschema 10:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:27:03 INFO - Downloading/unpacking functools32 (from jsonschema) 10:27:03 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 10:27:03 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 10:27:03 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 10:27:03 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 10:27:03 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 10:27:03 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 10:27:03 INFO - Downloading functools32-3.2.3-2.tar.gz 10:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:27:03 INFO - warning: no files found matching '*.txt' 10:27:03 INFO - no previously-included directories found matching 'build' 10:27:03 INFO - no previously-included directories found matching 'dist' 10:27:03 INFO - no previously-included directories found matching '.git*' 10:27:03 INFO - Installing collected packages: jsonschema, functools32 10:27:03 INFO - Running setup.py install for functools32 10:27:04 INFO - warning: no files found matching '*.txt' 10:27:04 INFO - no previously-included directories found matching 'build' 10:27:04 INFO - no previously-included directories found matching 'dist' 10:27:04 INFO - no previously-included directories found matching '.git*' 10:27:04 INFO - Successfully installed jsonschema functools32 10:27:04 INFO - Cleaning up... 10:27:04 INFO - Return code: 0 10:27:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:27: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')]} 10:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27: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')]} 10:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:27:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0e455bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', '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 10:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:27:04 INFO - Using env: {'DISPLAY': ':0', 10:27:04 INFO - 'HOME': '/home/cltbld', 10:27:04 INFO - 'LANG': 'en_US.UTF-8', 10:27:04 INFO - 'LANGUAGE': 'en_US:en', 10:27:04 INFO - 'LOGNAME': 'cltbld', 10:27:04 INFO - 'MAIL': '/var/mail/cltbld', 10:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:04 INFO - 'MOZ_NO_REMOTE': '1', 10:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:04 INFO - 'NO_EM_RESTART': '1', 10:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:04 INFO - 'PWD': '/builds/slave/test', 10:27:04 INFO - 'SHELL': '/bin/bash', 10:27:04 INFO - 'SHLVL': '1', 10:27:04 INFO - 'TERM': 'linux', 10:27:04 INFO - 'TMOUT': '86400', 10:27:04 INFO - 'USER': 'cltbld', 10:27:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:04 INFO - '_': '/tools/buildbot/bin/python'} 10:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:27:04 INFO - Downloading/unpacking flake8 10:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:27:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:27:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:27:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:27:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:27:06 INFO - no previously-included directories found matching 'docs/_build' 10:27:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:27:07 INFO - Running setup.py install for pep8 10:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:27:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:27:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:27:07 INFO - no previously-included directories found matching 'docs/_build' 10:27:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:27:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:27:07 INFO - Cleaning up... 10:27:07 INFO - Return code: 0 10:27:07 INFO - Running post-action listener: _resource_record_post_action 10:27:07 INFO - Running post-action listener: _start_resource_monitoring 10:27:07 INFO - Starting resource monitoring. 10:27:07 INFO - ##### 10:27:07 INFO - ##### Running install step. 10:27:07 INFO - ##### 10:27:07 INFO - Running pre-action listener: _resource_record_pre_action 10:27:07 INFO - Running main action method: install 10:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:27:07 INFO - Reading from file tmpfile_stdout 10:27:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:27:07 INFO - Reading from file tmpfile_stdout 10:27:07 INFO - Output received: 10:27:07 INFO - Usage: mozinstall [options] installer 10:27:07 INFO - Options: 10:27:07 INFO - -h, --help show this help message and exit 10:27:07 INFO - -d DEST, --destination=DEST 10:27:07 INFO - Directory to install application into. [default: 10:27:07 INFO - "/builds/slave/test"] 10:27:07 INFO - --app=APP Application being installed. [default: firefox] 10:27:07 INFO - mkdir: /builds/slave/test/build/application 10:27:07 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'] 10:27:07 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 10:27:23 INFO - Reading from file tmpfile_stdout 10:27:23 INFO - Output received: 10:27:23 INFO - /builds/slave/test/build/application/firefox/firefox 10:27:23 INFO - Running post-action listener: _resource_record_post_action 10:27:23 INFO - ##### 10:27:23 INFO - ##### Running run-tests step. 10:27:23 INFO - ##### 10:27:23 INFO - Running pre-action listener: _resource_record_pre_action 10:27:23 INFO - Running main action method: run_tests 10:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:27:23 INFO - Python 2.7.3 10:27:23 INFO - Return code: 0 10:27:23 INFO - grabbing minidump binary from tooltool 10:27:23 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')]} 10:27:23 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 0x299a410>, '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 0x299b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:27:23 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 10:27:23 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 10:27:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:27:23 INFO - Return code: 0 10:27:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:27:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:27:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:27:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:27:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:27:24 INFO - Return code: 0 10:27:24 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/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:27:24 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/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:27:24 INFO - Using env: {'DISPLAY': ':0', 10:27:24 INFO - 'HOME': '/home/cltbld', 10:27:24 INFO - 'LANG': 'en_US.UTF-8', 10:27:24 INFO - 'LANGUAGE': 'en_US:en', 10:27:24 INFO - 'LOGNAME': 'cltbld', 10:27:24 INFO - 'MAIL': '/var/mail/cltbld', 10:27:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:27:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:24 INFO - 'MOZ_NO_REMOTE': '1', 10:27:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:27:24 INFO - 'NO_EM_RESTART': '1', 10:27:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:24 INFO - 'PWD': '/builds/slave/test', 10:27:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:27:24 INFO - 'SHELL': '/bin/bash', 10:27:24 INFO - 'SHLVL': '1', 10:27:24 INFO - 'TERM': 'linux', 10:27:24 INFO - 'TMOUT': '86400', 10:27:24 INFO - 'USER': 'cltbld', 10:27:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303', 10:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:24 INFO - '_': '/tools/buildbot/bin/python'} 10:27:24 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/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:27:24 INFO - mozversion application_buildid: 20160519004038 10:27:24 INFO - mozversion application_changeset: c41ee7132426780f38bbffc58435548d92d2b327 10:27:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:27:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:27:24 INFO - mozversion application_name: Firefox 10:27:24 INFO - mozversion application_remotingname: firefox-dev 10:27:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:27:24 INFO - mozversion application_vendor: Mozilla 10:27:24 INFO - mozversion application_version: 48.0a2 10:27:24 INFO - mozversion platform_buildid: 20160519004038 10:27:24 INFO - mozversion platform_changeset: c41ee7132426780f38bbffc58435548d92d2b327 10:27:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:27:24 INFO - mozversion platform_version: 48.0a2 10:27:24 INFO - using testdate: 1463678844 10:27:24 INFO - actual date: 1463678844 10:27:24 INFO - starting webserver on 'localhost:33143' 10:27:24 INFO - SUITE-START | Running 2 tests 10:27:24 INFO - TEST-START | dromaeo_css 10:27:24 INFO - operating with platform_type : linux_ 10:27:24 INFO - Initialising browser for dromaeo_css test... 10:27:24 INFO - TEST-INFO | started process 2440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5g_9pl/profile http://localhost:33143/getInfo.html) 10:27:28 INFO - PROCESS | 2440 | __metrics Screen width/height:1600/1200 10:27:28 INFO - PROCESS | 2440 | colorDepth:24 10:27:28 INFO - PROCESS | 2440 | Browser inner width/height: 1024/697 10:27:28 INFO - PROCESS | 2440 | __metrics 10:27:29 ERROR - PROCESS | 2440 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:27:30 INFO - TEST-INFO | 2440: exit 0 10:27:30 INFO - Browser initialized. 10:27:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:27:30 INFO - TEST-INFO | started process 2549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5g_9pl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:42 INFO - PROCESS | 2549 | RSS: Main: 142016512 10:27:42 INFO - PROCESS | 2549 | 10:28:33 INFO - PROCESS | 2549 | 1463678913358 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] 10:30:40 INFO - PROCESS | 2549 | Cycle 1(1): loaded http://localhost:33143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33143/tests/dromaeo/cssquery-ext.html) 10:30:41 INFO - PROCESS | 2549 | RSS: Main: 244957184 10:30:41 INFO - PROCESS | 2549 | 10:33:44 INFO - PROCESS | 2549 | Cycle 1(1): loaded http://localhost:33143/tests/dromaeo/cssquery-ext.html (next: http://localhost:33143/tests/dromaeo/cssquery-jquery.html) 10:33:44 INFO - PROCESS | 2549 | RSS: Main: 231448576 10:33:44 INFO - PROCESS | 2549 | 10:36:46 INFO - PROCESS | 2549 | Cycle 1(1): loaded http://localhost:33143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33143/tests/dromaeo/cssquery-mootools.html) 10:36:46 INFO - PROCESS | 2549 | RSS: Main: 222740480 10:36:46 INFO - PROCESS | 2549 | 10:39:48 INFO - PROCESS | 2549 | Cycle 1(1): loaded http://localhost:33143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33143/tests/dromaeo/cssquery-prototype.html) 10:39:49 INFO - PROCESS | 2549 | RSS: Main: 226123776 10:39:49 INFO - PROCESS | 2549 | 10:42:51 INFO - PROCESS | 2549 | Cycle 1(1): loaded http://localhost:33143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33143/tests/dromaeo/cssquery-yui.html) 10:42:52 INFO - PROCESS | 2549 | RSS: Main: 209924096 10:42:52 INFO - PROCESS | 2549 | 10:45:54 INFO - PROCESS | 2549 | Cycle 1(1): loaded http://localhost:33143/tests/dromaeo/cssquery-yui.html (next: http://localhost:33143/tests/dromaeo/cssquery-dojo.html) 10:45:55 INFO - PROCESS | 2549 | RSS: Main: 257974272 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | __start_tp_report 10:45:55 INFO - PROCESS | 2549 | _x_x_mozilla_page_load 10:45:55 INFO - PROCESS | 2549 | _x_x_mozilla_page_load_details 10:45:55 INFO - PROCESS | 2549 | |i|pagename|runs| 10:45:55 INFO - PROCESS | 2549 | |0;dojo.html;3296.835158242088;3349.6315405305413;3366.27625060612;3373.6795004474598;3389.068006298268;5514.751836167372;5519.751611177497;5522.171674248864;5527.060399732045;5528.75120619572;5525.364583072947;5540.9168862466995;5543.861403464915;5545.00189965806;5579.414161513044;4908.607311415096;5039.496050394959;5119.334486516747;5171.120909445384;5190.455002224769;5014.373203349582;5089.949100508985;5094.7197904115255;5097.770600322994;5103.464136265694;5009.949900500985;5067;5142.382914050319;5157.071727089123;5163.767630456619;5117.078925793356;5119.206522988924;5129.846104616849;5131.461196574381;5156.20078887773;4960.528749768766;5004.099262132815;5032;5050.116229659831;5086.46592107827;5392.2181283714035;5392.379876314235;5405.054115529767;5441.211024401479;5444.156155795818;5924.526037916957;5938.020226662596;5943.52451803859;5944.702764861783;5949;5887.087501437241;5962.582619216657;5970.194023806774;5982.162497250389;6002.669853158074;5540.501354878081;5543.113101903717;5554.028045092093;5557.277553917965;5566.081596536607;5930.55520835939;6081.75672973085;6088.543359248074;6099.817005489843;6099.817005489843;5783.566232532577;5826.6795326256615;5829.271341082364;5835.941640583625;5853.414658534112;5928.051511758098;5945.7621695132575;5955.957707401188;5956.731947062306;5967.9701601491715;5705.372409035086;5890.528757699374;5900;5915.37888521699;5919.200907877467;5786.450287222707;5874.882502350015;5890.734916928748;5891.027980383275;5927.436893495111;4500.437445319335;4501.842435514741;4505.797239124247;4509.594136527729;4529.162105010583;3917.138229589486;4015.377616469452;4058.350663893763;4081.8571350003203;4087.4890638670167;5605.943940560624;5682.090865461506;5707.600467967285;5729.25519682447;5744.195812586241;5964.940350596526;5965.164876917235;5971.0744834550715;5972;5975.25309336333;5599.972000139973;5605.607607467519;5635.380108188096;5692.117721753135;5713.771449142071;5121.4878512149235;5124.461931497139;5125.256837758504;5126.871828204325;5139.486051394831;6109.358517355702;6132.325444201134;6136.509079273647;6142.6314421134875;6143.56995010354;5856.707164641836;5892.94107058924;5919.763209471659;5981.192539007352;5984.551158663031;6109.053096770008;6146.692665366624;6147.969260153671;6162.599431036968;6166.290876549075;5793.507551857971;5802.738876750641;5803.709814509342;5804.390538993345;5808.73860676279;5702.144678298288;5882.294124705063;5903.852403689943;5930.644161350333;5934.465898069195;5776.42235776419;5815.3893841147765;5817.883642327214;5822.592418530662;5825.912611310749;5723.771049158154;5745.569082318759;5780.450857168562;5782.3639399666845;5785.82642520725;5572.972135139298;5663.518600918968;5732.455416735404;5757.942420575908;5768.480836724715;5762.538996880324;5782.710864456844;5785.508231800344;5792.739326730223;5809.854753631024;5597.04850175463;5681.0626246668835;5685.545156387562;5687.43125687428;5691.4877661010705 10:45:55 INFO - PROCESS | 2549 | |1;ext.html;668.431832941999;689.8861687821509;690.6443181761391;725.5066554742773;744.7616762635955;33216;33748.66251337486;33840.32319353611;39080;40231.59768402315;42181.156376872445;42729;42788.14423711524;42790;42855.571444285546;8840.955795221014;9018;9047.140521650434;9047.23098536622;9048.095190480932;8736.301095912311;8863.734087977338;8905.73282801517;8908.866367004468;8914.73255802327;9098.317626178063;9177.174054335108;9178.954105229464;9180.127887850644;9181.127792859668;9058.728238152833;9120.042395548504;9121.589528471235;9123.315751318678;9125.863112053325;8961.417507862034;9075.183233509017;9076.68231611897;9084.8637270441;9088.136627020422;42937.141257175;43410.78294608538;43458.130837383076;43574.782126089485;43733.56266437327;3827.885163445101;3890.1247219375696;3990.840366385341;4361.80371883266;4704.506026867164;29873;29956.101316960525;30219.697803021907;31623;31684.841575792205;4544.750038747868;4639.257718764981;4643.628509719214;4650.698104253585;4693.7653117344;285305;289033;290453;290814;291201;62005.68997154985;62807.37192628106;63105.68447157735;63166.36833631697;63352;65707;66285.66857165683;66446.33553664498;66682.99975500371;66691.66654166795;19928;19959.800401996086;19978;20165.596688066158;20175.39473815788;15431;15524;15550.611234719223;15559.377624895104;15561.221938903009;19995.200191992157;20730.170793168105;20740.481487962923;20865.165393384093;20902.163913443597;7472.571414290377;7634.236576342432;7681.731139410093;7701.499402538929;7742.070951485745;1108.6286094158386;1123.7808627317759;1149.4597539156582;1160.2516376936828;1190.7797057544383;33879.66120338765;34015;34133;34339.31321373609;34640.30719385598;1229.9508019679113;1256.39065053449;1260.2816394655142;1298.79868620364;1324.3113580937859;17730.556736081442;17735.911320443316;17822.46532603998;17949.7307540387;18068.277268909358;508656;517471;517547;518129;518278;62846.37153628497;64426;64440.99999999906;64664.67667661631;64699;1483.3695679336238;1487.8512148785035;1517.1958861803262;1572.5754046407405;1600.5598460423478;30391.84804076054;31298.37403251877;32495.675043249266;33871.83064084664;33908.66091339055;49592.75203623959;50072.49927500678;50582.74708626433;50685.74657126691;50726;328435;330275;331866;331932;332270;27600.723992759817;30624;49725.75137124291;50236.49763502464;50963.49036509587;50303;50317.24524132214;50386.74806625943;50431.747841260556;52022.73988630184;41127.58872411238;41509.58490415057;43445.05221282944;44245.33631995587;44452.777736111115;43173.3523997134;43842.56157438385;44327.33508997303;44520.77739611411;45499.77250113728;47148.52851471442;47169.76415117903;47238;49095.50904491052;49140;36316;37335.43996839995;38195.61804381921;38298;38684.41973370458;29069.965102442628;29205.182922300424;29583.704162958096;31169;31304.686953130178 10:45:55 INFO - PROCESS | 2549 | |2;jquery.html;412.82661282261455;413.7000674510978;420.70340410010925;431.5404094639209;432.312622929542;14352.425902963869;18790.15444305006;19327;19348.226070957164;20403.285884994028;16332.75500867488;19073.141708623112;19646;19918.701219481718;20629.690554641656;5711.2575365202565;5834.970825145869;5862.560307976897;5867.941320586803;5886.617369870966;5887.558433117512;5985.401459854002;5985.670788106652;5993.041113421853;5994.760209591633;4300.247456695081;4480.081583275421;6094.847628809271;6381.329960354165;6389.904151437732;6158;6313.747450101991;6331.113644089831;6364.363563643645;6365.077063825743;5691.373948865621;5717.285339332583;5728.369879313273;5733.684647344395;5734.856628584277;22302.107915683355;22685.886570567207;22997.967074580385;23500;23545.29364119079;2561.065211197918;2603.06289735695;2606.648102506156;2728.290644432442;2732.6447561816835;14758.852411475855;15230.923845380814;15393;15500.147491888054;15505.302261398265;2040.5714799892041;2114.1437717724193;2116.703661487393;2135.1459416233474;2150.0754675489534;54178.72910635461;83258.16741832625;83377.58311208466;83416.58291708563;83561;10731.40977246259;11091.667249982513;11330.546778128948;11364.374959377148;11380.886191137983;15771.68456630861;15858.60353491172;15912.92043539775;16009.919950400406;16015.679686406207;9142.771430714285;9265.907340926504;9271.304652151115;9271.90728092724;9385.530723463937;9308.627654893864;9430.245580353692;9492.762680933032;9509.857352139723;9575.712728618153;6254.937450625526;6506.674666266667;6891.310868913069;7057.6118313492225;7159.319864612853;1933.5552822850823;1986.960260794776;1990.5819777846814;1997.610465959124;2041.3263623004373;787.9724209652635;1144.8397224388593;1181.0846593889632;1189.3815216087587;1244.4773195258012;17845.643087138185;19472.415827525198;20295.086721097585;20413.591728165353;20500;1096.9122470202365;1097.8408130821147;1132.8017596920506;1197.874223206568;1257.836481257449;11625.709357265967;11750.29498230109;11834.408279585987;11834.644960651194;11855.762884742257;541600;549042;569371;570773;576817;51273.743631281606;77377.226227737;78588;82525.58737206276;85084.14915850763;1114.2590177532013;1131.2420678145663;1141.2866958151155;1143.3654321851286;1146.2863019785307;17503;17664;17964.461066168034;18024;18317.450476485727;36436.81781591181;37250;37573.43639845459;37813;37930.81034594809;51080.74459627678;51235.74382128065;51300.23049654184;51344;51373.74313128411;7222.638868056471;7974.202579741979;8594.226519613265;9414.67048653294;9423.528823558658;8922.598483068406;11193;13464.192148471124;13488.190708557519;13838.58484245434;11602.6519204424;11917.76164476723;12158.148929574845;12215.816762748744;12255.75488490243;11648.475818588015;11648.475818588015;11891;11919.940400297943;11983.161178717406;12174.75650487003;12274.570390036306;12337.753244935231;12641.87358126407;13035.087543872218;8562.315014798925;8663.870041949249;8684.131586841266;8761.255293299886;8826.779330516789;10916;12875.871241287467;12957.740845182854;13055.804162937373;13166.934165329112 10:45:55 INFO - PROCESS | 2549 | |3;mootools.html;1442.9927850360746;1517.4916403004993;1523.5733994481543;1726.309476209516;1853.1660752661305;7999;8190.140035296297;8192.426530142893;8192.713255036075;8195.754127376189;7776.805579860506;7927.643256053477;7928.841423171533;7934.484258523192;7941.32498737608;2028.6247044296779;2069.1516478243925;2249.853759505631;2283.703118594589;2292.1175347491253;2346.249200255919;2370.3718514593647;2371.95256094878;2372;2373.5490256851144;2287.2223444029028;2330.731965823935;2340.520193360357;2342.601757701186;2343.6484527320954;2019.1317733374642;2228.053077442081;2291.026313816621;2319.7796209360085;2325.3953971967326;2268.4895898422888;2305;2307.676925230469;2308.307507747669;2308.5844547981355;8174.182581741838;8216.342692584638;8231.670733170666;8236.794080147984;8251.381146414044;4794.928076078827;4799.664023518355;4859.975700121512;4893.119238537062;4898.167311557044;3150.7951983121025;3282.195862013822;3322.4684050551796;3323.135984643986;3341.9498707519406;1079.2175672637354;1082.3181395720646;1103.3876198709713;1110.294962698684;1133.0595605647293;11947.163698541106;11952.342621155833;11956.521739130425;11963.102767292488;11992.340421276826;4305.590968857953;4400.119976004812;4450.910981780346;4458.286674132188;4474.843380481668;10111.292209545261;10135.9493202535;10140;10160.593576257015;10170.084692377573;5142.61430392722;5151.484851514819;5184.248283998874;5185.662931909414;5186.273921650972;4260.659147268211;4329.350597410351;4504.48198457175;4635.953640463552;4766.976165119152;3886.300465916162;3970.4838371011583;4025.6376926076796;4073.5315438724333;4097.733647312915;1194.858909741195;1216.580279803484;1216.920900141488;1219.597532814187;1223.3149436315691;942.359195746885;1024.4467987286782;1025.2464438637596;1041.4740556019312;1043.9769026354215;5663.348714897757;5745.339285982082;5849.2103566018895;5875.823725288248;6001.099835024781;921.5576523268735;941.7363138321281;952.2857856607544;963.3064193780467;1032.6385764982197;3771.6794072504144;4008.779517126586;4014.6186112319283;4040.595940405936;4178.937315940202;9857.359271647463;10231.43727095002;10231.48842557884;10241.334313269614;10261.871194168636;9634.325597208128;9821.459819709984;9931.404115753077;9950.805903291506;10114.29199955996;7629.580373079534;7636.618169091523;7664.616769161631;7716.5370077795515;7716.6527506262355;5633.774649013993;5699.544036476989;5718.428157184248;5786.884262314814;5881.823545293648;8968.417052891542;9009.504477253813;9271.490068046322;9273.258139348702;9280.62877484893;8979;9022.233110185445;9213.401128926598;9371.250299976122;9382.10869967352;6793.796186114425;7419.517731347445;7570;7606.885896711665;7729.3430058445665;8086.393520485869;8132.105468398353;8143.5928203590765;8160.30637395828;8176.83646327082;7095.893561596684;7279.235680253497;7301.598412087386;7348.889766653611;7428.442866785121;6937.826554336182;7032.12098487689;7161.4986950912935;7277.963610181915;7388.187299396955;6484.546081774419;6496.025596160424;6552.3775241352;6556.114924485133;6562.704678289584;4968.403791545038;4997.125503037027;5060.1903695408555;5190.143626301769;5252.395974462986;5069.5944324454695;5092.083424983391;5139.665921715226;5166.922496162636;5181.81863634771 10:45:55 INFO - PROCESS | 2549 | |4;prototype.html;317.3779392390915;318.4220639539236;322.4421750371857;323.54057238721015;334.12292731579606;6061.787837425691;6104.473881529618;6113.174721412608;6119.969400152999;6135.631862088272;5778.942210577893;5839.79560715375;5981.46166844985;5994.970025149868;6027.27672679278;4690.742009189493;4708.670393072486;4708.905821883569;4725.787339569728;4733.952660473386;4697.859064228079;4707.482176960549;4714.222153344694;4719.740414277213;4725.125851717443;4402.40567523385;4521.954780452186;4626.6298696104395;4655.790489427984;4680.204365257898;4623.976880115578;4649.325847752091;4653.069386122772;4663.417072865892;4668.953310466886;4068.9186216275803;4074.368472886678;4074.4295798588223;4082.5713300103657;4085.9591404085877;5871.4715675589405;5892.823215303548;5894.08641660539;5903.144044113623;5904.498117660004;5355.0896347621;5360.410354860962;5361.08861493547;5363.061464243741;5371.677699338053;6204.689765511752;6339.0808332791485;6369.299377068519;6379.553431259814;6381.8085457436355;4229.809658565372;4256.638185754215;4259.680523960685;4260.10537787062;4262.893427664302;6590.571612845198;6618.305077966792;6650.93349066508;6664.83337916556;6675.699593518255;4416.359627854007;4422.668299877522;4424;4427.645788336926;4428.557144285545;4471.150481408522;4474.6420286377015;4479.17135329965;4479.395281637003;4487.820487180476;5245.423003469616;5246.213068039825;5246.711430871339;5250.763715632729;5254.4220135785035;6288.748450062038;6422.068800024063;6450.77422290227;6456.677166141674;6463.289038205794;1486.2345891865698;1562.8202756683127;1579.968400631981;1584.3108247912196;1588.602849287678;1016.6645007147623;1018.1803648063232;1020.3316827477865;1026.6047571684956;1030.567161792049;6152.907706384318;6234.470070044097;6239;6241.687915604201;6263.530235232376;6595.901061484082;6597.241317248482;6610.7025183866845;6612.570182938093;6612.9749888766355;6237.126802247689;6248.062790581449;6251.59364641306;6253.593516421418;6255.530835187288;3537.4163263061823;3570.3573356795505;3571.1250743567994;3571.3750093733493;3574;6699.899501507482;6791.694373753193;6850.212225594021;6853.451723862079;6876.243613202544;6689.096971908827;6708.2956289589865;6711.194656641234;6711.429528490035;6714.429273511709;6848.383645471832;6859.2454829968665;6860.382565569123;6863.759768408082;6864.656767161622;6608.570442921195;6611.206655201407;6611.504137189634;6617.205935287796;6625.768098116736;6372.139761132374;6510.0885875976455;6514.1531600891585;6520.9347906520325;6522.804315870531;6854.931450685429;6872.312768723088;6873.553219040747;6884.759033433806;6904.93095069063;4462.955370446384;4466.977665111654;4469.21788686985;4469.927217467849;4483.036147228361;6570.408663220333;6570.8357291068105;6572.211334639874;6578.177727784027;6578.605283682994;6251.34360892118;6397.168368112116;6408.871822563616;6506.121673574196;6511.34886511345;6405.423511883952;6439.323870993666;6467.676616169078;6467.676616169267;6474.352564743488;6355.841103972438;6358.1734374531015;6358.300586935341;6371.617702937839;6372.203474565679;6496.220453545605;6499.38255865692;6503.837404064936;6509.088727578238;6510.18622672166;6146.262448506208;6329.050642403677;6344.811040191126;6353.174087368612;6376.171097757448 10:45:55 INFO - PROCESS | 2549 | |5;yui.html;823.2426167925508;860.8536548786706;866.1381924984645;918.7014220378379;930.2325581395351;15388.15365154916;15529.922350388233;15684.451044213454;15707.528774136767;15714.292856821441;14249.92875035626;14285.500007499739;14345.78481322781;14357.856421435808;14396.424143034292;751.4289140253405;882.814608932125;895.6059333893066;896.8430524658191;902.6028547439106;885.5704983083232;886.6143227695941;893.7274131389923;893.8480458322068;894.8478758611019;942.6182396129544;945.6642891773424;945.9243260539175;946.6166202687922;953.3136141977765;790.1940021178394;931;935.4667839331584;945.8439357506038;946.1059298962483;696.2202333386639;697.0206859362604;697.0276464332279;698.0157977252101;698.0576222100124;14785.186814725186;14801.259937003215;14831.851681483264;14882.851171488255;14896.553103406915;14099.36552855124;14913.030653007629;14926.40294388223;15004.399824007027;15063.472778452702;11994.100442466763;12030.097742669335;12112.697182570419;12128.57549985755;12354.814677779841;3996.820143093568;4013.6387725104587;4026.094128821021;4081.69387295954;4108.301588729893;54778.45221547774;54849.45150548523;54914;54916.45083549193;56278;10877.347359158475;11113.722156946142;11198.720031999103;11280.153988450898;11440.256383335223;18669.346572869883;18758.437246882615;18817.247310107443;18846.623067538847;18878.24487020504;8442;8492.751901140698;8551.786205344915;8565.828683426296;8743.868841967376;4947.876303092379;5044;5098.1842905135;5329.493698098674;5358.5981051421295;3464.549608550872;3505.5793304803587;3506.1409954560786;3510.069831494656;3511.3328467591077;649.8277956341574;651.3974573519475;655.4788942790493;665.737033871618;670.1991120610824;670.3698523388;693.5942473652868;724.7427163356932;757.4394947738633;769.5690413368532;9055.23030542398;9555;9678.17735492477;9809.803803923882;9821.017898210122;744.1925510820712;779.9571023593643;785.4776573578621;802;819.3649921311031;4414.095110502403;4419.64642828573;4454.37638730578;4503.527129651405;4565.543445655474;71338;72942.63528682428;72964;73009;73756;60120.699396502736;62321.68839155775;63417.365826342066;63710.68144659247;64642.67678661671;54639.72680136574;54881.45118548843;55284.99999999919;55448.722756386764;55781.44218557762;8561.82876342482;8650.178233067849;9010.414323068979;9023.233025192932;9066.863997040182;40589;40682;41145.38281925714;41923.1615367697;42368.36447453229;49001;52398.21402679039;52797.7360113197;52899.73550132225;54140.45859541354;11296.152788540729;11606.88393116058;11697.883021169679;11706.74102668436;11737.765244694887;10886.836697449386;11086.944565277123;11939.940300298444;12298.754024919273;12595.93702031484;12232.571859985213;12495.625131246077;12520.311382873664;12531.310777907303;12605;11198.073449729092;11208.55165793359;11248.606298779503;11379.715507112389;11554.422278885853;12404;12484.250944943333;12567;12758.48966041385;12999.870001299865;10400.583976641152;10667.94666026696;10678.252522323362;10733.624323148651;10978.890211097787;10562.735931601772;10635.680929572125;10711.250212485364;10738.516766745672;10770.62302819429 10:45:55 INFO - PROCESS | 2549 | __end_tp_report 10:45:55 INFO - PROCESS | 2549 | __start_cc_report 10:45:55 INFO - PROCESS | 2549 | _x_x_mozilla_cycle_collect,813 10:45:55 INFO - PROCESS | 2549 | __end_cc_report 10:45:55 INFO - PROCESS | 2549 | __startTimestamp1463679955186__endTimestamp 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | ------- Summary: start ------- 10:45:55 INFO - PROCESS | 2549 | Number of tests: 6 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | [#0] dojo.html Cycles:165 Average:5511.88 Median:5723.77 stddev:603.28 (10.5%) stddev-sans-first:579.56 10:45:55 INFO - PROCESS | 2549 | Values: 3296.8 3349.6 3366.3 3373.7 3389.1 5514.8 5519.8 5522.2 5527.1 5528.8 5525.4 5540.9 5543.9 5545.0 5579.4 4908.6 5039.5 5119.3 5171.1 5190.5 5014.4 5089.9 5094.7 5097.8 5103.5 5009.9 5067.0 5142.4 5157.1 5163.8 5117.1 5119.2 5129.8 5131.5 5156.2 4960.5 5004.1 5032.0 5050.1 5086.5 5392.2 5392.4 5405.1 5441.2 5444.2 5924.5 5938.0 5943.5 5944.7 5949.0 5887.1 5962.6 5970.2 5982.2 6002.7 5540.5 5543.1 5554.0 5557.3 5566.1 5930.6 6081.8 6088.5 6099.8 6099.8 5783.6 5826.7 5829.3 5835.9 5853.4 5928.1 5945.8 5956.0 5956.7 5968.0 5705.4 5890.5 5900.0 5915.4 5919.2 5786.5 5874.9 5890.7 5891.0 5927.4 4500.4 4501.8 4505.8 4509.6 4529.2 3917.1 4015.4 4058.4 4081.9 4087.5 5605.9 5682.1 5707.6 5729.3 5744.2 5964.9 5965.2 5971.1 5972.0 5975.3 5600.0 5605.6 5635.4 5692.1 5713.8 5121.5 5124.5 5125.3 5126.9 5139.5 6109.4 6132.3 6136.5 6142.6 6143.6 5856.7 5892.9 5919.8 5981.2 5984.6 6109.1 6146.7 6148.0 6162.6 6166.3 5793.5 5802.7 5803.7 5804.4 5808.7 5702.1 5882.3 5903.9 5930.6 5934.5 5776.4 5815.4 5817.9 5822.6 5825.9 5723.8 5745.6 5780.5 5782.4 5785.8 5573.0 5663.5 5732.5 5757.9 5768.5 5762.5 5782.7 5785.5 5792.7 5809.9 5597.0 5681.1 5685.5 5687.4 5691.5 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | [#1] ext.html Cycles:180 Average:56539.37 Median:43451.59 stddev:103356.37 (237.9%) stddev-sans-first:103561.18 10:45:55 INFO - PROCESS | 2549 | Values: 668.4 689.9 690.6 725.5 744.8 33216.0 33748.7 33840.3 39080.0 40231.6 42181.2 42729.0 42788.1 42790.0 42855.6 8841.0 9018.0 9047.1 9047.2 9048.1 8736.3 8863.7 8905.7 8908.9 8914.7 9098.3 9177.2 9179.0 9180.1 9181.1 9058.7 9120.0 9121.6 9123.3 9125.9 8961.4 9075.2 9076.7 9084.9 9088.1 42937.1 43410.8 43458.1 43574.8 43733.6 3827.9 3890.1 3990.8 4361.8 4704.5 29873.0 29956.1 30219.7 31623.0 31684.8 4544.8 4639.3 4643.6 4650.7 4693.8 285305.0 289033.0 290453.0 290814.0 291201.0 62005.7 62807.4 63105.7 63166.4 63352.0 65707.0 66285.7 66446.3 66683.0 66691.7 19928.0 19959.8 19978.0 20165.6 20175.4 15431.0 15524.0 15550.6 15559.4 15561.2 19995.2 20730.2 20740.5 20865.2 20902.2 7472.6 7634.2 7681.7 7701.5 7742.1 1108.6 1123.8 1149.5 1160.3 1190.8 33879.7 34015.0 34133.0 34339.3 34640.3 1230.0 1256.4 1260.3 1298.8 1324.3 17730.6 17735.9 17822.5 17949.7 18068.3 508656.0 517471.0 517547.0 518129.0 518278.0 62846.4 64426.0 64441.0 64664.7 64699.0 1483.4 1487.9 1517.2 1572.6 1600.6 30391.8 31298.4 32495.7 33871.8 33908.7 49592.8 50072.5 50582.7 50685.7 50726.0 328435.0 330275.0 331866.0 331932.0 332270.0 27600.7 30624.0 49725.8 50236.5 50963.5 50303.0 50317.2 50386.7 50431.7 52022.7 41127.6 41509.6 43445.1 44245.3 44452.8 43173.4 43842.6 44327.3 44520.8 45499.8 47148.5 47169.8 47238.0 49095.5 49140.0 36316.0 37335.4 38195.6 38298.0 38684.4 29070.0 29205.2 29583.7 31169.0 31304.7 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | [#2] jquery.html Cycles:180 Average:30522.66 Median:23248.98 stddev:91834.02 (395.0%) stddev-sans-first:92063.81 10:45:55 INFO - PROCESS | 2549 | Values: 412.8 413.7 420.7 431.5 432.3 14352.4 18790.2 19327.0 19348.2 20403.3 16332.8 19073.1 19646.0 19918.7 20629.7 5711.3 5835.0 5862.6 5867.9 5886.6 5887.6 5985.4 5985.7 5993.0 5994.8 4300.2 4480.1 6094.8 6381.3 6389.9 6158.0 6313.7 6331.1 6364.4 6365.1 5691.4 5717.3 5728.4 5733.7 5734.9 22302.1 22685.9 22998.0 23500.0 23545.3 2561.1 2603.1 2606.6 2728.3 2732.6 14758.9 15230.9 15393.0 15500.1 15505.3 2040.6 2114.1 2116.7 2135.1 2150.1 54178.7 83258.2 83377.6 83416.6 83561.0 10731.4 11091.7 11330.5 11364.4 11380.9 15771.7 15858.6 15912.9 16009.9 16015.7 9142.8 9265.9 9271.3 9271.9 9385.5 9308.6 9430.2 9492.8 9509.9 9575.7 6254.9 6506.7 6891.3 7057.6 7159.3 1933.6 1987.0 1990.6 1997.6 2041.3 788.0 1144.8 1181.1 1189.4 1244.5 17845.6 19472.4 20295.1 20413.6 20500.0 1096.9 1097.8 1132.8 1197.9 1257.8 11625.7 11750.3 11834.4 11834.6 11855.8 541600.0 549042.0 569371.0 570773.0 576817.0 51273.7 77377.2 78588.0 82525.6 85084.1 1114.3 1131.2 1141.3 1143.4 1146.3 17503.0 17664.0 17964.5 18024.0 18317.5 36436.8 37250.0 37573.4 37813.0 37930.8 51080.7 51235.7 51300.2 51344.0 51373.7 7222.6 7974.2 8594.2 9414.7 9423.5 8922.6 11193.0 13464.2 13488.2 13838.6 11602.7 11917.8 12158.1 12215.8 12255.8 11648.5 11648.5 11891.0 11919.9 11983.2 12174.8 12274.6 12337.8 12641.9 13035.1 8562.3 8663.9 8684.1 8761.3 8826.8 10916.0 12875.9 12957.7 13055.8 13166.9 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | [#3] mootools.html Cycles:180 Average:5510.08 Median:4982.76 stddev:3046.54 (61.1%) stddev-sans-first:3039.75 10:45:55 INFO - PROCESS | 2549 | Values: 1443.0 1517.5 1523.6 1726.3 1853.2 7999.0 8190.1 8192.4 8192.7 8195.8 7776.8 7927.6 7928.8 7934.5 7941.3 2028.6 2069.2 2249.9 2283.7 2292.1 2346.2 2370.4 2372.0 2372.0 2373.5 2287.2 2330.7 2340.5 2342.6 2343.6 2019.1 2228.1 2291.0 2319.8 2325.4 2268.5 2305.0 2307.7 2308.3 2308.6 8174.2 8216.3 8231.7 8236.8 8251.4 4794.9 4799.7 4860.0 4893.1 4898.2 3150.8 3282.2 3322.5 3323.1 3341.9 1079.2 1082.3 1103.4 1110.3 1133.1 11947.2 11952.3 11956.5 11963.1 11992.3 4305.6 4400.1 4450.9 4458.3 4474.8 10111.3 10135.9 10140.0 10160.6 10170.1 5142.6 5151.5 5184.2 5185.7 5186.3 4260.7 4329.4 4504.5 4636.0 4767.0 3886.3 3970.5 4025.6 4073.5 4097.7 1194.9 1216.6 1216.9 1219.6 1223.3 942.4 1024.4 1025.2 1041.5 1044.0 5663.3 5745.3 5849.2 5875.8 6001.1 921.6 941.7 952.3 963.3 1032.6 3771.7 4008.8 4014.6 4040.6 4178.9 9857.4 10231.4 10231.5 10241.3 10261.9 9634.3 9821.5 9931.4 9950.8 10114.3 7629.6 7636.6 7664.6 7716.5 7716.7 5633.8 5699.5 5718.4 5786.9 5881.8 8968.4 9009.5 9271.5 9273.3 9280.6 8979.0 9022.2 9213.4 9371.3 9382.1 6793.8 7419.5 7570.0 7606.9 7729.3 8086.4 8132.1 8143.6 8160.3 8176.8 7095.9 7279.2 7301.6 7348.9 7428.4 6937.8 7032.1 7161.5 7278.0 7388.2 6484.5 6496.0 6552.4 6556.1 6562.7 4968.4 4997.1 5060.2 5190.1 5252.4 5069.6 5092.1 5139.7 5166.9 5181.8 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | [#4] prototype.html Cycles:180 Average:5356.02 Median:6149.59 stddev:1632.94 (26.6%) stddev-sans-first:1593.13 10:45:55 INFO - PROCESS | 2549 | Values: 317.4 318.4 322.4 323.5 334.1 6061.8 6104.5 6113.2 6120.0 6135.6 5778.9 5839.8 5981.5 5995.0 6027.3 4690.7 4708.7 4708.9 4725.8 4734.0 4697.9 4707.5 4714.2 4719.7 4725.1 4402.4 4522.0 4626.6 4655.8 4680.2 4624.0 4649.3 4653.1 4663.4 4669.0 4068.9 4074.4 4074.4 4082.6 4086.0 5871.5 5892.8 5894.1 5903.1 5904.5 5355.1 5360.4 5361.1 5363.1 5371.7 6204.7 6339.1 6369.3 6379.6 6381.8 4229.8 4256.6 4259.7 4260.1 4262.9 6590.6 6618.3 6650.9 6664.8 6675.7 4416.4 4422.7 4424.0 4427.6 4428.6 4471.2 4474.6 4479.2 4479.4 4487.8 5245.4 5246.2 5246.7 5250.8 5254.4 6288.7 6422.1 6450.8 6456.7 6463.3 1486.2 1562.8 1580.0 1584.3 1588.6 1016.7 1018.2 1020.3 1026.6 1030.6 6152.9 6234.5 6239.0 6241.7 6263.5 6595.9 6597.2 6610.7 6612.6 6613.0 6237.1 6248.1 6251.6 6253.6 6255.5 3537.4 3570.4 3571.1 3571.4 3574.0 6699.9 6791.7 6850.2 6853.5 6876.2 6689.1 6708.3 6711.2 6711.4 6714.4 6848.4 6859.2 6860.4 6863.8 6864.7 6608.6 6611.2 6611.5 6617.2 6625.8 6372.1 6510.1 6514.2 6520.9 6522.8 6854.9 6872.3 6873.6 6884.8 6904.9 4463.0 4467.0 4469.2 4469.9 4483.0 6570.4 6570.8 6572.2 6578.2 6578.6 6251.3 6397.2 6408.9 6506.1 6511.3 6405.4 6439.3 6467.7 6467.7 6474.4 6355.8 6358.2 6358.3 6371.6 6372.2 6496.2 6499.4 6503.8 6509.1 6510.2 6146.3 6329.1 6344.8 6353.2 6376.2 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - PROCESS | 2549 | [#5] yui.html Cycles:180 Average:15943.91 Median:26974.44 stddev:19359.28 (71.8%) stddev-sans-first:19380.29 10:45:55 INFO - PROCESS | 2549 | Values: 823.2 860.9 866.1 918.7 930.2 15388.2 15529.9 15684.5 15707.5 15714.3 14249.9 14285.5 14345.8 14357.9 14396.4 751.4 882.8 895.6 896.8 902.6 885.6 886.6 893.7 893.8 894.8 942.6 945.7 945.9 946.6 953.3 790.2 931.0 935.5 945.8 946.1 696.2 697.0 697.0 698.0 698.1 14785.2 14801.3 14831.9 14882.9 14896.6 14099.4 14913.0 14926.4 15004.4 15063.5 11994.1 12030.1 12112.7 12128.6 12354.8 3996.8 4013.6 4026.1 4081.7 4108.3 54778.5 54849.5 54914.0 54916.5 56278.0 10877.3 11113.7 11198.7 11280.2 11440.3 18669.3 18758.4 18817.2 18846.6 18878.2 8442.0 8492.8 8551.8 8565.8 8743.9 4947.9 5044.0 5098.2 5329.5 5358.6 3464.5 3505.6 3506.1 3510.1 3511.3 649.8 651.4 655.5 665.7 670.2 670.4 693.6 724.7 757.4 769.6 9055.2 9555.0 9678.2 9809.8 9821.0 744.2 780.0 785.5 802.0 819.4 4414.1 4419.6 4454.4 4503.5 4565.5 71338.0 72942.6 72964.0 73009.0 73756.0 60120.7 62321.7 63417.4 63710.7 64642.7 54639.7 54881.5 55285.0 55448.7 55781.4 8561.8 8650.2 9010.4 9023.2 9066.9 40589.0 40682.0 41145.4 41923.2 42368.4 49001.0 52398.2 52797.7 52899.7 54140.5 11296.2 11606.9 11697.9 11706.7 11737.8 10886.8 11086.9 11939.9 12298.8 12595.9 12232.6 12495.6 12520.3 12531.3 12605.0 11198.1 11208.6 11248.6 11379.7 11554.4 12404.0 12484.3 12567.0 12758.5 12999.9 10400.6 10667.9 10678.3 10733.6 10978.9 10562.7 10635.7 10711.3 10738.5 10770.6 10:45:55 INFO - PROCESS | 2549 | -------- Summary: end -------- 10:45:55 INFO - PROCESS | 2549 | 10:45:55 INFO - TEST-INFO | 2549: exit 0 10:45:55 INFO - TEST-OK | dromaeo_css | took 1111608ms 10:45:55 INFO - TEST-START | kraken 10:45:55 INFO - operating with platform_type : linux_ 10:45:55 INFO - Initialising browser for kraken test... 10:45:55 INFO - TEST-INFO | started process 2816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDU2iGL/profile http://localhost:33143/getInfo.html) 10:46:00 INFO - PROCESS | 2816 | __metrics Screen width/height:1600/1200 10:46:00 INFO - PROCESS | 2816 | colorDepth:24 10:46:00 INFO - PROCESS | 2816 | Browser inner width/height: 1024/697 10:46:00 INFO - PROCESS | 2816 | __metrics 10:46:01 ERROR - PROCESS | 2816 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:46:01 INFO - TEST-INFO | 2816: exit 0 10:46:01 INFO - Browser initialized. 10:46:01 INFO - Running cycle 1/1 for kraken test... 10:46:01 INFO - TEST-INFO | started process 2937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDU2iGL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:46:13 INFO - PROCESS | 2937 | RSS: Main: 141901824 10:46:13 INFO - PROCESS | 2937 | 10:46:16 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33143/tests/kraken/driver.html?testName=audio-beat-detection) 10:46:17 INFO - PROCESS | 2937 | RSS: Main: 197500928 10:46:17 INFO - PROCESS | 2937 | 10:46:19 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33143/tests/kraken/driver.html?testName=audio-dft) 10:46:20 INFO - PROCESS | 2937 | RSS: Main: 182501376 10:46:20 INFO - PROCESS | 2937 | 10:46:23 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33143/tests/kraken/driver.html?testName=audio-fft) 10:46:23 INFO - PROCESS | 2937 | RSS: Main: 273076224 10:46:23 INFO - PROCESS | 2937 | 10:46:25 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33143/tests/kraken/driver.html?testName=audio-oscillator) 10:46:26 INFO - PROCESS | 2937 | RSS: Main: 179408896 10:46:26 INFO - PROCESS | 2937 | 10:46:28 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:46:29 INFO - PROCESS | 2937 | RSS: Main: 177491968 10:46:29 INFO - PROCESS | 2937 | 10:46:32 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33143/tests/kraken/driver.html?testName=imaging-darkroom) 10:46:32 INFO - PROCESS | 2937 | RSS: Main: 212721664 10:46:32 INFO - PROCESS | 2937 | 10:46:36 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33143/tests/kraken/driver.html?testName=imaging-desaturate) 10:46:36 INFO - PROCESS | 2937 | RSS: Main: 213032960 10:46:36 INFO - PROCESS | 2937 | 10:46:39 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33143/tests/kraken/driver.html?testName=json-parse-financial) 10:46:40 INFO - PROCESS | 2937 | RSS: Main: 212901888 10:46:40 INFO - PROCESS | 2937 | 10:46:41 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:46:42 INFO - PROCESS | 2937 | RSS: Main: 191979520 10:46:42 INFO - PROCESS | 2937 | 10:46:43 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:46:44 INFO - PROCESS | 2937 | RSS: Main: 195104768 10:46:44 INFO - PROCESS | 2937 | 10:46:46 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:46:47 INFO - PROCESS | 2937 | RSS: Main: 211992576 10:46:47 INFO - PROCESS | 2937 | 10:46:49 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:46:50 INFO - PROCESS | 2937 | RSS: Main: 213241856 10:46:50 INFO - PROCESS | 2937 | 10:46:52 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:46:53 INFO - PROCESS | 2937 | RSS: Main: 210145280 10:46:53 INFO - PROCESS | 2937 | 10:46:54 INFO - PROCESS | 2937 | Cycle 1(1): loaded http://localhost:33143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33143/tests/kraken/driver.html?testName=ai-astar) 10:46:55 INFO - PROCESS | 2937 | RSS: Main: 273334272 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | __start_tp_report 10:46:55 INFO - PROCESS | 2937 | _x_x_mozilla_page_load 10:46:55 INFO - PROCESS | 2937 | _x_x_mozilla_page_load_details 10:46:55 INFO - PROCESS | 2937 | |i|pagename|runs| 10:46:55 INFO - PROCESS | 2937 | |0;ai-astar;111;111;110;112;109;111;105;109;110;108 10:46:55 INFO - PROCESS | 2937 | |1;audio-beat-detection;163;134;153;173;128;169;162;127;200;132 10:46:55 INFO - PROCESS | 2937 | |2;audio-dft;161;161;162;161;161;161;160;161;160;160 10:46:55 INFO - PROCESS | 2937 | |3;audio-fft;76;77;74;181;75;76;73;76;165;76 10:46:55 INFO - PROCESS | 2937 | |4;audio-oscillator;91;92;150;92;91;92;143;91;93;153 10:46:55 INFO - PROCESS | 2937 | |5;imaging-gaussian-blur;117;116;117;117;116;117;117;117;117;117 10:46:55 INFO - PROCESS | 2937 | |6;imaging-darkroom;145;146;149;146;145;145;147;145;146;145 10:46:55 INFO - PROCESS | 2937 | |7;imaging-desaturate;94;95;94;94;94;95;94;95;94;95 10:46:55 INFO - PROCESS | 2937 | |8;json-parse-financial;58;53;54;53;54;53;56;79;52;50 10:46:55 INFO - PROCESS | 2937 | |9;json-stringify-tinderbox;59;59;59;60;60;59;64;60;59;62 10:46:55 INFO - PROCESS | 2937 | |10;stanford-crypto-aes;72;71;71;71;73;73;73;73;73;72 10:46:55 INFO - PROCESS | 2937 | |11;stanford-crypto-ccm;114;113;118;111;110;107;113;111;125;129 10:46:55 INFO - PROCESS | 2937 | |12;stanford-crypto-pbkdf2;158;154;156;155;153;155;158;156;156;161 10:46:55 INFO - PROCESS | 2937 | |13;stanford-crypto-sha256-iterative;64;67;66;69;64;65;65;64;63;63 10:46:55 INFO - PROCESS | 2937 | __end_tp_report 10:46:55 INFO - PROCESS | 2937 | __start_cc_report 10:46:55 INFO - PROCESS | 2937 | _x_x_mozilla_cycle_collect,1600 10:46:55 INFO - PROCESS | 2937 | __end_cc_report 10:46:55 INFO - PROCESS | 2937 | __startTimestamp1463680015227__endTimestamp 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | ------- Summary: start ------- 10:46:55 INFO - PROCESS | 2937 | Number of tests: 14 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.01 (1.8%) stddev-sans-first:2.07 10:46:55 INFO - PROCESS | 2937 | Values: 111.0 111.0 110.0 112.0 109.0 111.0 105.0 109.0 110.0 108.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#1] audio-beat-detection Cycles:10 Average:154.10 Median:162.50 stddev:23.89 (14.7%) stddev-sans-first:25.12 10:46:55 INFO - PROCESS | 2937 | Values: 163.0 134.0 153.0 173.0 128.0 169.0 162.0 127.0 200.0 132.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:46:55 INFO - PROCESS | 2937 | Values: 161.0 161.0 162.0 161.0 161.0 161.0 160.0 161.0 160.0 160.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:41.35 (54.4%) stddev-sans-first:43.29 10:46:55 INFO - PROCESS | 2937 | Values: 76.0 77.0 74.0 181.0 75.0 76.0 73.0 76.0 165.0 76.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:91.50 stddev:27.62 (30.2%) stddev-sans-first:28.54 10:46:55 INFO - PROCESS | 2937 | Values: 91.0 92.0 150.0 92.0 91.0 92.0 143.0 91.0 93.0 153.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:46:55 INFO - PROCESS | 2937 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:1.29 (0.9%) stddev-sans-first:1.32 10:46:55 INFO - PROCESS | 2937 | Values: 145.0 146.0 149.0 146.0 145.0 145.0 147.0 145.0 146.0 145.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:46:55 INFO - PROCESS | 2937 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 95.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:54.00 stddev:8.30 (15.4%) stddev-sans-first:8.77 10:46:55 INFO - PROCESS | 2937 | Values: 58.0 53.0 54.0 53.0 54.0 53.0 56.0 79.0 52.0 50.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.66 (2.8%) stddev-sans-first:1.72 10:46:55 INFO - PROCESS | 2937 | Values: 59.0 59.0 59.0 60.0 60.0 59.0 64.0 60.0 59.0 62.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#10] stanford-crypto-aes Cycles:10 Average:72.20 Median:73.00 stddev:0.92 (1.3%) stddev-sans-first:0.97 10:46:55 INFO - PROCESS | 2937 | Values: 72.0 71.0 71.0 71.0 73.0 73.0 73.0 73.0 73.0 72.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#11] stanford-crypto-ccm Cycles:10 Average:115.10 Median:113.50 stddev:6.95 (6.1%) stddev-sans-first:7.36 10:46:55 INFO - PROCESS | 2937 | Values: 114.0 113.0 118.0 111.0 110.0 107.0 113.0 111.0 125.0 129.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:156.00 stddev:2.30 (1.5%) stddev-sans-first:2.35 10:46:55 INFO - PROCESS | 2937 | Values: 158.0 154.0 156.0 155.0 153.0 155.0 158.0 156.0 156.0 161.0 10:46:55 INFO - PROCESS | 2937 | 10:46:55 INFO - PROCESS | 2937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.89 (2.9%) stddev-sans-first:1.96 10:46:55 INFO - PROCESS | 2937 | Values: 64.0 67.0 66.0 69.0 64.0 65.0 65.0 64.0 63.0 63.0 10:46:55 INFO - PROCESS | 2937 | -------- Summary: end -------- 10:46:55 INFO - PROCESS | 2937 | 10:46:56 INFO - TEST-INFO | 2937: exit 0 10:46:56 INFO - TEST-OK | kraken | took 60227ms 10:46:56 INFO - SUITE-END | took 1171s 10:46:56 INFO - Completed test suite (00:19:32) 10:46:56 INFO - javascript benchmark 10:46:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.835158242088, 3349.6315405305413, 3366.27625060612, 3373.6795004474598, 3389.068006298268, 5514.751836167372, 5519.751611177497, 5522.171674248864, 5527.060399732045, 5528.75120619572, 5525.364583072947, 5540.9168862466995, 5543.861403464915, 5545.00189965806, 5579.414161513044, 4908.607311415096, 5039.496050394959, 5119.334486516747, 5171.120909445384, 5190.455002224769, 5014.373203349582, 5089.949100508985, 5094.7197904115255, 5097.770600322994, 5103.464136265694, 5009.949900500985, 5067.0, 5142.382914050319, 5157.071727089123, 5163.767630456619, 5117.078925793356, 5119.206522988924, 5129.846104616849, 5131.461196574381, 5156.20078887773, 4960.528749768766, 5004.099262132815, 5032.0, 5050.116229659831, 5086.46592107827, 5392.2181283714035, 5392.379876314235, 5405.054115529767, 5441.211024401479, 5444.156155795818, 5924.526037916957, 5938.020226662596, 5943.52451803859, 5944.702764861783, 5949.0, 5887.087501437241, 5962.582619216657, 5970.194023806774, 5982.162497250389, 6002.669853158074, 5540.501354878081, 5543.113101903717, 5554.028045092093, 5557.277553917965, 5566.081596536607, 5930.55520835939, 6081.75672973085, 6088.543359248074, 6099.817005489843, 6099.817005489843, 5783.566232532577, 5826.6795326256615, 5829.271341082364, 5835.941640583625, 5853.414658534112, 5928.051511758098, 5945.7621695132575, 5955.957707401188, 5956.731947062306, 5967.9701601491715, 5705.372409035086, 5890.528757699374, 5900.0, 5915.37888521699, 5919.200907877467, 5786.450287222707, 5874.882502350015, 5890.734916928748, 5891.027980383275, 5927.436893495111, 4500.437445319335, 4501.842435514741, 4505.797239124247, 4509.594136527729, 4529.162105010583, 3917.138229589486, 4015.377616469452, 4058.350663893763, 4081.8571350003203, 4087.4890638670167, 5605.943940560624, 5682.090865461506, 5707.600467967285, 5729.25519682447, 5744.195812586241, 5964.940350596526, 5965.164876917235, 5971.0744834550715, 5972.0, 5975.25309336333, 5599.972000139973, 5605.607607467519, 5635.380108188096, 5692.117721753135, 5713.771449142071, 5121.4878512149235, 5124.461931497139, 5125.256837758504, 5126.871828204325, 5139.486051394831, 6109.358517355702, 6132.325444201134, 6136.509079273647, 6142.6314421134875, 6143.56995010354, 5856.707164641836, 5892.94107058924, 5919.763209471659, 5981.192539007352, 5984.551158663031, 6109.053096770008, 6146.692665366624, 6147.969260153671, 6162.599431036968, 6166.290876549075, 5793.507551857971, 5802.738876750641, 5803.709814509342, 5804.390538993345, 5808.73860676279, 5702.144678298288, 5882.294124705063, 5903.852403689943, 5930.644161350333, 5934.465898069195, 5776.42235776419, 5815.3893841147765, 5817.883642327214, 5822.592418530662, 5825.912611310749, 5723.771049158154, 5745.569082318759, 5780.450857168562, 5782.3639399666845, 5785.82642520725, 5572.972135139298, 5663.518600918968, 5732.455416735404, 5757.942420575908, 5768.480836724715, 5762.538996880324, 5782.710864456844, 5785.508231800344, 5792.739326730223, 5809.854753631024, 5597.04850175463, 5681.0626246668835, 5685.545156387562, 5687.43125687428, 5691.4877661010705], "value": 5473.123986758232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.431832941999, 689.8861687821509, 690.6443181761391, 725.5066554742773, 744.7616762635955, 33216.0, 33748.66251337486, 33840.32319353611, 39080.0, 40231.59768402315, 42181.156376872445, 42729.0, 42788.14423711524, 42790.0, 42855.571444285546, 8840.955795221014, 9018.0, 9047.140521650434, 9047.23098536622, 9048.095190480932, 8736.301095912311, 8863.734087977338, 8905.73282801517, 8908.866367004468, 8914.73255802327, 9098.317626178063, 9177.174054335108, 9178.954105229464, 9180.127887850644, 9181.127792859668, 9058.728238152833, 9120.042395548504, 9121.589528471235, 9123.315751318678, 9125.863112053325, 8961.417507862034, 9075.183233509017, 9076.68231611897, 9084.8637270441, 9088.136627020422, 42937.141257175, 43410.78294608538, 43458.130837383076, 43574.782126089485, 43733.56266437327, 3827.885163445101, 3890.1247219375696, 3990.840366385341, 4361.80371883266, 4704.506026867164, 29873.0, 29956.101316960525, 30219.697803021907, 31623.0, 31684.841575792205, 4544.750038747868, 4639.257718764981, 4643.628509719214, 4650.698104253585, 4693.7653117344, 285305.0, 289033.0, 290453.0, 290814.0, 291201.0, 62005.68997154985, 62807.37192628106, 63105.68447157735, 63166.36833631697, 63352.0, 65707.0, 66285.66857165683, 66446.33553664498, 66682.99975500371, 66691.66654166795, 19928.0, 19959.800401996086, 19978.0, 20165.596688066158, 20175.39473815788, 15431.0, 15524.0, 15550.611234719223, 15559.377624895104, 15561.221938903009, 19995.200191992157, 20730.170793168105, 20740.481487962923, 20865.165393384093, 20902.163913443597, 7472.571414290377, 7634.236576342432, 7681.731139410093, 7701.499402538929, 7742.070951485745, 1108.6286094158386, 1123.7808627317759, 1149.4597539156582, 1160.2516376936828, 1190.7797057544383, 33879.66120338765, 34015.0, 34133.0, 34339.31321373609, 34640.30719385598, 1229.9508019679113, 1256.39065053449, 1260.2816394655142, 1298.79868620364, 1324.3113580937859, 17730.556736081442, 17735.911320443316, 17822.46532603998, 17949.7307540387, 18068.277268909358, 508656.0, 517471.0, 517547.0, 518129.0, 518278.0, 62846.37153628497, 64426.0, 64440.99999999906, 64664.67667661631, 64699.0, 1483.3695679336238, 1487.8512148785035, 1517.1958861803262, 1572.5754046407405, 1600.5598460423478, 30391.84804076054, 31298.37403251877, 32495.675043249266, 33871.83064084664, 33908.66091339055, 49592.75203623959, 50072.49927500678, 50582.74708626433, 50685.74657126691, 50726.0, 328435.0, 330275.0, 331866.0, 331932.0, 332270.0, 27600.723992759817, 30624.0, 49725.75137124291, 50236.49763502464, 50963.49036509587, 50303.0, 50317.24524132214, 50386.74806625943, 50431.747841260556, 52022.73988630184, 41127.58872411238, 41509.58490415057, 43445.05221282944, 44245.33631995587, 44452.777736111115, 43173.3523997134, 43842.56157438385, 44327.33508997303, 44520.77739611411, 45499.77250113728, 47148.52851471442, 47169.76415117903, 47238.0, 49095.50904491052, 49140.0, 36316.0, 37335.43996839995, 38195.61804381921, 38298.0, 38684.41973370458, 29069.965102442628, 29205.182922300424, 29583.704162958096, 31169.0, 31304.686953130178], "value": 21173.382787606035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.82661282261455, 413.7000674510978, 420.70340410010925, 431.5404094639209, 432.312622929542, 14352.425902963869, 18790.15444305006, 19327.0, 19348.226070957164, 20403.285884994028, 16332.75500867488, 19073.141708623112, 19646.0, 19918.701219481718, 20629.690554641656, 5711.2575365202565, 5834.970825145869, 5862.560307976897, 5867.941320586803, 5886.617369870966, 5887.558433117512, 5985.401459854002, 5985.670788106652, 5993.041113421853, 5994.760209591633, 4300.247456695081, 4480.081583275421, 6094.847628809271, 6381.329960354165, 6389.904151437732, 6158.0, 6313.747450101991, 6331.113644089831, 6364.363563643645, 6365.077063825743, 5691.373948865621, 5717.285339332583, 5728.369879313273, 5733.684647344395, 5734.856628584277, 22302.107915683355, 22685.886570567207, 22997.967074580385, 23500.0, 23545.29364119079, 2561.065211197918, 2603.06289735695, 2606.648102506156, 2728.290644432442, 2732.6447561816835, 14758.852411475855, 15230.923845380814, 15393.0, 15500.147491888054, 15505.302261398265, 2040.5714799892041, 2114.1437717724193, 2116.703661487393, 2135.1459416233474, 2150.0754675489534, 54178.72910635461, 83258.16741832625, 83377.58311208466, 83416.58291708563, 83561.0, 10731.40977246259, 11091.667249982513, 11330.546778128948, 11364.374959377148, 11380.886191137983, 15771.68456630861, 15858.60353491172, 15912.92043539775, 16009.919950400406, 16015.679686406207, 9142.771430714285, 9265.907340926504, 9271.304652151115, 9271.90728092724, 9385.530723463937, 9308.627654893864, 9430.245580353692, 9492.762680933032, 9509.857352139723, 9575.712728618153, 6254.937450625526, 6506.674666266667, 6891.310868913069, 7057.6118313492225, 7159.319864612853, 1933.5552822850823, 1986.960260794776, 1990.5819777846814, 1997.610465959124, 2041.3263623004373, 787.9724209652635, 1144.8397224388593, 1181.0846593889632, 1189.3815216087587, 1244.4773195258012, 17845.643087138185, 19472.415827525198, 20295.086721097585, 20413.591728165353, 20500.0, 1096.9122470202365, 1097.8408130821147, 1132.8017596920506, 1197.874223206568, 1257.836481257449, 11625.709357265967, 11750.29498230109, 11834.408279585987, 11834.644960651194, 11855.762884742257, 541600.0, 549042.0, 569371.0, 570773.0, 576817.0, 51273.743631281606, 77377.226227737, 78588.0, 82525.58737206276, 85084.14915850763, 1114.2590177532013, 1131.2420678145663, 1141.2866958151155, 1143.3654321851286, 1146.2863019785307, 17503.0, 17664.0, 17964.461066168034, 18024.0, 18317.450476485727, 36436.81781591181, 37250.0, 37573.43639845459, 37813.0, 37930.81034594809, 51080.74459627678, 51235.74382128065, 51300.23049654184, 51344.0, 51373.74313128411, 7222.638868056471, 7974.202579741979, 8594.226519613265, 9414.67048653294, 9423.528823558658, 8922.598483068406, 11193.0, 13464.192148471124, 13488.190708557519, 13838.58484245434, 11602.6519204424, 11917.76164476723, 12158.148929574845, 12215.816762748744, 12255.75488490243, 11648.475818588015, 11648.475818588015, 11891.0, 11919.940400297943, 11983.161178717406, 12174.75650487003, 12274.570390036306, 12337.753244935231, 12641.87358126407, 13035.087543872218, 8562.315014798925, 8663.870041949249, 8684.131586841266, 8761.255293299886, 8826.779330516789, 10916.0, 12875.871241287467, 12957.740845182854, 13055.804162937373, 13166.934165329112], "value": 9695.772182951692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.9927850360746, 1517.4916403004993, 1523.5733994481543, 1726.309476209516, 1853.1660752661305, 7999.0, 8190.140035296297, 8192.426530142893, 8192.713255036075, 8195.754127376189, 7776.805579860506, 7927.643256053477, 7928.841423171533, 7934.484258523192, 7941.32498737608, 2028.6247044296779, 2069.1516478243925, 2249.853759505631, 2283.703118594589, 2292.1175347491253, 2346.249200255919, 2370.3718514593647, 2371.95256094878, 2372.0, 2373.5490256851144, 2287.2223444029028, 2330.731965823935, 2340.520193360357, 2342.601757701186, 2343.6484527320954, 2019.1317733374642, 2228.053077442081, 2291.026313816621, 2319.7796209360085, 2325.3953971967326, 2268.4895898422888, 2305.0, 2307.676925230469, 2308.307507747669, 2308.5844547981355, 8174.182581741838, 8216.342692584638, 8231.670733170666, 8236.794080147984, 8251.381146414044, 4794.928076078827, 4799.664023518355, 4859.975700121512, 4893.119238537062, 4898.167311557044, 3150.7951983121025, 3282.195862013822, 3322.4684050551796, 3323.135984643986, 3341.9498707519406, 1079.2175672637354, 1082.3181395720646, 1103.3876198709713, 1110.294962698684, 1133.0595605647293, 11947.163698541106, 11952.342621155833, 11956.521739130425, 11963.102767292488, 11992.340421276826, 4305.590968857953, 4400.119976004812, 4450.910981780346, 4458.286674132188, 4474.843380481668, 10111.292209545261, 10135.9493202535, 10140.0, 10160.593576257015, 10170.084692377573, 5142.61430392722, 5151.484851514819, 5184.248283998874, 5185.662931909414, 5186.273921650972, 4260.659147268211, 4329.350597410351, 4504.48198457175, 4635.953640463552, 4766.976165119152, 3886.300465916162, 3970.4838371011583, 4025.6376926076796, 4073.5315438724333, 4097.733647312915, 1194.858909741195, 1216.580279803484, 1216.920900141488, 1219.597532814187, 1223.3149436315691, 942.359195746885, 1024.4467987286782, 1025.2464438637596, 1041.4740556019312, 1043.9769026354215, 5663.348714897757, 5745.339285982082, 5849.2103566018895, 5875.823725288248, 6001.099835024781, 921.5576523268735, 941.7363138321281, 952.2857856607544, 963.3064193780467, 1032.6385764982197, 3771.6794072504144, 4008.779517126586, 4014.6186112319283, 4040.595940405936, 4178.937315940202, 9857.359271647463, 10231.43727095002, 10231.48842557884, 10241.334313269614, 10261.871194168636, 9634.325597208128, 9821.459819709984, 9931.404115753077, 9950.805903291506, 10114.29199955996, 7629.580373079534, 7636.618169091523, 7664.616769161631, 7716.5370077795515, 7716.6527506262355, 5633.774649013993, 5699.544036476989, 5718.428157184248, 5786.884262314814, 5881.823545293648, 8968.417052891542, 9009.504477253813, 9271.490068046322, 9273.258139348702, 9280.62877484893, 8979.0, 9022.233110185445, 9213.401128926598, 9371.250299976122, 9382.10869967352, 6793.796186114425, 7419.517731347445, 7570.0, 7606.885896711665, 7729.3430058445665, 8086.393520485869, 8132.105468398353, 8143.5928203590765, 8160.30637395828, 8176.83646327082, 7095.893561596684, 7279.235680253497, 7301.598412087386, 7348.889766653611, 7428.442866785121, 6937.826554336182, 7032.12098487689, 7161.4986950912935, 7277.963610181915, 7388.187299396955, 6484.546081774419, 6496.025596160424, 6552.3775241352, 6556.114924485133, 6562.704678289584, 4968.403791545038, 4997.125503037027, 5060.1903695408555, 5190.143626301769, 5252.395974462986, 5069.5944324454695, 5092.083424983391, 5139.665921715226, 5166.922496162636, 5181.81863634771], "value": 4470.560109942189, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.3779392390915, 318.4220639539236, 322.4421750371857, 323.54057238721015, 334.12292731579606, 6061.787837425691, 6104.473881529618, 6113.174721412608, 6119.969400152999, 6135.631862088272, 5778.942210577893, 5839.79560715375, 5981.46166844985, 5994.970025149868, 6027.27672679278, 4690.742009189493, 4708.670393072486, 4708.905821883569, 4725.787339569728, 4733.952660473386, 4697.859064228079, 4707.482176960549, 4714.222153344694, 4719.740414277213, 4725.125851717443, 4402.40567523385, 4521.954780452186, 4626.6298696104395, 4655.790489427984, 4680.204365257898, 4623.976880115578, 4649.325847752091, 4653.069386122772, 4663.417072865892, 4668.953310466886, 4068.9186216275803, 4074.368472886678, 4074.4295798588223, 4082.5713300103657, 4085.9591404085877, 5871.4715675589405, 5892.823215303548, 5894.08641660539, 5903.144044113623, 5904.498117660004, 5355.0896347621, 5360.410354860962, 5361.08861493547, 5363.061464243741, 5371.677699338053, 6204.689765511752, 6339.0808332791485, 6369.299377068519, 6379.553431259814, 6381.8085457436355, 4229.809658565372, 4256.638185754215, 4259.680523960685, 4260.10537787062, 4262.893427664302, 6590.571612845198, 6618.305077966792, 6650.93349066508, 6664.83337916556, 6675.699593518255, 4416.359627854007, 4422.668299877522, 4424.0, 4427.645788336926, 4428.557144285545, 4471.150481408522, 4474.6420286377015, 4479.17135329965, 4479.395281637003, 4487.820487180476, 5245.423003469616, 5246.213068039825, 5246.711430871339, 5250.763715632729, 5254.4220135785035, 6288.748450062038, 6422.068800024063, 6450.77422290227, 6456.677166141674, 6463.289038205794, 1486.2345891865698, 1562.8202756683127, 1579.968400631981, 1584.3108247912196, 1588.602849287678, 1016.6645007147623, 1018.1803648063232, 1020.3316827477865, 1026.6047571684956, 1030.567161792049, 6152.907706384318, 6234.470070044097, 6239.0, 6241.687915604201, 6263.530235232376, 6595.901061484082, 6597.241317248482, 6610.7025183866845, 6612.570182938093, 6612.9749888766355, 6237.126802247689, 6248.062790581449, 6251.59364641306, 6253.593516421418, 6255.530835187288, 3537.4163263061823, 3570.3573356795505, 3571.1250743567994, 3571.3750093733493, 3574.0, 6699.899501507482, 6791.694373753193, 6850.212225594021, 6853.451723862079, 6876.243613202544, 6689.096971908827, 6708.2956289589865, 6711.194656641234, 6711.429528490035, 6714.429273511709, 6848.383645471832, 6859.2454829968665, 6860.382565569123, 6863.759768408082, 6864.656767161622, 6608.570442921195, 6611.206655201407, 6611.504137189634, 6617.205935287796, 6625.768098116736, 6372.139761132374, 6510.0885875976455, 6514.1531600891585, 6520.9347906520325, 6522.804315870531, 6854.931450685429, 6872.312768723088, 6873.553219040747, 6884.759033433806, 6904.93095069063, 4462.955370446384, 4466.977665111654, 4469.21788686985, 4469.927217467849, 4483.036147228361, 6570.408663220333, 6570.8357291068105, 6572.211334639874, 6578.177727784027, 6578.605283682994, 6251.34360892118, 6397.168368112116, 6408.871822563616, 6506.121673574196, 6511.34886511345, 6405.423511883952, 6439.323870993666, 6467.676616169078, 6467.676616169267, 6474.352564743488, 6355.841103972438, 6358.1734374531015, 6358.300586935341, 6371.617702937839, 6372.203474565679, 6496.220453545605, 6499.38255865692, 6503.837404064936, 6509.088727578238, 6510.18622672166, 6146.262448506208, 6329.050642403677, 6344.811040191126, 6353.174087368612, 6376.171097757448], "value": 4812.173414822854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.2426167925508, 860.8536548786706, 866.1381924984645, 918.7014220378379, 930.2325581395351, 15388.15365154916, 15529.922350388233, 15684.451044213454, 15707.528774136767, 15714.292856821441, 14249.92875035626, 14285.500007499739, 14345.78481322781, 14357.856421435808, 14396.424143034292, 751.4289140253405, 882.814608932125, 895.6059333893066, 896.8430524658191, 902.6028547439106, 885.5704983083232, 886.6143227695941, 893.7274131389923, 893.8480458322068, 894.8478758611019, 942.6182396129544, 945.6642891773424, 945.9243260539175, 946.6166202687922, 953.3136141977765, 790.1940021178394, 931.0, 935.4667839331584, 945.8439357506038, 946.1059298962483, 696.2202333386639, 697.0206859362604, 697.0276464332279, 698.0157977252101, 698.0576222100124, 14785.186814725186, 14801.259937003215, 14831.851681483264, 14882.851171488255, 14896.553103406915, 14099.36552855124, 14913.030653007629, 14926.40294388223, 15004.399824007027, 15063.472778452702, 11994.100442466763, 12030.097742669335, 12112.697182570419, 12128.57549985755, 12354.814677779841, 3996.820143093568, 4013.6387725104587, 4026.094128821021, 4081.69387295954, 4108.301588729893, 54778.45221547774, 54849.45150548523, 54914.0, 54916.45083549193, 56278.0, 10877.347359158475, 11113.722156946142, 11198.720031999103, 11280.153988450898, 11440.256383335223, 18669.346572869883, 18758.437246882615, 18817.247310107443, 18846.623067538847, 18878.24487020504, 8442.0, 8492.751901140698, 8551.786205344915, 8565.828683426296, 8743.868841967376, 4947.876303092379, 5044.0, 5098.1842905135, 5329.493698098674, 5358.5981051421295, 3464.549608550872, 3505.5793304803587, 3506.1409954560786, 3510.069831494656, 3511.3328467591077, 649.8277956341574, 651.3974573519475, 655.4788942790493, 665.737033871618, 670.1991120610824, 670.3698523388, 693.5942473652868, 724.7427163356932, 757.4394947738633, 769.5690413368532, 9055.23030542398, 9555.0, 9678.17735492477, 9809.803803923882, 9821.017898210122, 744.1925510820712, 779.9571023593643, 785.4776573578621, 802.0, 819.3649921311031, 4414.095110502403, 4419.64642828573, 4454.37638730578, 4503.527129651405, 4565.543445655474, 71338.0, 72942.63528682428, 72964.0, 73009.0, 73756.0, 60120.699396502736, 62321.68839155775, 63417.365826342066, 63710.68144659247, 64642.67678661671, 54639.72680136574, 54881.45118548843, 55284.99999999919, 55448.722756386764, 55781.44218557762, 8561.82876342482, 8650.178233067849, 9010.414323068979, 9023.233025192932, 9066.863997040182, 40589.0, 40682.0, 41145.38281925714, 41923.1615367697, 42368.36447453229, 49001.0, 52398.21402679039, 52797.7360113197, 52899.73550132225, 54140.45859541354, 11296.152788540729, 11606.88393116058, 11697.883021169679, 11706.74102668436, 11737.765244694887, 10886.836697449386, 11086.944565277123, 11939.940300298444, 12298.754024919273, 12595.93702031484, 12232.571859985213, 12495.625131246077, 12520.311382873664, 12531.310777907303, 12605.0, 11198.073449729092, 11208.55165793359, 11248.606298779503, 11379.715507112389, 11554.422278885853, 12404.0, 12484.250944943333, 12567.0, 12758.48966041385, 12999.870001299865, 10400.583976641152, 10667.94666026696, 10678.252522323362, 10733.624323148651, 10978.890211097787, 10562.735931601772, 10635.680929572125, 10711.250212485364, 10738.516766745672, 10770.62302819429], "value": 7071.764212219987, "unit": "score"}], "name": "dromaeo_css", "value": 7449.842630906373, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 112.0, 109.0, 111.0, 105.0, 109.0, 110.0, 108.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 153.0, 173.0, 128.0, 169.0, 162.0, 127.0, 200.0, 132.0], "value": 154.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 181.0, 75.0, 76.0, 73.0, 76.0, 165.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 150.0, 92.0, 91.0, 92.0, 143.0, 91.0, 93.0, 153.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 149.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 53.0, 54.0, 53.0, 56.0, 79.0, 52.0, 50.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 64.0, 60.0, 59.0, 62.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 71.0, 73.0, 73.0, 73.0, 73.0, 73.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 118.0, 111.0, 110.0, 107.0, 113.0, 111.0, 125.0, 129.0], "value": 115.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 156.0, 155.0, 153.0, 155.0, 158.0, 156.0, 156.0, 161.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 69.0, 64.0, 65.0, 65.0, 64.0, 63.0, 63.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1510.0999999999997, "alertThreshold": 2.0}]} 10:46:56 INFO - Return code: 0 10:46:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:46:56 ERROR - # TBPL SUCCESS # 10:46:56 INFO - Running post-action listener: _resource_record_post_action 10:46:56 INFO - Running post-run listener: _resource_record_post_run 10:46:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 366841856; Read time: 0; Write time: 256036 10:46:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118255616; Read time: 0; Write time: 105992 10:46:57 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 248586240; Read time: 0; Write time: 150044 10:46:57 INFO - Running post-run listener: _upload_blobber_files 10:46:57 INFO - Blob upload gear active. 10:46:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:46:57 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 10:46:57 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'] 10:46:57 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 10:46:58 INFO - (blobuploader) - INFO - Open directory for files ... 10:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:46:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:58 INFO - (blobuploader) - INFO - Done attempting. 10:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:46:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:59 INFO - (blobuploader) - INFO - Done attempting. 10:46:59 INFO - (blobuploader) - INFO - Iteration through files over. 10:46:59 INFO - Return code: 0 10:46:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:46:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:46:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73bbea89eda7ef5c68bdf71049cbf12019485e5ccccc400ee0e8f9363dbf6b9ae0dbffb495c1f45a63b9a9c1bbb45eeb5cd0bca7eab3e9fd9a3837aba9288133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7518e1c2bb1a51a28876e26137b62ad3a3c885eca762a76489b2a703878e858381615791178510c2ca0d79330b0cfc67a088aaf64144a5f20ba7724f74d8bfe"} 10:46:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:46:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:46:59 INFO - Contents: 10:46:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73bbea89eda7ef5c68bdf71049cbf12019485e5ccccc400ee0e8f9363dbf6b9ae0dbffb495c1f45a63b9a9c1bbb45eeb5cd0bca7eab3e9fd9a3837aba9288133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7518e1c2bb1a51a28876e26137b62ad3a3c885eca762a76489b2a703878e858381615791178510c2ca0d79330b0cfc67a088aaf64144a5f20ba7724f74d8bfe"} 10:46:59 INFO - Running post-run listener: copy_logs_to_upload_dir 10:46:59 INFO - Copying logs to upload dir... 10:46:59 INFO - mkdir: /builds/slave/test/build/upload/logs 10:46:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.237987 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-19 10:46:58.989050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 10:46:58.993254) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303 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/73bbea89eda7ef5c68bdf71049cbf12019485e5ccccc400ee0e8f9363dbf6b9ae0dbffb495c1f45a63b9a9c1bbb45eeb5cd0bca7eab3e9fd9a3837aba9288133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7518e1c2bb1a51a28876e26137b62ad3a3c885eca762a76489b2a703878e858381615791178510c2ca0d79330b0cfc67a088aaf64144a5f20ba7724f74d8bfe"} build_url:https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/d5uTXz16QCivdKgpOLX-zw/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/73bbea89eda7ef5c68bdf71049cbf12019485e5ccccc400ee0e8f9363dbf6b9ae0dbffb495c1f45a63b9a9c1bbb45eeb5cd0bca7eab3e9fd9a3837aba9288133", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7518e1c2bb1a51a28876e26137b62ad3a3c885eca762a76489b2a703878e858381615791178510c2ca0d79330b0cfc67a088aaf64144a5f20ba7724f74d8bfe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 10:46:59.018194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:46:59.018558) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1463678647.240119-653515303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 10:46:59.107705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 10:46:59.108256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 10:46:59.108865) ========= ========= Total master_lag: 0.17 =========