builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1464091188.97 results: success (0) buildid: 20160524022209 builduid: b27ddde44f0140008b8f0df56a6bab0c revision: a6138313bed92c7755f7f6ec38e9033a7abd88b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:48.966575) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:48.966981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:48.967258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:48.981452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:48.981731) ========= 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=fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 04:59:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.9M=0s 2016-05-24 04:59:49 (23.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101399 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.094163) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.094481) ========= 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=fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017412 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.143186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.143502) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6138313bed92c7755f7f6ec38e9033a7abd88b2 --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 a6138313bed92c7755f7f6ec38e9033a7abd88b2 --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=fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 04:59:49,760 truncating revision to first 12 chars 2016-05-24 04:59:49,760 Setting DEBUG logging. 2016-05-24 04:59:49,760 attempt 1/10 2016-05-24 04:59:49,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6138313bed9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 04:59:50,024 unpacking tar archive at: mozilla-aurora-a6138313bed9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537834 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.694436) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.694772) ========= script_repo_revision: a6138313bed92c7755f7f6ec38e9033a7abd88b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.695212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.695493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 04:59:49.705914) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-24 04:59:49.706189) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:59:50 INFO - MultiFileLogger online at 20160524 04:59:50 in /builds/slave/test 04:59:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:59:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:59:50 INFO - {'append_to_log': False, 04:59:50 INFO - 'base_work_dir': '/builds/slave/test', 04:59:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:59:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:59:50 INFO - 'branch': 'Mozilla-Aurora', 04:59:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:50 INFO - 'config_files': ('talos/linux_config.py',), 04:59:50 INFO - 'default_actions': ('clobber', 04:59:50 INFO - 'read-buildbot-config', 04:59:50 INFO - 'download-and-extract', 04:59:50 INFO - 'populate-webroot', 04:59:50 INFO - 'create-virtualenv', 04:59:50 INFO - 'install', 04:59:50 INFO - 'run-tests'), 04:59:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:50 INFO - 'download_minidump_stackwalk': True, 04:59:50 INFO - 'download_symbols': 'ondemand', 04:59:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:50 INFO - 'installer_path': 'installer.exe', 04:59:50 INFO - 'log_level': 'info', 04:59:50 INFO - 'log_name': 'talos', 04:59:50 INFO - 'log_to_console': True, 04:59:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:59:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:59:50 INFO - 'opt_config_files': (), 04:59:50 INFO - 'pip_index': False, 04:59:50 INFO - 'sps_profile': False, 04:59:50 INFO - 'sps_profile_interval': 0, 04:59:50 INFO - 'suite': 'dromaeojs-e10s', 04:59:50 INFO - 'system_bits': '32', 04:59:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:50 INFO - 'title': 'talos-linux64-ix-048', 04:59:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:50 INFO - 'use_talos_json': True, 04:59:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:59:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:50 INFO - 'work_dir': 'build'} 04:59:50 INFO - ##### 04:59:50 INFO - ##### Running clobber step. 04:59:50 INFO - ##### 04:59:50 INFO - Running pre-action listener: _resource_record_pre_action 04:59:50 INFO - Running main action method: clobber 04:59:50 INFO - rmtree: /builds/slave/test/build 04:59:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:59:51 INFO - Running post-action listener: _resource_record_post_action 04:59:51 INFO - ##### 04:59:51 INFO - ##### Running read-buildbot-config step. 04:59:51 INFO - ##### 04:59:51 INFO - Running pre-action listener: _resource_record_pre_action 04:59:51 INFO - Running main action method: read_buildbot_config 04:59:51 INFO - Using buildbot properties: 04:59:51 INFO - { 04:59:51 INFO - "project": "", 04:59:51 INFO - "product": "firefox", 04:59:51 INFO - "script_repo_revision": "production", 04:59:51 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:59:51 INFO - "repository": "", 04:59:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:59:51 INFO - "buildid": "20160524022209", 04:59:51 INFO - "pgo_build": "True", 04:59:51 INFO - "basedir": "/builds/slave/test", 04:59:51 INFO - "buildnumber": 366, 04:59:51 INFO - "slavename": "talos-linux64-ix-048", 04:59:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:59:51 INFO - "platform": "ubuntu64_hw", 04:59:51 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:59:51 INFO - "branch": "mozilla-aurora", 04:59:51 INFO - "repo_path": "releases/mozilla-aurora", 04:59:51 INFO - "revision": "a6138313bed92c7755f7f6ec38e9033a7abd88b2", 04:59:51 INFO - "stage_platform": "linux64-pgo", 04:59:51 INFO - "builduid": "b27ddde44f0140008b8f0df56a6bab0c", 04:59:51 INFO - "slavebuilddir": "test" 04:59:51 INFO - } 04:59:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 04:59:51 INFO - Running post-action listener: _resource_record_post_action 04:59:51 INFO - ##### 04:59:51 INFO - ##### Running download-and-extract step. 04:59:51 INFO - ##### 04:59:51 INFO - Running pre-action listener: _resource_record_pre_action 04:59:51 INFO - Running main action method: download_and_extract 04:59:51 INFO - mkdir: /builds/slave/test/build/tests 04:59:51 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')]} 04:59:51 INFO - https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:59:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:59:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:59:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:52 INFO - Downloaded 1361 bytes. 04:59:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 04:59:52 INFO - Using the following test package requirements: 04:59:52 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:59:52 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:59:52 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:59:52 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'jsshell-linux-x86_64.zip'], 04:59:52 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:59:52 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 04:59:52 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:59:52 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:59:52 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:59:52 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 04:59:52 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:59:52 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:52 INFO - https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:59:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:59:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:53 INFO - Downloaded 23812152 bytes. 04:59:53 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'] 04:59:53 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 04:59:55 INFO - Return code: 0 04:59:55 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 04:59:55 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')]} 04:59:55 INFO - https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:59:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:59:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 04:59:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:56 INFO - Downloaded 23812152 bytes. 04:59:56 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'] 04:59:56 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 04:59:57 INFO - Return code: 0 04:59: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')]} 04:59:57 INFO - https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:59:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:59:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 04:59:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:58 INFO - Downloaded 10840145 bytes. 04:59:58 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'] 04:59:58 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 04:59:58 INFO - Return code: 0 04:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:58 INFO - https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:59:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:59:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 04:59:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 04:59:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SasM4Ki3R9izo83mmuyhnw/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 05:00:00 INFO - Downloaded 62730992 bytes. 05:00:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:00:00 INFO - mkdir: /builds/slave/test/properties 05:00:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:00:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:00:00 INFO - Contents: 05:00:00 INFO - build_url:https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:00:00 INFO - Running post-action listener: _resource_record_post_action 05:00:00 INFO - Running post-action listener: set_extra_try_arguments 05:00:00 INFO - ##### 05:00:00 INFO - ##### Running populate-webroot step. 05:00:00 INFO - ##### 05:00:00 INFO - Running pre-action listener: _resource_record_pre_action 05:00:00 INFO - Running main action method: populate_webroot 05:00:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:00 INFO - '--tppagecycles', 05:00:00 INFO - '7'], 05:00:00 INFO - 'tests': ['tsvgm']}}, 05:00:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:00:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:00:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['damp', 'tps']}, 05:00:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'tests': ['damp', 'tps']}, 05:00:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['dromaeo_dom']}, 05:00:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['a11yr', 05:00:00 INFO - 'ts_paint', 05:00:00 INFO - 'tpaint', 05:00:00 INFO - 'sessionrestore', 05:00:00 INFO - 'sessionrestore_no_auto_restore', 05:00:00 INFO - 'tabpaint']}, 05:00:00 INFO - 'other-e10s': {'tests': ['a11yr', 05:00:00 INFO - 'ts_paint', 05:00:00 INFO - 'tpaint', 05:00:00 INFO - 'sessionrestore', 05:00:00 INFO - 'sessionrestore_no_auto_restore', 05:00:00 INFO - 'tabpaint']}, 05:00:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:00:00 INFO - 'ts_paint', 05:00:00 INFO - 'tpaint', 05:00:00 INFO - 'sessionrestore', 05:00:00 INFO - 'sessionrestore_no_auto_restore', 05:00:00 INFO - 'tabpaint']}, 05:00:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:00:00 INFO - 'ts_paint', 05:00:00 INFO - 'tpaint', 05:00:00 INFO - 'sessionrestore', 05:00:00 INFO - 'sessionrestore_no_auto_restore', 05:00:00 INFO - 'tabpaint']}, 05:00:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['a11yr', 05:00:00 INFO - 'ts_paint', 05:00:00 INFO - 'tpaint', 05:00:00 INFO - 'sessionrestore', 05:00:00 INFO - 'sessionrestore_no_auto_restore', 05:00:00 INFO - 'tabpaint']}, 05:00:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['a11yr', 05:00:00 INFO - 'ts_paint', 05:00:00 INFO - 'tpaint', 05:00:00 INFO - 'sessionrestore', 05:00:00 INFO - 'sessionrestore_no_auto_restore', 05:00:00 INFO - 'tabpaint']}, 05:00:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['tsvgx', 05:00:00 INFO - 'tsvgr_opacity', 05:00:00 INFO - 'tart', 05:00:00 INFO - 'tscrollx', 05:00:00 INFO - 'cart']}, 05:00:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:00:00 INFO - 'tsvgr_opacity', 05:00:00 INFO - 'tart', 05:00:00 INFO - 'tscrollx', 05:00:00 INFO - 'cart']}, 05:00:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'talos_options': ['--disable-e10s'], 05:00:00 INFO - 'tests': ['tp5o']}, 05:00:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'tests': ['tp5o']}, 05:00:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'talos_options': ['--disable-e10s', 05:00:00 INFO - '--xperf_path', 05:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:00 INFO - 'tests': ['tp5n']}, 05:00:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:00 INFO - 'talos_options': ['--xperf_path', 05:00:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:00 INFO - 'tests': ['tp5n']}}, 05:00:00 INFO - 'talos.zip': {'path': '', 05:00:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:00 INFO - Running post-action listener: _resource_record_post_action 05:00:00 INFO - ##### 05:00:00 INFO - ##### Running create-virtualenv step. 05:00:00 INFO - ##### 05:00:00 INFO - Running pre-action listener: _resource_record_pre_action 05:00:00 INFO - Running main action method: create_virtualenv 05:00:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:00:00 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 05:00:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:00:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:00 INFO - Using real prefix '/usr' 05:00:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:00:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:03 INFO - Installing pip.................done. 05:00:03 INFO - Return code: 0 05:00:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:03 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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:03 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 05:00:03 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 05:00:03 INFO - Using env: {'DISPLAY': ':0', 05:00:03 INFO - 'HOME': '/home/cltbld', 05:00:03 INFO - 'LANG': 'en_US.UTF-8', 05:00:03 INFO - 'LANGUAGE': 'en_US:en', 05:00:03 INFO - 'LOGNAME': 'cltbld', 05:00:03 INFO - 'MAIL': '/var/mail/cltbld', 05:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:03 INFO - 'MOZ_NO_REMOTE': '1', 05:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:03 INFO - 'NO_EM_RESTART': '1', 05:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:03 INFO - 'PWD': '/builds/slave/test', 05:00:03 INFO - 'SHELL': '/bin/bash', 05:00:03 INFO - 'SHLVL': '1', 05:00:03 INFO - 'TERM': 'linux', 05:00:03 INFO - 'TMOUT': '86400', 05:00:03 INFO - 'USER': 'cltbld', 05:00:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:03 INFO - '_': '/tools/buildbot/bin/python'} 05:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:03 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 05:00:03 INFO - Cleaning up... 05:00:03 INFO - Return code: 0 05:00:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:03 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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:03 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 05:00:03 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 05:00:03 INFO - Using env: {'DISPLAY': ':0', 05:00:03 INFO - 'HOME': '/home/cltbld', 05:00:03 INFO - 'LANG': 'en_US.UTF-8', 05:00:03 INFO - 'LANGUAGE': 'en_US:en', 05:00:03 INFO - 'LOGNAME': 'cltbld', 05:00:03 INFO - 'MAIL': '/var/mail/cltbld', 05:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:03 INFO - 'MOZ_NO_REMOTE': '1', 05:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:03 INFO - 'NO_EM_RESTART': '1', 05:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:03 INFO - 'PWD': '/builds/slave/test', 05:00:03 INFO - 'SHELL': '/bin/bash', 05:00:03 INFO - 'SHLVL': '1', 05:00:03 INFO - 'TERM': 'linux', 05:00:03 INFO - 'TMOUT': '86400', 05:00:03 INFO - 'USER': 'cltbld', 05:00:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:03 INFO - '_': '/tools/buildbot/bin/python'} 05:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:03 INFO - Downloading/unpacking psutil>=0.7.1 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:05 INFO - Installing collected packages: psutil 05:00:05 INFO - Running setup.py install for psutil 05:00:05 INFO - building 'psutil._psutil_linux' extension 05:00:05 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 05:00:05 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 05:00:06 INFO - building 'psutil._psutil_posix' extension 05:00:06 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 05:00:06 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 05:00:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:06 INFO - Successfully installed psutil 05:00:06 INFO - Cleaning up... 05:00:06 INFO - Return code: 0 05:00:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:00:06 INFO - Using env: {'DISPLAY': ':0', 05:00:06 INFO - 'HOME': '/home/cltbld', 05:00:06 INFO - 'LANG': 'en_US.UTF-8', 05:00:06 INFO - 'LANGUAGE': 'en_US:en', 05:00:06 INFO - 'LOGNAME': 'cltbld', 05:00:06 INFO - 'MAIL': '/var/mail/cltbld', 05:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:06 INFO - 'MOZ_NO_REMOTE': '1', 05:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:06 INFO - 'NO_EM_RESTART': '1', 05:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:06 INFO - 'PWD': '/builds/slave/test', 05:00:06 INFO - 'SHELL': '/bin/bash', 05:00:06 INFO - 'SHLVL': '1', 05:00:06 INFO - 'TERM': 'linux', 05:00:06 INFO - 'TMOUT': '86400', 05:00:06 INFO - 'USER': 'cltbld', 05:00:06 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:06 INFO - '_': '/tools/buildbot/bin/python'} 05:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:00:08 INFO - Installing collected packages: mozsystemmonitor 05:00:08 INFO - Running setup.py install for mozsystemmonitor 05:00:08 INFO - Successfully installed mozsystemmonitor 05:00:08 INFO - Cleaning up... 05:00:08 INFO - Return code: 0 05:00:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:00:08 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')]} 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:08 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')]} 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:08 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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:08 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 05:00:08 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 05:00:08 INFO - Using env: {'DISPLAY': ':0', 05:00:08 INFO - 'HOME': '/home/cltbld', 05:00:08 INFO - 'LANG': 'en_US.UTF-8', 05:00:08 INFO - 'LANGUAGE': 'en_US:en', 05:00:08 INFO - 'LOGNAME': 'cltbld', 05:00:08 INFO - 'MAIL': '/var/mail/cltbld', 05:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:08 INFO - 'MOZ_NO_REMOTE': '1', 05:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:08 INFO - 'NO_EM_RESTART': '1', 05:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:08 INFO - 'PWD': '/builds/slave/test', 05:00:08 INFO - 'SHELL': '/bin/bash', 05:00:08 INFO - 'SHLVL': '1', 05:00:08 INFO - 'TERM': 'linux', 05:00:08 INFO - 'TMOUT': '86400', 05:00:08 INFO - 'USER': 'cltbld', 05:00:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:08 INFO - '_': '/tools/buildbot/bin/python'} 05:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:11 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 05:00:11 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 05:00:11 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 05:00:11 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 05:00:11 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 05:00:11 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 05:00:11 INFO - Downloading docopt-0.6.1.tar.gz 05:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:11 INFO - Running setup.py install for blobuploader 05:00:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:00:11 INFO - Running setup.py install for requests 05:00:12 INFO - Running setup.py install for docopt 05:00:12 INFO - Successfully installed blobuploader requests docopt 05:00:12 INFO - Cleaning up... 05:00:12 INFO - Return code: 0 05:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:12 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')]} 05:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 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')]} 05:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:12 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 05:00:12 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 05:00:12 INFO - Using env: {'DISPLAY': ':0', 05:00:12 INFO - 'HOME': '/home/cltbld', 05:00:12 INFO - 'LANG': 'en_US.UTF-8', 05:00:12 INFO - 'LANGUAGE': 'en_US:en', 05:00:12 INFO - 'LOGNAME': 'cltbld', 05:00:12 INFO - 'MAIL': '/var/mail/cltbld', 05:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:12 INFO - 'MOZ_NO_REMOTE': '1', 05:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:12 INFO - 'NO_EM_RESTART': '1', 05:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:12 INFO - 'PWD': '/builds/slave/test', 05:00:12 INFO - 'SHELL': '/bin/bash', 05:00:12 INFO - 'SHLVL': '1', 05:00:12 INFO - 'TERM': 'linux', 05:00:12 INFO - 'TMOUT': '86400', 05:00:12 INFO - 'USER': 'cltbld', 05:00:12 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:12 INFO - '_': '/tools/buildbot/bin/python'} 05:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:12 INFO - Running setup.py (path:/tmp/pip-97B7y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:12 INFO - Running setup.py (path:/tmp/pip-5RLCTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:12 INFO - Running setup.py (path:/tmp/pip-q_ngJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:12 INFO - Running setup.py (path:/tmp/pip-6h0vWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:12 INFO - Running setup.py (path:/tmp/pip-d56Xbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:12 INFO - Running setup.py (path:/tmp/pip-jrvQlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:12 INFO - Running setup.py (path:/tmp/pip-xRP3f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:12 INFO - Running setup.py (path:/tmp/pip-MkeDfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:13 INFO - Running setup.py (path:/tmp/pip-hmZZIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:13 INFO - Running setup.py (path:/tmp/pip-TK2XWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:13 INFO - Running setup.py (path:/tmp/pip-o8l7xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:13 INFO - Running setup.py (path:/tmp/pip-UvrXSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:13 INFO - Running setup.py (path:/tmp/pip-VEI3lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:13 INFO - Running setup.py (path:/tmp/pip-a2tAU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:13 INFO - Running setup.py (path:/tmp/pip-fUv93u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:13 INFO - Running setup.py (path:/tmp/pip-akbRmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:13 INFO - Running setup.py (path:/tmp/pip-aCyKPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:13 INFO - Running setup.py install for manifestparser 05:00:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:00:13 INFO - Running setup.py install for mozcrash 05:00:13 INFO - Running setup.py install for mozdebug 05:00:13 INFO - Running setup.py install for mozdevice 05:00:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozfile 05:00:14 INFO - Running setup.py install for mozhttpd 05:00:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozinfo 05:00:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozInstall 05:00:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozleak 05:00:14 INFO - Running setup.py install for mozlog 05:00:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for moznetwork 05:00:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:00:14 INFO - Running setup.py install for mozprocess 05:00:14 INFO - Running setup.py install for mozprofile 05:00:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Running setup.py install for mozrunner 05:00:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Running setup.py install for mozscreenshot 05:00:15 INFO - Running setup.py install for moztest 05:00:15 INFO - Running setup.py install for mozversion 05:00:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:00:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:15 INFO - Cleaning up... 05:00:15 INFO - Return code: 0 05:00:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:15 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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:15 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 05:00:15 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 05:00:15 INFO - Using env: {'DISPLAY': ':0', 05:00:15 INFO - 'HOME': '/home/cltbld', 05:00:15 INFO - 'LANG': 'en_US.UTF-8', 05:00:15 INFO - 'LANGUAGE': 'en_US:en', 05:00:15 INFO - 'LOGNAME': 'cltbld', 05:00:15 INFO - 'MAIL': '/var/mail/cltbld', 05:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:15 INFO - 'MOZ_NO_REMOTE': '1', 05:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:15 INFO - 'NO_EM_RESTART': '1', 05:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:15 INFO - 'PWD': '/builds/slave/test', 05:00:15 INFO - 'SHELL': '/bin/bash', 05:00:15 INFO - 'SHLVL': '1', 05:00:15 INFO - 'TERM': 'linux', 05:00:15 INFO - 'TMOUT': '86400', 05:00:15 INFO - 'USER': 'cltbld', 05:00:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:15 INFO - '_': '/tools/buildbot/bin/python'} 05:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:15 INFO - Running setup.py (path:/tmp/pip-Z0hKyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:15 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)) 05:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:15 INFO - Running setup.py (path:/tmp/pip-hqXizk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:15 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)) 05:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:15 INFO - Running setup.py (path:/tmp/pip-ee23z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:15 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)) 05:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:15 INFO - Running setup.py (path:/tmp/pip-5vGkaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:15 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)) 05:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:15 INFO - Running setup.py (path:/tmp/pip-RNEN9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:16 INFO - Running setup.py (path:/tmp/pip-WLIuys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:16 INFO - Running setup.py (path:/tmp/pip-shhNUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:16 INFO - Running setup.py (path:/tmp/pip-jZ6Ubi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:16 INFO - Running setup.py (path:/tmp/pip-KnIcg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:16 INFO - Running setup.py (path:/tmp/pip-MO7EWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:16 INFO - Running setup.py (path:/tmp/pip-4WblVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:16 INFO - Running setup.py (path:/tmp/pip-hgfBdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:16 INFO - Running setup.py (path:/tmp/pip-TlZZoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:16 INFO - Running setup.py (path:/tmp/pip-HSLQ96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:16 INFO - Running setup.py (path:/tmp/pip-cCsAA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:16 INFO - Running setup.py (path:/tmp/pip-BZ8l5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:16 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)) 05:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:16 INFO - Running setup.py (path:/tmp/pip-IW6LC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:16 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)) 05:00:16 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)) 05:00:16 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)) 05:00:16 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)) 05:00:16 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)) 05:00:16 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)) 05:00:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:16 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 05:00:16 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 05:00:16 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 05:00:16 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 05:00:16 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 05:00:16 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 05:00:18 INFO - Downloading blessings-1.6.tar.gz 05:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:18 INFO - Installing collected packages: blessings 05:00:18 INFO - Running setup.py install for blessings 05:00:19 INFO - Successfully installed blessings 05:00:19 INFO - Cleaning up... 05:00:19 INFO - Return code: 0 05:00:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:19 INFO - Reading from file tmpfile_stdout 05:00:19 INFO - Current package versions: 05:00:19 INFO - argparse == 1.2.1 05:00:19 INFO - blessings == 1.6 05:00:19 INFO - blobuploader == 1.2.4 05:00:19 INFO - docopt == 0.6.1 05:00:19 INFO - manifestparser == 1.1 05:00:19 INFO - mozInstall == 1.12 05:00:19 INFO - mozcrash == 0.17 05:00:19 INFO - mozdebug == 0.1 05:00:19 INFO - mozdevice == 0.48 05:00:19 INFO - mozfile == 1.2 05:00:19 INFO - mozhttpd == 0.7 05:00:19 INFO - mozinfo == 0.9 05:00:19 INFO - mozleak == 0.1 05:00:19 INFO - mozlog == 3.1 05:00:19 INFO - moznetwork == 0.27 05:00:19 INFO - mozprocess == 0.22 05:00:19 INFO - mozprofile == 0.28 05:00:19 INFO - mozrunner == 6.11 05:00:19 INFO - mozscreenshot == 0.1 05:00:19 INFO - mozsystemmonitor == 0.0 05:00:19 INFO - moztest == 0.7 05:00:19 INFO - mozversion == 1.4 05:00:19 INFO - psutil == 3.1.1 05:00:19 INFO - requests == 1.2.3 05:00:19 INFO - wsgiref == 0.1.2 05:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:19 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 05:00:19 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 05:00:19 INFO - Using env: {'DISPLAY': ':0', 05:00:19 INFO - 'HOME': '/home/cltbld', 05:00:19 INFO - 'LANG': 'en_US.UTF-8', 05:00:19 INFO - 'LANGUAGE': 'en_US:en', 05:00:19 INFO - 'LOGNAME': 'cltbld', 05:00:19 INFO - 'MAIL': '/var/mail/cltbld', 05:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:19 INFO - 'MOZ_NO_REMOTE': '1', 05:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:19 INFO - 'NO_EM_RESTART': '1', 05:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:19 INFO - 'PWD': '/builds/slave/test', 05:00:19 INFO - 'SHELL': '/bin/bash', 05:00:19 INFO - 'SHLVL': '1', 05:00:19 INFO - 'TERM': 'linux', 05:00:19 INFO - 'TMOUT': '86400', 05:00:19 INFO - 'USER': 'cltbld', 05:00:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:19 INFO - '_': '/tools/buildbot/bin/python'} 05:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 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)) 05:00:19 INFO - Cleaning up... 05:00:19 INFO - Return code: 0 05:00:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:00:19 INFO - Using env: {'DISPLAY': ':0', 05:00:19 INFO - 'HOME': '/home/cltbld', 05:00:19 INFO - 'LANG': 'en_US.UTF-8', 05:00:19 INFO - 'LANGUAGE': 'en_US:en', 05:00:19 INFO - 'LOGNAME': 'cltbld', 05:00:19 INFO - 'MAIL': '/var/mail/cltbld', 05:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:19 INFO - 'MOZ_NO_REMOTE': '1', 05:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:19 INFO - 'NO_EM_RESTART': '1', 05:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:19 INFO - 'PWD': '/builds/slave/test', 05:00:19 INFO - 'SHELL': '/bin/bash', 05:00:19 INFO - 'SHLVL': '1', 05:00:19 INFO - 'TERM': 'linux', 05:00:19 INFO - 'TMOUT': '86400', 05:00:19 INFO - 'USER': 'cltbld', 05:00:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:19 INFO - '_': '/tools/buildbot/bin/python'} 05:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:19 INFO - Downloading/unpacking jsonschema 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:21 INFO - Downloading/unpacking functools32 (from jsonschema) 05:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:21 INFO - warning: no files found matching '*.txt' 05:00:21 INFO - no previously-included directories found matching 'build' 05:00:21 INFO - no previously-included directories found matching 'dist' 05:00:21 INFO - no previously-included directories found matching '.git*' 05:00:21 INFO - Installing collected packages: jsonschema, functools32 05:00:21 INFO - Running setup.py install for functools32 05:00:22 INFO - warning: no files found matching '*.txt' 05:00:22 INFO - no previously-included directories found matching 'build' 05:00:22 INFO - no previously-included directories found matching 'dist' 05:00:22 INFO - no previously-included directories found matching '.git*' 05:00:22 INFO - Successfully installed jsonschema functools32 05:00:22 INFO - Cleaning up... 05:00:22 INFO - Return code: 0 05:00:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:22 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 0x7fc288de9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c655a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, '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': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', '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 05:00:22 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 05:00:22 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 05:00:22 INFO - Using env: {'DISPLAY': ':0', 05:00:22 INFO - 'HOME': '/home/cltbld', 05:00:22 INFO - 'LANG': 'en_US.UTF-8', 05:00:22 INFO - 'LANGUAGE': 'en_US:en', 05:00:22 INFO - 'LOGNAME': 'cltbld', 05:00:22 INFO - 'MAIL': '/var/mail/cltbld', 05:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:22 INFO - 'MOZ_NO_REMOTE': '1', 05:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:22 INFO - 'NO_EM_RESTART': '1', 05:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:22 INFO - 'PWD': '/builds/slave/test', 05:00:22 INFO - 'SHELL': '/bin/bash', 05:00:22 INFO - 'SHLVL': '1', 05:00:22 INFO - 'TERM': 'linux', 05:00:22 INFO - 'TMOUT': '86400', 05:00:22 INFO - 'USER': 'cltbld', 05:00:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:22 INFO - '_': '/tools/buildbot/bin/python'} 05:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:22 INFO - Downloading/unpacking flake8 05:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:00:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:00:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:24 INFO - no previously-included directories found matching 'docs/_build' 05:00:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:00:25 INFO - Running setup.py install for pep8 05:00:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:25 INFO - no previously-included directories found matching 'docs/_build' 05:00:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:00:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:00:25 INFO - Cleaning up... 05:00:25 INFO - Return code: 0 05:00:25 INFO - Running post-action listener: _resource_record_post_action 05:00:25 INFO - Running post-action listener: _start_resource_monitoring 05:00:25 INFO - Starting resource monitoring. 05:00:25 INFO - ##### 05:00:25 INFO - ##### Running install step. 05:00:25 INFO - ##### 05:00:25 INFO - Running pre-action listener: _resource_record_pre_action 05:00:25 INFO - Running main action method: install 05:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:25 INFO - Reading from file tmpfile_stdout 05:00:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:00:25 INFO - Reading from file tmpfile_stdout 05:00:25 INFO - Output received: 05:00:25 INFO - Usage: mozinstall [options] installer 05:00:25 INFO - Options: 05:00:25 INFO - -h, --help show this help message and exit 05:00:25 INFO - -d DEST, --destination=DEST 05:00:25 INFO - Directory to install application into. [default: 05:00:25 INFO - "/builds/slave/test"] 05:00:25 INFO - --app=APP Application being installed. [default: firefox] 05:00:25 INFO - mkdir: /builds/slave/test/build/application 05:00:25 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'] 05:00:25 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 05:00:41 INFO - Reading from file tmpfile_stdout 05:00:41 INFO - Output received: 05:00:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:00:41 INFO - Running post-action listener: _resource_record_post_action 05:00:41 INFO - ##### 05:00:41 INFO - ##### Running run-tests step. 05:00:41 INFO - ##### 05:00:41 INFO - Running pre-action listener: _resource_record_pre_action 05:00:41 INFO - Running main action method: run_tests 05:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:00:41 INFO - Python 2.7.3 05:00:41 INFO - Return code: 0 05:00:41 INFO - grabbing minidump binary from tooltool 05:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:41 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 0x2cf4410>, '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 0x2cf5310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf57a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:00:41 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 05:00:41 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 05:00:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:41 INFO - Return code: 0 05:00:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:00:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:00:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:00:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:00:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:00:42 INFO - Return code: 0 05:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:00:42 INFO - Using env: {'DISPLAY': ':0', 05:00:42 INFO - 'HOME': '/home/cltbld', 05:00:42 INFO - 'LANG': 'en_US.UTF-8', 05:00:42 INFO - 'LANGUAGE': 'en_US:en', 05:00:42 INFO - 'LOGNAME': 'cltbld', 05:00:42 INFO - 'MAIL': '/var/mail/cltbld', 05:00:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:00:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:42 INFO - 'MOZ_NO_REMOTE': '1', 05:00:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:42 INFO - 'NO_EM_RESTART': '1', 05:00:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:42 INFO - 'PWD': '/builds/slave/test', 05:00:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:00:42 INFO - 'SHELL': '/bin/bash', 05:00:42 INFO - 'SHLVL': '1', 05:00:42 INFO - 'TERM': 'linux', 05:00:42 INFO - 'TMOUT': '86400', 05:00:42 INFO - 'USER': 'cltbld', 05:00:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236', 05:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:42 INFO - '_': '/tools/buildbot/bin/python'} 05:00:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:00:42 INFO - mozversion application_buildid: 20160524022209 05:00:42 INFO - mozversion application_changeset: a6138313bed92c7755f7f6ec38e9033a7abd88b2 05:00:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:00:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:42 INFO - mozversion application_name: Firefox 05:00:42 INFO - mozversion application_remotingname: firefox-dev 05:00:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:00:42 INFO - mozversion application_vendor: Mozilla 05:00:42 INFO - mozversion application_version: 48.0a2 05:00:42 INFO - mozversion platform_buildid: 20160524022209 05:00:42 INFO - mozversion platform_changeset: a6138313bed92c7755f7f6ec38e9033a7abd88b2 05:00:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:00:42 INFO - mozversion platform_version: 48.0a2 05:00:42 INFO - using testdate: 1464091242 05:00:42 INFO - actual date: 1464091242 05:00:42 INFO - starting webserver on 'localhost:37463' 05:00:42 INFO - SUITE-START | Running 2 tests 05:00:42 INFO - TEST-START | dromaeo_css 05:00:42 INFO - operating with platform_type : linux_ 05:00:42 INFO - Initialising browser for dromaeo_css test... 05:00:42 INFO - TEST-INFO | started process 15338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvA83S/profile http://localhost:37463/getInfo.html) 05:00:46 INFO - PROCESS | 15338 | 05:00:46 INFO - PROCESS | 15338 | (process:15415): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:00:46 INFO - PROCESS | 15338 | __metrics Screen width/height:1600/1200 05:00:46 INFO - PROCESS | 15338 | colorDepth:24 05:00:46 INFO - PROCESS | 15338 | Browser inner width/height: 1024/697 05:00:46 INFO - PROCESS | 15338 | __metrics 05:00:47 ERROR - PROCESS | 15338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:00:48 INFO - TEST-INFO | 15338: exit 0 05:00:48 INFO - Browser initialized. 05:00:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:00:48 INFO - TEST-INFO | started process 15466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvA83S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:50 INFO - PROCESS | 15466 | 05:00:50 INFO - PROCESS | 15466 | (process:15536): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:01:00 INFO - PROCESS | 15466 | RSS: Main: 152186880 05:01:00 INFO - PROCESS | 15466 | 05:01:49 INFO - PROCESS | 15466 | 1464091309890 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] 05:03:57 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:37463/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37463/tests/dromaeo/cssquery-ext.html) 05:03:58 INFO - PROCESS | 15466 | RSS: Main: 155234304 05:03:58 INFO - PROCESS | 15466 | 05:06:59 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:37463/tests/dromaeo/cssquery-ext.html (next: http://localhost:37463/tests/dromaeo/cssquery-jquery.html) 05:07:00 INFO - PROCESS | 15466 | RSS: Main: 152780800 05:07:00 INFO - PROCESS | 15466 | 05:10:02 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:37463/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37463/tests/dromaeo/cssquery-mootools.html) 05:10:02 INFO - PROCESS | 15466 | RSS: Main: 152317952 05:10:02 INFO - PROCESS | 15466 | 05:13:04 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:37463/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37463/tests/dromaeo/cssquery-prototype.html) 05:13:05 INFO - PROCESS | 15466 | RSS: Main: 152645632 05:13:05 INFO - PROCESS | 15466 | 05:16:07 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:37463/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37463/tests/dromaeo/cssquery-yui.html) 05:16:07 INFO - PROCESS | 15466 | RSS: Main: 154148864 05:16:07 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | Cycle 1(1): loaded http://localhost:37463/tests/dromaeo/cssquery-yui.html (next: http://localhost:37463/tests/dromaeo/cssquery-dojo.html) 05:19:10 INFO - PROCESS | 15466 | RSS: Main: 155725824 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | __start_tp_report 05:19:10 INFO - PROCESS | 15466 | _x_x_mozilla_page_load 05:19:10 INFO - PROCESS | 15466 | _x_x_mozilla_page_load_details 05:19:10 INFO - PROCESS | 15466 | |i|pagename|runs| 05:19:10 INFO - PROCESS | 15466 | |0;dojo.html;3285.09659843543;3298.4227760141985;3326.417876871547;3334.333133373323;3339.565856438664;5470.972645136769;5471.972640136793;5498.202760599711;5506.50441460269;5528.143137813635;5453.863653408666;5461.399246082928;5501.477359650837;5517.5585953123755;5517.613767036309;4988.700677959325;5016.473270306602;5067.74661266937;5089.51649593288;5119;4993.275974983625;5039.672421292605;5077.923831142536;5079.898402031957;5097.05704444677;5075;5182;5184.274201611777;5192.792288308463;5236.685798852062;5043.268726034741;5043.949560504403;5086.033653605803;5105.795768169269;5126.179811230222;4922.212446008622;4951.133551628451;4982.77577509013;5013.197888337849;5021.297018417425;5315.309009828737;5417.918731219035;5435.565154787608;5458.6724796512335;5493.313335833021;5816.447437493432;5870.471657550798;5885.117232415172;5888.440598143169;5896.38088000758;5624.268845050158;5815.418458154193;5931.970340148272;5933.258342707161;5943.3462319144855;5536.197251398565;5549.972250138723;5580.693061881595;5584.972075139598;5586.776528938837;5888.705564721832;5895.941040589625;5942.781729745392;5952.345242023374;5957.761689532457;5688.63023903445;5690.374058853523;5780.046292361713;5782.2194003808945;5816.73824677882;5845.970770146122;5853.94146058534;5887.793927212612;5888.205092312483;5893.528517718572;5749.8562535936935;5887.882242355215;5898.262717160355;5907.113932910098;5910.7931222407005;5818.069108942549;5870.148828419855;5883.735231914574;5903.055511118287;5915.053591425351;4464.1071785643;4471.441069866267;4482.955170448319;4486.7083639563325;4510.571495707903;3980.4626375439525;3986.5016872890887;4045.9797701011307;4048.332025215865;4078.775667338325;5505.752241149158;5685.090385538294;5685.118806584986;5712.457316554921;5752;5936.287645482484;5941.732622032019;5942.64344139353;5947.167396564484;5952.345242023374;5466.453354664502;5608.803691870765;5684.9431505684415;5686.857828554236;5696.174054762119;4936.284238785356;4944.060628480577;4947.703137811671;4949.82675606352;4977.427595826454;6081.513478921675;6098.298695650057;6147.44672979434;6156.445919867144;6160.630362178284;5750.712464376848;5820.30156381237;5898.970505147447;5948.8215353537735;5960.64236145824;6081.695915204134;6101.450869421773;6104.816855494342;6104.969475152773;6118.785842495491;5798.59409841307;5808.07070868659;5808.564357673107;5817.650940943557;5830.416958304136;5822.737976791139;5912.379200183918;5966.224390829338;6000.259924621985;6029.668368239789;5739.053056245672;5769.423057694197;5785.681787501728;5786.132080188006;5802.767889284381;5695.345035320825;5720.942790572208;5738.770449182153;5739.225204597493;5748.109043098327;5617.8033768817895;5702.287214098238;5721.22763426932;5751.194832723506;5754.5684073695475;5795.159701843125;5823.534117270524;5850.678212698343;5854.297484301911;5903.144044113494;5569.916451253153;5742.138679197987;5752.9712351437975;5757.65454072757;5771.192033115283 05:19:10 INFO - PROCESS | 15466 | |1;ext.html;655.62301676536;673.3838537737969;677.1637028270088;712.8538649576834;727.3017902813298;39756.2048759025;40554.39168412476;40583.59416405835;40767.184656306854;40909;42429.787851060704;42442;42850;42906.7854660727;42946.570534294646;8682.088380720028;8912.821743565124;8918.955405222965;8919.73240802777;8921.15249051339;8722.476651400904;8726.301895848317;8786.516741579211;8806.471611703286;8808.911910880905;9080.59137338818;9136.58885350161;9138.908610913872;9149;9178.219851312613;9017.594208260643;9061.184493395625;9062.546872656341;9073.047330030351;9080.455172689626;8954.507502087383;9051.094890510962;9072.8639070414;9089.909100908972;9096.590653420546;42944.57055429437;43540.129197416194;43714;43769.78115109436;43971.34042989358;3875.205582855508;3990.760554366718;4246.766427846467;4424.80088396023;4768.618510519184;32641;33734.15664608405;33750.83124584386;33764.32471350584;34466.31067378663;4423.469183697945;4576.496585375606;4594.494605593382;4595.655325850541;4602.424696912886;312353;313041;315959.42020289984;315988;316516;61070.694646526485;61490;61510;61560;61721.38278617156;71050;72449;72623.27376726271;72651;72787.27212727805;19439;19633.803661963197;19711.60576788456;19712.408627740904;19725.704114438297;15165.620859478602;15243.847561524464;15270.465533706489;15275.847241527665;15329.46346877854;20130.094145763476;20189;20292.492687682927;20341.694874576893;21116.36650900445;8073.555954422563;8213.95893020543;8265.809560466481;8297.25324720778;8309.8338033239;1210.2254557083475;1212.950797560104;1221.3404761428906;1251.9233459225059;1255.6421419895287;28642.85678571594;29190.854045729637;29499.852500737357;29634;29701.702982969895;1221.8839210275187;1246.5574720974105;1260.1242136714895;1261.2936755416995;1296.7341694952513;16102.516924492284;16125.193740313172;16172.75740863888;16405.753913691304;16728.16359182036;491643;499058;579197;601875;782757;55684.44315556873;57603.711981439825;57649.42350576525;57705.42294577084;57780.422195778345;819.1399031017527;1364.6179069860455;1533.9233038348038;1536.853998870128;1539.0457916092093;33561.49657755184;34099.496378819116;34166.487502687974;34424.48363274603;34622.30755384828;53294;53804.730976344865;53959.19061214006;54166;54236.186457202384;421930;422131;423392;423414;424492;30307.090787275534;30310.84844575763;30657.386852263277;31023.84488077545;31287.374252515277;45889.770551147034;46483.070338593716;48228.27657585209;50709;52080;43011.569884300756;43148.56851431446;43484.78257608692;43493.3475997854;43790.78104609456;42701.786491067345;42790.57209427866;43088;43819.123617526835;44278.335824963295;42439.3634095495;43330;44224;44252.77873610611;44891.326630099924;36601.81699091594;36606.450903237004;37058;37710.43434348432;38133.237335253696;28817.42365152643;29075;29182;29496.705032950253;29568 05:19:10 INFO - PROCESS | 15466 | |2;jquery.html;412.9772862492563;424.8831571317889;425.6084402349836;430.06031820472253;430.3093534876523;14693;19202.519937001565;19433.31983380582;19849.702254466178;19866.90066549667;18855.622887542242;18878.433646990612;19145.808541914612;19609.803901960975;19627.509312267164;5340.786368545263;5885.705714714269;5910.67491287979;5922.111683247525;5963.970180149115;5740.225069615591;5779.2775903012125;5872.354041055481;5875.559333050017;5891.263592050994;5662.065759149736;5864.648121112726;5884.411558844125;5888.499477544414;5888.735006924699;5830.62100963436;5856.1508581255475;5880.647161170344;5885.499732522762;5899.233099697033;5199.376074871039;5232.607554433394;5235.319408476912;5265.815696450606;5296;23007.1947481839;23625.173118940926;23634.29097127089;24015.519689606284;24018.879905600534;2653.1775149703653;2880.5391137417914;3075.384923015406;3080.430120427706;3338.7996720196866;14447.433477500574;14924.850751492455;15162.620934476727;15547.455839045691;15813.209339532978;2037.266584029763;2068.9689654655194;2127.8829664368454;2132.808047275737;2143.1534543855246;70763;71367;71734.64132679303;72661.63669181621;73274.26725732727;10986.780264394667;10990.395528246023;11239.381833999209;12040.036797056215;12270.570530031406;15445.691086178214;15487.225638718019;15659.686806263811;15670;15708.60728481797;9168.174864262248;9199.862002069975;9201.447913125234;9215.769605759775;9341.673041443653;9377.578008989612;9429.151376376021;9434;9565.713028609152;9582.808343833085;6791.558548694319;7087.468439867031;7098.609576473344;7154.928450715531;7235;1974.792646772097;1976.8122028407565;1994.5811379610154;2022.261874415857;2028.4421784009514;1023.2400271532952;1133.5692436873935;1139.4929256480953;1158.5134243617701;1180.8985184005016;18679.159437825332;19905.502362441053;20117.19531218764;20209.494762631053;20347.186112555628;1095.7315457712912;1097.4635510285664;1161.9709507262387;1180.9291442513477;1231.6920769807548;11774.52901883915;11806.527738890349;11836.70408239801;11843.230190037792;11857.16999810005;530286;536632;542778;546175;554551;62463.68768156221;68483.65758171277;71773;74959;78639.60680196677;1116.849225354583;1127.515168477546;1141.0985321595847;1163.3485248261002;1171.718787490996;18145.90927045356;18302.176402061672;18528.722069168703;18547.258109675462;18751.90624046871;38500.22999539937;38588.228235435694;38895.805520972215;40131.59868401279;41048.79475602603;52440.73779631077;52686.209706855196;53083;53108;53341.6664583373;8023.959880200561;8496.767968644635;8576.914230857612;8661.61022753965;8692.217700406994;9371.953140234255;13252.668683282995;13556.864431355954;13617.523386681418;13779.035467517178;11339.092872570009;11619.070474361863;11742.412879356169;11782.234154779911;11926.821097683369;11570.132240081859;11787.174897757075;12164.695882603006;12254.326012069421;12258.75482490363;11958.552743333017;12383.938080309541;12541.247525148521;12679.873201268238;12775.552855650008;8310.916890831257;8315.501069935823;8316.168383161636;8329.50022998622;8641.783955401166;11705.941470292593;12132.393380330772;12241.632751017483;12375.69060773488;12753.48986040548 05:19:10 INFO - PROCESS | 15466 | |3;mootools.html;1578.755292929596;1582.4540533515938;1788.4277031349966;1881.2663061406063;1909.8185672361121;7308.269173082689;8141.633626486808;8154;8404.747857564284;8456.069832318448;8179.591020448968;8265.83468330633;8287.544185069819;8296.626651800669;8323.417360784748;2345.7185137783404;2386.4033991502124;2388.22382725614;2389.916352927648;2392.102961389479;2352.5059737455153;2380.5238952209543;2413.698287714036;2415.8429702069398;2417.9758202418016;2315.768423157679;2359.917402890899;2378.250850981935;2388.868612226327;2392.6530653055297;2322.918697845576;2323.1984965186984;2325.104834638659;2327.848689835164;2405.350555350063;2348.4598542335357;2353.035255545218;2364.3616223619524;2379.4646204604;2379.6430535419654;8544;8565.48607083577;8585.399022068457;8635.309175265964;8636.697715579987;5209.505097015777;5216.374035115772;5257.474252574751;5263.078961181778;5284.603654725873;3468.739844511672;3518.437050072002;3546.7517273790845;3559.110222444389;3586.8923932281814;1246.8628450870397;1272.338384040303;1285.6528737240892;1288.2013151845915;1318.3605951113702;11838.052955763518;11849.763004739856;11886.04911607078;11903.345316007617;11903.880961190363;4485.147821913826;4485.192665320208;4535.750533720611;4602.332661764092;4693.9765301173275;10147.847782283272;10163.796724065478;10209.38743675382;10214.642487512901;10219.386836789816;5303.867403314948;5307.761150748149;5311.468853114735;5333.679979201261;5337.759800808973;4100.610442008005;4750.8337208197545;4803.351547541037;4879.902401951941;4902.068606964736;3983.342748446532;4033.3143365627916;4062.431259623655;4084.346504559256;4128.401381799622;1293.5472584595316;1295.838020247469;1296.7017585955284;1312.9146605470805;1315.9934200328937;921.3320342751451;999.695092996643;1038.7846219922708;1050.4432650695144;1054.9789004219872;5715.257016587817;5897.085951677497;5948.375420580864;6019.036954087325;6056.545759068087;979.872616559857;1050.7898420315967;1051.3954476176077;1052.847337136111;1076.5370890516997;3920.6471417572557;4000.6599439047427;4005.539362973237;4028.597140285948;4073.653739432122;10044.698659040241;10332.535035923402;10349.379037257639;10386.636467723745;10425.322354047114;10278.640247591447;10302.948485257526;10432.68701938943;10462.424566648755;10602.734931626772;8033.277005069572;8152.83694326122;8200.42597018203;8255.463394879434;8264.793380165544;5759.769609215585;5761.222234998221;5796.188533605215;5829.271341082364;5837.29952405714;8857.64569417216;8921.420107692978;9032.638694452411;9139.131782480654;9238.907610924074;8972.461652300883;9003.774905627411;9047.81904361896;9159.404638698463;9189.77025574366;6982.197047339621;6990.161180658353;7041.436685065285;7396.149442814145;7605.961970190114;7747.070351557849;7818.413618978713;7818.92181078182;7846.921530784619;7873.5275883447175;7019.4735394844565;7150.856982860418;7164.67758950838;7231.8553628928175;7242.637868106679;7007.159140903124;7072.151341839012;7074.504784665024;7121.181064177686;7126.5011449198055;6665.133532640726;6677.29888361715;6732.899006514808;6739.42714869222;6740.730370785113;4822.68652537584;4911.8280860169725;4966.751662416792;4980.302757614009;5051.368578927634;5035.269885866602;5050.49495050492;5053.393592768891;5105;5159.793608255628 05:19:10 INFO - PROCESS | 15466 | |4;prototype.html;306.7239484463982;307.6754024504147;309.8853424233033;318.3235624298367;326.5836059024742;6566.343365663437;6657.400833924946;6720.327967203277;6754.527183097179;6756.898646520306;6550.312217217195;6573.342665733424;6576.586034002688;6607.570507916982;6627.337266273383;4707.8587642370785;4775.403074615673;4892.706437613754;4908.680935739183;4910.116179087763;4854.859108109591;4862.100511405383;4889.926651100236;4908.116539022974;4911.361523002005;4815.133276010317;4851.417829860422;4855.441624213207;4856.781444834991;4859.173940430118;4845.806167753286;4882.3408839806525;4883.609311255091;4890.266460030988;4892.584130348907;4184.518780340239;4188.832446702128;4192.643625291854;4197.97901010496;4205.285101532747;6264.59280146789;6298.2442106947;6350.396712312323;6388.616682999035;6393.07300441438;5633.267675202238;5677.829665110054;5684.8863022739315;5689.374168841424;5691.857703557403;6913;6944.652767361612;6956.304369563054;6969.512134150612;6969.6515174241595;4651.418572678415;4693.577578017961;4698.412698412699;4708.293755936603;4717.221658426355;7251.419886409075;7257.564546127249;7284.45366597502;7313.853722925565;7319.085114360705;4537.160625284333;4672.696274742131;4675.4155730533685;4678.69588476748;4774.236122220497;4709.505501922317;4729.1014707206205;4729.787159577759;4733.195356789354;4746;5594.021046316879;5608.943910560843;5613.578981576398;5613.887722245614;5613.943860561424;6980.127484064492;7000.124984376953;7001.3394909933895;7009.509334346649;7058.2941705830035;1628.9429869954495;1631.4534630898545;1643.408372985724;1650.9009459432473;1652.1573997261244;1003.3578509753618;1029.562435964712;1037.2065369991963;1049.7323182588543;1050.2438244463974;6800.455963522906;6810.182778066664;6816.352446517573;6816.965915170492;6820.079289295882;7108.218096009435;7259.745908893164;7260.891086633705;7262.709491620276;7265.8546829063125;6883.483738719616;6891.414229790424;6921.930780692129;6926.792196234121;6930.826729331706;3938.5076865391825;3977.343738283209;3977.4829272195007;3983.2830090583393;3985.8206380712936;7595.620218989028;7621.161672216052;7621.352185064332;7630.809229769189;7631.771046868603;7326.04761381017;7409.333160015624;7440.590767507839;7450.701971921171;7460.477766556398;7633.1985141559335;7641.2740789624895;7642.808929776689;7643.69425222996;7664.578448185292;7220.675069621774;7285.453590980592;7287.161976372785;7291.562506249642;7304.050473438631;7189.964050179925;7202.927970720226;7204.495685302189;7207.9279207207255;7218.27817218274;7428.405727541675;7593.430492713179;7657.157712651715;7658.770236892902;7663.616819159131;4713.198756211521;4738;4763.476017637988;4767.6662633615315;4774.594159496342;7223.458240632079;7263.673134708845;7264.455165862476;7269.3094156055095;7273.309035641606;7018.017477553249;7064.222935477196;7096;7097.183823860322;7102.786916392516;6895.069380573447;7038.964805175941;7042.753503627348;7050.294970502909;7057.576545407292;6884.690188941609;6909.170899491892;6922.965385173042;6930.584164950119;6931.7227310907;7065.222825489295;7066.4346852250665;7094.467914906506;7112.751053713096;7125.18060423058;6870.587764734132;6896;6905.413039891666;6916.965415172892;6945.374916257561 05:19:10 INFO - PROCESS | 15466 | |5;yui.html;772.2894936658274;824.1173178547199;904.9773755656108;908.1100521488943;933.3839665820556;14678.853211467882;14755.336009879555;14784.408623655054;14810.18543980082;14829.77755333671;14310.642233944156;14348.210848403334;14379.137251764902;14426.567202983928;14426.639334016654;758.7458201502503;892.9464232146059;907.773056735816;914.9451032938011;915.0757734687946;907.4645958884257;908.27791905435;912.4935660708304;917.0645941140033;917.5320586500899;970.4565443351711;975.1564896364664;977.1205914676813;977.2914636888235;979.3438396274478;967.3422072990434;968.7190714692731;969.8205831921082;971.9368241064343;978.5792109392958;718.4180813541049;720.4164626652429;721.5346101764333;721.8556288742272;723.2297603052732;14947.02844315116;15024.399024039025;15052.247387630574;15190.544283671508;15195.62010949724;15189.392424303014;15211.847881521155;15283.923580382138;15436.151011694352;15489.683376912975;11647.41762911851;11701.414929253588;11798.705032374259;11906.523739050428;11936.104792140624;4065.2072845795083;4117.794110294473;4143.067809742814;4143.56492568279;4173.937390939138;54416.18375724367;54679;55810.44189558093;56174.43825561733;56642.43357566413;11534.653960381202;11565.826512602318;11623.12826538013;11706.297622142698;11758.05935525156;21371.145154193968;21426.678599821014;21428;21433.67849482259;21437.892810535846;9135.68025119131;9253.861192082124;9266.953665231631;9301.162895339452;9307.301952353466;5161;5167.328247327899;5214.504622060898;5274.947250527445;5295.602829787781;3571.0715214044535;3600.207954250061;3610.9638903610626;3614.963850361463;3615.3311637347174;662.1954325494547;677.2854638356482;682.0621645237798;684.1004079635263;684.2473279392628;783.5494590610422;792.3938187286731;811.9309858661961;845.4631309118754;870.1037930931151;9611.279154063473;9638.9036109638;9655.845546309642;9666.014142463435;9990.400575965465;644.2751904107879;660.5178219899404;711.7615598774365;737.4174402222185;741.810838236257;4419.790284442947;4571.245744452128;4598.26427771555;4598.3102534620075;4629.259318509023;59423.405765942654;65439;65454.67272663606;65756.6712166436;65872;54789.726051369486;54877;55193.172102418495;55500.44499555034;55786.721066394406;49336;49487.505124949006;49575.99999999928;51699.224511632354;52004;9382.906170938477;9599.376040557341;9741.366811157252;9853.205720703136;9967.950160249442;38036;39240.6075939237;39923;39961.2007759849;40540.3918941222;47085.76457117692;51094.48905511046;51583.226251605505;51590.41959157602;52258.21612675889;12934.676633084247;12938.741225175256;13053.804192937303;13334.266615335862;13362.599122026355;14397.496087636882;14523.491677791226;14636.487722929647;14695.70608587801;14704.558863233693;12996.740065198832;13293.933530332286;13384.93307533456;13539.796903046265;13639.868087921142;13481.191128532319;13559.864401356255;13837.723245535235;13900.582982510541;14297.499587514387;13408.932955335162;13730.725385492435;13773.380197890918;13956.581302560939;14114.2942852859;11158.88841111611;11253.549858005588;11489.82765258505;11627;11671.941640291745;11130.888691113309;11462.913519468684;11559.826602601135;11595.478203481032;11757.118216133653 05:19:10 INFO - PROCESS | 15466 | __end_tp_report 05:19:10 INFO - PROCESS | 15466 | __start_cc_report 05:19:10 INFO - PROCESS | 15466 | _x_x_mozilla_cycle_collect,333 05:19:10 INFO - PROCESS | 15466 | __end_cc_report 05:19:10 INFO - PROCESS | 15466 | __startTimestamp1464092350261__endTimestamp 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | ------- Summary: start ------- 05:19:10 INFO - PROCESS | 15466 | Number of tests: 6 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | [#0] dojo.html Cycles:165 Average:5485.21 Median:5721.23 stddev:604.91 (10.6%) stddev-sans-first:581.63 05:19:10 INFO - PROCESS | 15466 | Values: 3285.1 3298.4 3326.4 3334.3 3339.6 5471.0 5472.0 5498.2 5506.5 5528.1 5453.9 5461.4 5501.5 5517.6 5517.6 4988.7 5016.5 5067.7 5089.5 5119.0 4993.3 5039.7 5077.9 5079.9 5097.1 5075.0 5182.0 5184.3 5192.8 5236.7 5043.3 5043.9 5086.0 5105.8 5126.2 4922.2 4951.1 4982.8 5013.2 5021.3 5315.3 5417.9 5435.6 5458.7 5493.3 5816.4 5870.5 5885.1 5888.4 5896.4 5624.3 5815.4 5932.0 5933.3 5943.3 5536.2 5550.0 5580.7 5585.0 5586.8 5888.7 5895.9 5942.8 5952.3 5957.8 5688.6 5690.4 5780.0 5782.2 5816.7 5846.0 5853.9 5887.8 5888.2 5893.5 5749.9 5887.9 5898.3 5907.1 5910.8 5818.1 5870.1 5883.7 5903.1 5915.1 4464.1 4471.4 4483.0 4486.7 4510.6 3980.5 3986.5 4046.0 4048.3 4078.8 5505.8 5685.1 5685.1 5712.5 5752.0 5936.3 5941.7 5942.6 5947.2 5952.3 5466.5 5608.8 5684.9 5686.9 5696.2 4936.3 4944.1 4947.7 4949.8 4977.4 6081.5 6098.3 6147.4 6156.4 6160.6 5750.7 5820.3 5899.0 5948.8 5960.6 6081.7 6101.5 6104.8 6105.0 6118.8 5798.6 5808.1 5808.6 5817.7 5830.4 5822.7 5912.4 5966.2 6000.3 6029.7 5739.1 5769.4 5785.7 5786.1 5802.8 5695.3 5720.9 5738.8 5739.2 5748.1 5617.8 5702.3 5721.2 5751.2 5754.6 5795.2 5823.5 5850.7 5854.3 5903.1 5569.9 5742.1 5753.0 5757.7 5771.2 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | [#1] ext.html Cycles:180 Average:61449.98 Median:42979.07 stddev:122720.31 (285.5%) stddev-sans-first:122979.69 05:19:10 INFO - PROCESS | 15466 | Values: 655.6 673.4 677.2 712.9 727.3 39756.2 40554.4 40583.6 40767.2 40909.0 42429.8 42442.0 42850.0 42906.8 42946.6 8682.1 8912.8 8919.0 8919.7 8921.2 8722.5 8726.3 8786.5 8806.5 8808.9 9080.6 9136.6 9138.9 9149.0 9178.2 9017.6 9061.2 9062.5 9073.0 9080.5 8954.5 9051.1 9072.9 9089.9 9096.6 42944.6 43540.1 43714.0 43769.8 43971.3 3875.2 3990.8 4246.8 4424.8 4768.6 32641.0 33734.2 33750.8 33764.3 34466.3 4423.5 4576.5 4594.5 4595.7 4602.4 312353.0 313041.0 315959.4 315988.0 316516.0 61070.7 61490.0 61510.0 61560.0 61721.4 71050.0 72449.0 72623.3 72651.0 72787.3 19439.0 19633.8 19711.6 19712.4 19725.7 15165.6 15243.8 15270.5 15275.8 15329.5 20130.1 20189.0 20292.5 20341.7 21116.4 8073.6 8214.0 8265.8 8297.3 8309.8 1210.2 1213.0 1221.3 1251.9 1255.6 28642.9 29190.9 29499.9 29634.0 29701.7 1221.9 1246.6 1260.1 1261.3 1296.7 16102.5 16125.2 16172.8 16405.8 16728.2 491643.0 499058.0 579197.0 601875.0 782757.0 55684.4 57603.7 57649.4 57705.4 57780.4 819.1 1364.6 1533.9 1536.9 1539.0 33561.5 34099.5 34166.5 34424.5 34622.3 53294.0 53804.7 53959.2 54166.0 54236.2 421930.0 422131.0 423392.0 423414.0 424492.0 30307.1 30310.8 30657.4 31023.8 31287.4 45889.8 46483.1 48228.3 50709.0 52080.0 43011.6 43148.6 43484.8 43493.3 43790.8 42701.8 42790.6 43088.0 43819.1 44278.3 42439.4 43330.0 44224.0 44252.8 44891.3 36601.8 36606.5 37058.0 37710.4 38133.2 28817.4 29075.0 29182.0 29496.7 29568.0 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | [#2] jquery.html Cycles:180 Average:29857.95 Median:23629.73 stddev:88523.09 (374.6%) stddev-sans-first:88743.81 05:19:10 INFO - PROCESS | 15466 | Values: 413.0 424.9 425.6 430.1 430.3 14693.0 19202.5 19433.3 19849.7 19866.9 18855.6 18878.4 19145.8 19609.8 19627.5 5340.8 5885.7 5910.7 5922.1 5964.0 5740.2 5779.3 5872.4 5875.6 5891.3 5662.1 5864.6 5884.4 5888.5 5888.7 5830.6 5856.2 5880.6 5885.5 5899.2 5199.4 5232.6 5235.3 5265.8 5296.0 23007.2 23625.2 23634.3 24015.5 24018.9 2653.2 2880.5 3075.4 3080.4 3338.8 14447.4 14924.9 15162.6 15547.5 15813.2 2037.3 2069.0 2127.9 2132.8 2143.2 70763.0 71367.0 71734.6 72661.6 73274.3 10986.8 10990.4 11239.4 12040.0 12270.6 15445.7 15487.2 15659.7 15670.0 15708.6 9168.2 9199.9 9201.4 9215.8 9341.7 9377.6 9429.2 9434.0 9565.7 9582.8 6791.6 7087.5 7098.6 7154.9 7235.0 1974.8 1976.8 1994.6 2022.3 2028.4 1023.2 1133.6 1139.5 1158.5 1180.9 18679.2 19905.5 20117.2 20209.5 20347.2 1095.7 1097.5 1162.0 1180.9 1231.7 11774.5 11806.5 11836.7 11843.2 11857.2 530286.0 536632.0 542778.0 546175.0 554551.0 62463.7 68483.7 71773.0 74959.0 78639.6 1116.8 1127.5 1141.1 1163.3 1171.7 18145.9 18302.2 18528.7 18547.3 18751.9 38500.2 38588.2 38895.8 40131.6 41048.8 52440.7 52686.2 53083.0 53108.0 53341.7 8024.0 8496.8 8576.9 8661.6 8692.2 9372.0 13252.7 13556.9 13617.5 13779.0 11339.1 11619.1 11742.4 11782.2 11926.8 11570.1 11787.2 12164.7 12254.3 12258.8 11958.6 12383.9 12541.2 12679.9 12775.6 8310.9 8315.5 8316.2 8329.5 8641.8 11705.9 12132.4 12241.6 12375.7 12753.5 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | [#3] mootools.html Cycles:180 Average:5595.06 Median:4851.29 stddev:3038.80 (62.6%) stddev-sans-first:3032.34 05:19:10 INFO - PROCESS | 15466 | Values: 1578.8 1582.5 1788.4 1881.3 1909.8 7308.3 8141.6 8154.0 8404.7 8456.1 8179.6 8265.8 8287.5 8296.6 8323.4 2345.7 2386.4 2388.2 2389.9 2392.1 2352.5 2380.5 2413.7 2415.8 2418.0 2315.8 2359.9 2378.3 2388.9 2392.7 2322.9 2323.2 2325.1 2327.8 2405.4 2348.5 2353.0 2364.4 2379.5 2379.6 8544.0 8565.5 8585.4 8635.3 8636.7 5209.5 5216.4 5257.5 5263.1 5284.6 3468.7 3518.4 3546.8 3559.1 3586.9 1246.9 1272.3 1285.7 1288.2 1318.4 11838.1 11849.8 11886.0 11903.3 11903.9 4485.1 4485.2 4535.8 4602.3 4694.0 10147.8 10163.8 10209.4 10214.6 10219.4 5303.9 5307.8 5311.5 5333.7 5337.8 4100.6 4750.8 4803.4 4879.9 4902.1 3983.3 4033.3 4062.4 4084.3 4128.4 1293.5 1295.8 1296.7 1312.9 1316.0 921.3 999.7 1038.8 1050.4 1055.0 5715.3 5897.1 5948.4 6019.0 6056.5 979.9 1050.8 1051.4 1052.8 1076.5 3920.6 4000.7 4005.5 4028.6 4073.7 10044.7 10332.5 10349.4 10386.6 10425.3 10278.6 10302.9 10432.7 10462.4 10602.7 8033.3 8152.8 8200.4 8255.5 8264.8 5759.8 5761.2 5796.2 5829.3 5837.3 8857.6 8921.4 9032.6 9139.1 9238.9 8972.5 9003.8 9047.8 9159.4 9189.8 6982.2 6990.2 7041.4 7396.1 7606.0 7747.1 7818.4 7818.9 7846.9 7873.5 7019.5 7150.9 7164.7 7231.9 7242.6 7007.2 7072.2 7074.5 7121.2 7126.5 6665.1 6677.3 6732.9 6739.4 6740.7 4822.7 4911.8 4966.8 4980.3 5051.4 5035.3 5050.5 5053.4 5105.0 5159.8 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | [#4] prototype.html Cycles:180 Average:5821.76 Median:6805.32 stddev:1842.19 (27.1%) stddev-sans-first:1800.25 05:19:10 INFO - PROCESS | 15466 | Values: 306.7 307.7 309.9 318.3 326.6 6566.3 6657.4 6720.3 6754.5 6756.9 6550.3 6573.3 6576.6 6607.6 6627.3 4707.9 4775.4 4892.7 4908.7 4910.1 4854.9 4862.1 4889.9 4908.1 4911.4 4815.1 4851.4 4855.4 4856.8 4859.2 4845.8 4882.3 4883.6 4890.3 4892.6 4184.5 4188.8 4192.6 4198.0 4205.3 6264.6 6298.2 6350.4 6388.6 6393.1 5633.3 5677.8 5684.9 5689.4 5691.9 6913.0 6944.7 6956.3 6969.5 6969.7 4651.4 4693.6 4698.4 4708.3 4717.2 7251.4 7257.6 7284.5 7313.9 7319.1 4537.2 4672.7 4675.4 4678.7 4774.2 4709.5 4729.1 4729.8 4733.2 4746.0 5594.0 5608.9 5613.6 5613.9 5613.9 6980.1 7000.1 7001.3 7009.5 7058.3 1628.9 1631.5 1643.4 1650.9 1652.2 1003.4 1029.6 1037.2 1049.7 1050.2 6800.5 6810.2 6816.4 6817.0 6820.1 7108.2 7259.7 7260.9 7262.7 7265.9 6883.5 6891.4 6921.9 6926.8 6930.8 3938.5 3977.3 3977.5 3983.3 3985.8 7595.6 7621.2 7621.4 7630.8 7631.8 7326.0 7409.3 7440.6 7450.7 7460.5 7633.2 7641.3 7642.8 7643.7 7664.6 7220.7 7285.5 7287.2 7291.6 7304.1 7190.0 7202.9 7204.5 7207.9 7218.3 7428.4 7593.4 7657.2 7658.8 7663.6 4713.2 4738.0 4763.5 4767.7 4774.6 7223.5 7263.7 7264.5 7269.3 7273.3 7018.0 7064.2 7096.0 7097.2 7102.8 6895.1 7039.0 7042.8 7050.3 7057.6 6884.7 6909.2 6923.0 6930.6 6931.7 7065.2 7066.4 7094.5 7112.8 7125.2 6870.6 6896.0 6905.4 6917.0 6945.4 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - PROCESS | 15466 | [#5] yui.html Cycles:180 Average:15711.48 Median:48210.88 stddev:17745.87 (36.8%) stddev-sans-first:17760.19 05:19:10 INFO - PROCESS | 15466 | Values: 772.3 824.1 905.0 908.1 933.4 14678.9 14755.3 14784.4 14810.2 14829.8 14310.6 14348.2 14379.1 14426.6 14426.6 758.7 892.9 907.8 914.9 915.1 907.5 908.3 912.5 917.1 917.5 970.5 975.2 977.1 977.3 979.3 967.3 968.7 969.8 971.9 978.6 718.4 720.4 721.5 721.9 723.2 14947.0 15024.4 15052.2 15190.5 15195.6 15189.4 15211.8 15283.9 15436.2 15489.7 11647.4 11701.4 11798.7 11906.5 11936.1 4065.2 4117.8 4143.1 4143.6 4173.9 54416.2 54679.0 55810.4 56174.4 56642.4 11534.7 11565.8 11623.1 11706.3 11758.1 21371.1 21426.7 21428.0 21433.7 21437.9 9135.7 9253.9 9267.0 9301.2 9307.3 5161.0 5167.3 5214.5 5274.9 5295.6 3571.1 3600.2 3611.0 3615.0 3615.3 662.2 677.3 682.1 684.1 684.2 783.5 792.4 811.9 845.5 870.1 9611.3 9638.9 9655.8 9666.0 9990.4 644.3 660.5 711.8 737.4 741.8 4419.8 4571.2 4598.3 4598.3 4629.3 59423.4 65439.0 65454.7 65756.7 65872.0 54789.7 54877.0 55193.2 55500.4 55786.7 49336.0 49487.5 49576.0 51699.2 52004.0 9382.9 9599.4 9741.4 9853.2 9968.0 38036.0 39240.6 39923.0 39961.2 40540.4 47085.8 51094.5 51583.2 51590.4 52258.2 12934.7 12938.7 13053.8 13334.3 13362.6 14397.5 14523.5 14636.5 14695.7 14704.6 12996.7 13293.9 13384.9 13539.8 13639.9 13481.2 13559.9 13837.7 13900.6 14297.5 13408.9 13730.7 13773.4 13956.6 14114.3 11158.9 11253.5 11489.8 11627.0 11671.9 11130.9 11462.9 11559.8 11595.5 11757.1 05:19:10 INFO - PROCESS | 15466 | -------- Summary: end -------- 05:19:10 INFO - PROCESS | 15466 | 05:19:10 INFO - TEST-INFO | 15466: exit 0 05:19:10 INFO - TEST-OK | dromaeo_css | took 1108562ms 05:19:10 INFO - TEST-START | kraken 05:19:10 INFO - operating with platform_type : linux_ 05:19:10 INFO - Initialising browser for kraken test... 05:19:10 INFO - TEST-INFO | started process 15708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9NonIm/profile http://localhost:37463/getInfo.html) 05:19:14 INFO - PROCESS | 15708 | 05:19:14 INFO - PROCESS | 15708 | (process:15788): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:15 INFO - PROCESS | 15708 | __metrics Screen width/height:1600/1200 05:19:15 INFO - PROCESS | 15708 | colorDepth:24 05:19:15 INFO - PROCESS | 15708 | Browser inner width/height: 1024/697 05:19:15 INFO - PROCESS | 15708 | __metrics 05:19:16 ERROR - PROCESS | 15708 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:19:17 INFO - TEST-INFO | 15708: exit 0 05:19:17 INFO - Browser initialized. 05:19:17 INFO - Running cycle 1/1 for kraken test... 05:19:17 INFO - TEST-INFO | started process 15839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9NonIm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:18 INFO - PROCESS | 15839 | 05:19:18 INFO - PROCESS | 15839 | (process:15909): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:19:28 INFO - PROCESS | 15839 | RSS: Main: 151805952 05:19:28 INFO - PROCESS | 15839 | 05:19:31 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37463/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:32 INFO - PROCESS | 15839 | RSS: Main: 156434432 05:19:32 INFO - PROCESS | 15839 | 05:19:34 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37463/tests/kraken/driver.html?testName=audio-dft) 05:19:35 INFO - PROCESS | 15839 | RSS: Main: 156696576 05:19:35 INFO - PROCESS | 15839 | 05:19:38 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37463/tests/kraken/driver.html?testName=audio-fft) 05:19:38 INFO - PROCESS | 15839 | RSS: Main: 156459008 05:19:38 INFO - PROCESS | 15839 | 05:19:41 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37463/tests/kraken/driver.html?testName=audio-oscillator) 05:19:41 INFO - PROCESS | 15839 | RSS: Main: 156229632 05:19:41 INFO - PROCESS | 15839 | 05:19:43 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37463/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:19:44 INFO - PROCESS | 15839 | RSS: Main: 156393472 05:19:44 INFO - PROCESS | 15839 | 05:19:47 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37463/tests/kraken/driver.html?testName=imaging-darkroom) 05:19:48 INFO - PROCESS | 15839 | RSS: Main: 156921856 05:19:48 INFO - PROCESS | 15839 | 05:19:51 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37463/tests/kraken/driver.html?testName=imaging-desaturate) 05:19:52 INFO - PROCESS | 15839 | RSS: Main: 156934144 05:19:52 INFO - PROCESS | 15839 | 05:19:54 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37463/tests/kraken/driver.html?testName=json-parse-financial) 05:19:55 INFO - PROCESS | 15839 | RSS: Main: 156647424 05:19:55 INFO - PROCESS | 15839 | 05:19:57 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37463/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:19:57 INFO - PROCESS | 15839 | RSS: Main: 156614656 05:19:57 INFO - PROCESS | 15839 | 05:19:59 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:00 INFO - PROCESS | 15839 | RSS: Main: 156680192 05:20:00 INFO - PROCESS | 15839 | 05:20:02 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:02 INFO - PROCESS | 15839 | RSS: Main: 156884992 05:20:02 INFO - PROCESS | 15839 | 05:20:05 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:05 INFO - PROCESS | 15839 | RSS: Main: 157532160 05:20:05 INFO - PROCESS | 15839 | 05:20:08 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:09 INFO - PROCESS | 15839 | RSS: Main: 157270016 05:20:09 INFO - PROCESS | 15839 | 05:20:10 INFO - PROCESS | 15839 | Cycle 1(1): loaded http://localhost:37463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37463/tests/kraken/driver.html?testName=ai-astar) 05:20:11 INFO - PROCESS | 15839 | RSS: Main: 158420992 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | __start_tp_report 05:20:11 INFO - PROCESS | 15839 | _x_x_mozilla_page_load 05:20:11 INFO - PROCESS | 15839 | _x_x_mozilla_page_load_details 05:20:11 INFO - PROCESS | 15839 | |i|pagename|runs| 05:20:11 INFO - PROCESS | 15839 | |0;ai-astar;108;111;104;113;113;113;102;114;112;111 05:20:11 INFO - PROCESS | 15839 | |1;audio-beat-detection;163;126;158;186;135;152;155;128;190;128 05:20:11 INFO - PROCESS | 15839 | |2;audio-dft;163;162;163;163;161;163;161;162;163;162 05:20:11 INFO - PROCESS | 15839 | |3;audio-fft;75;77;76;179;76;79;76;77;174;77 05:20:11 INFO - PROCESS | 15839 | |4;audio-oscillator;93;91;156;90;92;93;140;93;92;148 05:20:11 INFO - PROCESS | 15839 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;121;117;117 05:20:11 INFO - PROCESS | 15839 | |6;imaging-darkroom;150;150;149;150;149;152;149;149;149;148 05:20:11 INFO - PROCESS | 15839 | |7;imaging-desaturate;98;94;94;95;95;96;95;94;95;96 05:20:11 INFO - PROCESS | 15839 | |8;json-parse-financial;55;56;56;55;58;58;56;85;68;54 05:20:11 INFO - PROCESS | 15839 | |9;json-stringify-tinderbox;61;58;58;59;58;58;57;57;58;59 05:20:11 INFO - PROCESS | 15839 | |10;stanford-crypto-aes;74;74;75;73;81;74;82;73;75;76 05:20:11 INFO - PROCESS | 15839 | |11;stanford-crypto-ccm;115;115;121;121;118;118;122;118;132;129 05:20:11 INFO - PROCESS | 15839 | |12;stanford-crypto-pbkdf2;161;166;160;160;165;160;161;168;161;162 05:20:11 INFO - PROCESS | 15839 | |13;stanford-crypto-sha256-iterative;69;69;68;70;67;67;67;68;69;66 05:20:11 INFO - PROCESS | 15839 | __end_tp_report 05:20:11 INFO - PROCESS | 15839 | __start_cc_report 05:20:11 INFO - PROCESS | 15839 | _x_x_mozilla_cycle_collect,842 05:20:11 INFO - PROCESS | 15839 | __end_cc_report 05:20:11 INFO - PROCESS | 15839 | __startTimestamp1464092411086__endTimestamp 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | ------- Summary: start ------- 05:20:11 INFO - PROCESS | 15839 | Number of tests: 14 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.50 stddev:4.12 (3.7%) stddev-sans-first:4.30 05:20:11 INFO - PROCESS | 15839 | Values: 108.0 111.0 104.0 113.0 113.0 113.0 102.0 114.0 112.0 111.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:156.50 stddev:23.29 (14.9%) stddev-sans-first:24.37 05:20:11 INFO - PROCESS | 15839 | Values: 163.0 126.0 158.0 186.0 135.0 152.0 155.0 128.0 190.0 128.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 05:20:11 INFO - PROCESS | 15839 | Values: 163.0 162.0 163.0 163.0 161.0 163.0 161.0 162.0 163.0 162.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#3] audio-fft Cycles:10 Average:96.60 Median:76.50 stddev:42.14 (55.1%) stddev-sans-first:43.97 05:20:11 INFO - PROCESS | 15839 | Values: 75.0 77.0 76.0 179.0 76.0 79.0 76.0 77.0 174.0 77.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:27.33 (29.7%) stddev-sans-first:28.38 05:20:11 INFO - PROCESS | 15839 | Values: 93.0 91.0 156.0 90.0 92.0 93.0 140.0 93.0 92.0 148.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.26 (1.1%) stddev-sans-first:1.32 05:20:11 INFO - PROCESS | 15839 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 121.0 117.0 117.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#6] imaging-darkroom Cycles:10 Average:149.50 Median:149.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:20:11 INFO - PROCESS | 15839 | Values: 150.0 150.0 149.0 150.0 149.0 152.0 149.0 149.0 149.0 148.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:0.78 05:20:11 INFO - PROCESS | 15839 | Values: 98.0 94.0 94.0 95.0 95.0 96.0 95.0 94.0 95.0 96.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:57.00 stddev:9.61 (16.9%) stddev-sans-first:10.01 05:20:11 INFO - PROCESS | 15839 | Values: 55.0 56.0 56.0 55.0 58.0 58.0 56.0 85.0 68.0 54.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:1.16 (2.0%) stddev-sans-first:0.71 05:20:11 INFO - PROCESS | 15839 | Values: 61.0 58.0 58.0 59.0 58.0 58.0 57.0 57.0 58.0 59.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.00 stddev:3.20 (4.3%) stddev-sans-first:3.33 05:20:11 INFO - PROCESS | 15839 | Values: 74.0 74.0 75.0 73.0 81.0 74.0 82.0 73.0 75.0 76.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:121.00 stddev:5.63 (4.6%) stddev-sans-first:5.55 05:20:11 INFO - PROCESS | 15839 | Values: 115.0 115.0 121.0 121.0 118.0 118.0 122.0 118.0 132.0 129.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:161.50 stddev:2.88 (1.8%) stddev-sans-first:3.00 05:20:11 INFO - PROCESS | 15839 | Values: 161.0 166.0 160.0 160.0 165.0 160.0 161.0 168.0 161.0 162.0 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - PROCESS | 15839 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.27 05:20:11 INFO - PROCESS | 15839 | Values: 69.0 69.0 68.0 70.0 67.0 67.0 67.0 68.0 69.0 66.0 05:20:11 INFO - PROCESS | 15839 | -------- Summary: end -------- 05:20:11 INFO - PROCESS | 15839 | 05:20:11 INFO - TEST-INFO | 15839: exit 0 05:20:12 INFO - TEST-OK | kraken | took 61068ms 05:20:12 INFO - SUITE-END | took 1169s 05:20:12 INFO - Completed test suite (00:19:29) 05:20:12 INFO - javascript benchmark 05:20:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.09659843543, 3298.4227760141985, 3326.417876871547, 3334.333133373323, 3339.565856438664, 5470.972645136769, 5471.972640136793, 5498.202760599711, 5506.50441460269, 5528.143137813635, 5453.863653408666, 5461.399246082928, 5501.477359650837, 5517.5585953123755, 5517.613767036309, 4988.700677959325, 5016.473270306602, 5067.74661266937, 5089.51649593288, 5119.0, 4993.275974983625, 5039.672421292605, 5077.923831142536, 5079.898402031957, 5097.05704444677, 5075.0, 5182.0, 5184.274201611777, 5192.792288308463, 5236.685798852062, 5043.268726034741, 5043.949560504403, 5086.033653605803, 5105.795768169269, 5126.179811230222, 4922.212446008622, 4951.133551628451, 4982.77577509013, 5013.197888337849, 5021.297018417425, 5315.309009828737, 5417.918731219035, 5435.565154787608, 5458.6724796512335, 5493.313335833021, 5816.447437493432, 5870.471657550798, 5885.117232415172, 5888.440598143169, 5896.38088000758, 5624.268845050158, 5815.418458154193, 5931.970340148272, 5933.258342707161, 5943.3462319144855, 5536.197251398565, 5549.972250138723, 5580.693061881595, 5584.972075139598, 5586.776528938837, 5888.705564721832, 5895.941040589625, 5942.781729745392, 5952.345242023374, 5957.761689532457, 5688.63023903445, 5690.374058853523, 5780.046292361713, 5782.2194003808945, 5816.73824677882, 5845.970770146122, 5853.94146058534, 5887.793927212612, 5888.205092312483, 5893.528517718572, 5749.8562535936935, 5887.882242355215, 5898.262717160355, 5907.113932910098, 5910.7931222407005, 5818.069108942549, 5870.148828419855, 5883.735231914574, 5903.055511118287, 5915.053591425351, 4464.1071785643, 4471.441069866267, 4482.955170448319, 4486.7083639563325, 4510.571495707903, 3980.4626375439525, 3986.5016872890887, 4045.9797701011307, 4048.332025215865, 4078.775667338325, 5505.752241149158, 5685.090385538294, 5685.118806584986, 5712.457316554921, 5752.0, 5936.287645482484, 5941.732622032019, 5942.64344139353, 5947.167396564484, 5952.345242023374, 5466.453354664502, 5608.803691870765, 5684.9431505684415, 5686.857828554236, 5696.174054762119, 4936.284238785356, 4944.060628480577, 4947.703137811671, 4949.82675606352, 4977.427595826454, 6081.513478921675, 6098.298695650057, 6147.44672979434, 6156.445919867144, 6160.630362178284, 5750.712464376848, 5820.30156381237, 5898.970505147447, 5948.8215353537735, 5960.64236145824, 6081.695915204134, 6101.450869421773, 6104.816855494342, 6104.969475152773, 6118.785842495491, 5798.59409841307, 5808.07070868659, 5808.564357673107, 5817.650940943557, 5830.416958304136, 5822.737976791139, 5912.379200183918, 5966.224390829338, 6000.259924621985, 6029.668368239789, 5739.053056245672, 5769.423057694197, 5785.681787501728, 5786.132080188006, 5802.767889284381, 5695.345035320825, 5720.942790572208, 5738.770449182153, 5739.225204597493, 5748.109043098327, 5617.8033768817895, 5702.287214098238, 5721.22763426932, 5751.194832723506, 5754.5684073695475, 5795.159701843125, 5823.534117270524, 5850.678212698343, 5854.297484301911, 5903.144044113494, 5569.916451253153, 5742.138679197987, 5752.9712351437975, 5757.65454072757, 5771.192033115283], "value": 5446.0243079325965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.62301676536, 673.3838537737969, 677.1637028270088, 712.8538649576834, 727.3017902813298, 39756.2048759025, 40554.39168412476, 40583.59416405835, 40767.184656306854, 40909.0, 42429.787851060704, 42442.0, 42850.0, 42906.7854660727, 42946.570534294646, 8682.088380720028, 8912.821743565124, 8918.955405222965, 8919.73240802777, 8921.15249051339, 8722.476651400904, 8726.301895848317, 8786.516741579211, 8806.471611703286, 8808.911910880905, 9080.59137338818, 9136.58885350161, 9138.908610913872, 9149.0, 9178.219851312613, 9017.594208260643, 9061.184493395625, 9062.546872656341, 9073.047330030351, 9080.455172689626, 8954.507502087383, 9051.094890510962, 9072.8639070414, 9089.909100908972, 9096.590653420546, 42944.57055429437, 43540.129197416194, 43714.0, 43769.78115109436, 43971.34042989358, 3875.205582855508, 3990.760554366718, 4246.766427846467, 4424.80088396023, 4768.618510519184, 32641.0, 33734.15664608405, 33750.83124584386, 33764.32471350584, 34466.31067378663, 4423.469183697945, 4576.496585375606, 4594.494605593382, 4595.655325850541, 4602.424696912886, 312353.0, 313041.0, 315959.42020289984, 315988.0, 316516.0, 61070.694646526485, 61490.0, 61510.0, 61560.0, 61721.38278617156, 71050.0, 72449.0, 72623.27376726271, 72651.0, 72787.27212727805, 19439.0, 19633.803661963197, 19711.60576788456, 19712.408627740904, 19725.704114438297, 15165.620859478602, 15243.847561524464, 15270.465533706489, 15275.847241527665, 15329.46346877854, 20130.094145763476, 20189.0, 20292.492687682927, 20341.694874576893, 21116.36650900445, 8073.555954422563, 8213.95893020543, 8265.809560466481, 8297.25324720778, 8309.8338033239, 1210.2254557083475, 1212.950797560104, 1221.3404761428906, 1251.9233459225059, 1255.6421419895287, 28642.85678571594, 29190.854045729637, 29499.852500737357, 29634.0, 29701.702982969895, 1221.8839210275187, 1246.5574720974105, 1260.1242136714895, 1261.2936755416995, 1296.7341694952513, 16102.516924492284, 16125.193740313172, 16172.75740863888, 16405.753913691304, 16728.16359182036, 491643.0, 499058.0, 579197.0, 601875.0, 782757.0, 55684.44315556873, 57603.711981439825, 57649.42350576525, 57705.42294577084, 57780.422195778345, 819.1399031017527, 1364.6179069860455, 1533.9233038348038, 1536.853998870128, 1539.0457916092093, 33561.49657755184, 34099.496378819116, 34166.487502687974, 34424.48363274603, 34622.30755384828, 53294.0, 53804.730976344865, 53959.19061214006, 54166.0, 54236.186457202384, 421930.0, 422131.0, 423392.0, 423414.0, 424492.0, 30307.090787275534, 30310.84844575763, 30657.386852263277, 31023.84488077545, 31287.374252515277, 45889.770551147034, 46483.070338593716, 48228.27657585209, 50709.0, 52080.0, 43011.569884300756, 43148.56851431446, 43484.78257608692, 43493.3475997854, 43790.78104609456, 42701.786491067345, 42790.57209427866, 43088.0, 43819.123617526835, 44278.335824963295, 42439.3634095495, 43330.0, 44224.0, 44252.77873610611, 44891.326630099924, 36601.81699091594, 36606.450903237004, 37058.0, 37710.43434348432, 38133.237335253696, 28817.42365152643, 29075.0, 29182.0, 29496.705032950253, 29568.0], "value": 21131.798337456723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.9772862492563, 424.8831571317889, 425.6084402349836, 430.06031820472253, 430.3093534876523, 14693.0, 19202.519937001565, 19433.31983380582, 19849.702254466178, 19866.90066549667, 18855.622887542242, 18878.433646990612, 19145.808541914612, 19609.803901960975, 19627.509312267164, 5340.786368545263, 5885.705714714269, 5910.67491287979, 5922.111683247525, 5963.970180149115, 5740.225069615591, 5779.2775903012125, 5872.354041055481, 5875.559333050017, 5891.263592050994, 5662.065759149736, 5864.648121112726, 5884.411558844125, 5888.499477544414, 5888.735006924699, 5830.62100963436, 5856.1508581255475, 5880.647161170344, 5885.499732522762, 5899.233099697033, 5199.376074871039, 5232.607554433394, 5235.319408476912, 5265.815696450606, 5296.0, 23007.1947481839, 23625.173118940926, 23634.29097127089, 24015.519689606284, 24018.879905600534, 2653.1775149703653, 2880.5391137417914, 3075.384923015406, 3080.430120427706, 3338.7996720196866, 14447.433477500574, 14924.850751492455, 15162.620934476727, 15547.455839045691, 15813.209339532978, 2037.266584029763, 2068.9689654655194, 2127.8829664368454, 2132.808047275737, 2143.1534543855246, 70763.0, 71367.0, 71734.64132679303, 72661.63669181621, 73274.26725732727, 10986.780264394667, 10990.395528246023, 11239.381833999209, 12040.036797056215, 12270.570530031406, 15445.691086178214, 15487.225638718019, 15659.686806263811, 15670.0, 15708.60728481797, 9168.174864262248, 9199.862002069975, 9201.447913125234, 9215.769605759775, 9341.673041443653, 9377.578008989612, 9429.151376376021, 9434.0, 9565.713028609152, 9582.808343833085, 6791.558548694319, 7087.468439867031, 7098.609576473344, 7154.928450715531, 7235.0, 1974.792646772097, 1976.8122028407565, 1994.5811379610154, 2022.261874415857, 2028.4421784009514, 1023.2400271532952, 1133.5692436873935, 1139.4929256480953, 1158.5134243617701, 1180.8985184005016, 18679.159437825332, 19905.502362441053, 20117.19531218764, 20209.494762631053, 20347.186112555628, 1095.7315457712912, 1097.4635510285664, 1161.9709507262387, 1180.9291442513477, 1231.6920769807548, 11774.52901883915, 11806.527738890349, 11836.70408239801, 11843.230190037792, 11857.16999810005, 530286.0, 536632.0, 542778.0, 546175.0, 554551.0, 62463.68768156221, 68483.65758171277, 71773.0, 74959.0, 78639.60680196677, 1116.849225354583, 1127.515168477546, 1141.0985321595847, 1163.3485248261002, 1171.718787490996, 18145.90927045356, 18302.176402061672, 18528.722069168703, 18547.258109675462, 18751.90624046871, 38500.22999539937, 38588.228235435694, 38895.805520972215, 40131.59868401279, 41048.79475602603, 52440.73779631077, 52686.209706855196, 53083.0, 53108.0, 53341.6664583373, 8023.959880200561, 8496.767968644635, 8576.914230857612, 8661.61022753965, 8692.217700406994, 9371.953140234255, 13252.668683282995, 13556.864431355954, 13617.523386681418, 13779.035467517178, 11339.092872570009, 11619.070474361863, 11742.412879356169, 11782.234154779911, 11926.821097683369, 11570.132240081859, 11787.174897757075, 12164.695882603006, 12254.326012069421, 12258.75482490363, 11958.552743333017, 12383.938080309541, 12541.247525148521, 12679.873201268238, 12775.552855650008, 8310.916890831257, 8315.501069935823, 8316.168383161636, 8329.50022998622, 8641.783955401166, 11705.941470292593, 12132.393380330772, 12241.632751017483, 12375.69060773488, 12753.48986040548], "value": 9703.943006544654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1578.755292929596, 1582.4540533515938, 1788.4277031349966, 1881.2663061406063, 1909.8185672361121, 7308.269173082689, 8141.633626486808, 8154.0, 8404.747857564284, 8456.069832318448, 8179.591020448968, 8265.83468330633, 8287.544185069819, 8296.626651800669, 8323.417360784748, 2345.7185137783404, 2386.4033991502124, 2388.22382725614, 2389.916352927648, 2392.102961389479, 2352.5059737455153, 2380.5238952209543, 2413.698287714036, 2415.8429702069398, 2417.9758202418016, 2315.768423157679, 2359.917402890899, 2378.250850981935, 2388.868612226327, 2392.6530653055297, 2322.918697845576, 2323.1984965186984, 2325.104834638659, 2327.848689835164, 2405.350555350063, 2348.4598542335357, 2353.035255545218, 2364.3616223619524, 2379.4646204604, 2379.6430535419654, 8544.0, 8565.48607083577, 8585.399022068457, 8635.309175265964, 8636.697715579987, 5209.505097015777, 5216.374035115772, 5257.474252574751, 5263.078961181778, 5284.603654725873, 3468.739844511672, 3518.437050072002, 3546.7517273790845, 3559.110222444389, 3586.8923932281814, 1246.8628450870397, 1272.338384040303, 1285.6528737240892, 1288.2013151845915, 1318.3605951113702, 11838.052955763518, 11849.763004739856, 11886.04911607078, 11903.345316007617, 11903.880961190363, 4485.147821913826, 4485.192665320208, 4535.750533720611, 4602.332661764092, 4693.9765301173275, 10147.847782283272, 10163.796724065478, 10209.38743675382, 10214.642487512901, 10219.386836789816, 5303.867403314948, 5307.761150748149, 5311.468853114735, 5333.679979201261, 5337.759800808973, 4100.610442008005, 4750.8337208197545, 4803.351547541037, 4879.902401951941, 4902.068606964736, 3983.342748446532, 4033.3143365627916, 4062.431259623655, 4084.346504559256, 4128.401381799622, 1293.5472584595316, 1295.838020247469, 1296.7017585955284, 1312.9146605470805, 1315.9934200328937, 921.3320342751451, 999.695092996643, 1038.7846219922708, 1050.4432650695144, 1054.9789004219872, 5715.257016587817, 5897.085951677497, 5948.375420580864, 6019.036954087325, 6056.545759068087, 979.872616559857, 1050.7898420315967, 1051.3954476176077, 1052.847337136111, 1076.5370890516997, 3920.6471417572557, 4000.6599439047427, 4005.539362973237, 4028.597140285948, 4073.653739432122, 10044.698659040241, 10332.535035923402, 10349.379037257639, 10386.636467723745, 10425.322354047114, 10278.640247591447, 10302.948485257526, 10432.68701938943, 10462.424566648755, 10602.734931626772, 8033.277005069572, 8152.83694326122, 8200.42597018203, 8255.463394879434, 8264.793380165544, 5759.769609215585, 5761.222234998221, 5796.188533605215, 5829.271341082364, 5837.29952405714, 8857.64569417216, 8921.420107692978, 9032.638694452411, 9139.131782480654, 9238.907610924074, 8972.461652300883, 9003.774905627411, 9047.81904361896, 9159.404638698463, 9189.77025574366, 6982.197047339621, 6990.161180658353, 7041.436685065285, 7396.149442814145, 7605.961970190114, 7747.070351557849, 7818.413618978713, 7818.92181078182, 7846.921530784619, 7873.5275883447175, 7019.4735394844565, 7150.856982860418, 7164.67758950838, 7231.8553628928175, 7242.637868106679, 7007.159140903124, 7072.151341839012, 7074.504784665024, 7121.181064177686, 7126.5011449198055, 6665.133532640726, 6677.29888361715, 6732.899006514808, 6739.42714869222, 6740.730370785113, 4822.68652537584, 4911.8280860169725, 4966.751662416792, 4980.302757614009, 5051.368578927634, 5035.269885866602, 5050.49495050492, 5053.393592768891, 5105.0, 5159.793608255628], "value": 4587.915471511375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.7239484463982, 307.6754024504147, 309.8853424233033, 318.3235624298367, 326.5836059024742, 6566.343365663437, 6657.400833924946, 6720.327967203277, 6754.527183097179, 6756.898646520306, 6550.312217217195, 6573.342665733424, 6576.586034002688, 6607.570507916982, 6627.337266273383, 4707.8587642370785, 4775.403074615673, 4892.706437613754, 4908.680935739183, 4910.116179087763, 4854.859108109591, 4862.100511405383, 4889.926651100236, 4908.116539022974, 4911.361523002005, 4815.133276010317, 4851.417829860422, 4855.441624213207, 4856.781444834991, 4859.173940430118, 4845.806167753286, 4882.3408839806525, 4883.609311255091, 4890.266460030988, 4892.584130348907, 4184.518780340239, 4188.832446702128, 4192.643625291854, 4197.97901010496, 4205.285101532747, 6264.59280146789, 6298.2442106947, 6350.396712312323, 6388.616682999035, 6393.07300441438, 5633.267675202238, 5677.829665110054, 5684.8863022739315, 5689.374168841424, 5691.857703557403, 6913.0, 6944.652767361612, 6956.304369563054, 6969.512134150612, 6969.6515174241595, 4651.418572678415, 4693.577578017961, 4698.412698412699, 4708.293755936603, 4717.221658426355, 7251.419886409075, 7257.564546127249, 7284.45366597502, 7313.853722925565, 7319.085114360705, 4537.160625284333, 4672.696274742131, 4675.4155730533685, 4678.69588476748, 4774.236122220497, 4709.505501922317, 4729.1014707206205, 4729.787159577759, 4733.195356789354, 4746.0, 5594.021046316879, 5608.943910560843, 5613.578981576398, 5613.887722245614, 5613.943860561424, 6980.127484064492, 7000.124984376953, 7001.3394909933895, 7009.509334346649, 7058.2941705830035, 1628.9429869954495, 1631.4534630898545, 1643.408372985724, 1650.9009459432473, 1652.1573997261244, 1003.3578509753618, 1029.562435964712, 1037.2065369991963, 1049.7323182588543, 1050.2438244463974, 6800.455963522906, 6810.182778066664, 6816.352446517573, 6816.965915170492, 6820.079289295882, 7108.218096009435, 7259.745908893164, 7260.891086633705, 7262.709491620276, 7265.8546829063125, 6883.483738719616, 6891.414229790424, 6921.930780692129, 6926.792196234121, 6930.826729331706, 3938.5076865391825, 3977.343738283209, 3977.4829272195007, 3983.2830090583393, 3985.8206380712936, 7595.620218989028, 7621.161672216052, 7621.352185064332, 7630.809229769189, 7631.771046868603, 7326.04761381017, 7409.333160015624, 7440.590767507839, 7450.701971921171, 7460.477766556398, 7633.1985141559335, 7641.2740789624895, 7642.808929776689, 7643.69425222996, 7664.578448185292, 7220.675069621774, 7285.453590980592, 7287.161976372785, 7291.562506249642, 7304.050473438631, 7189.964050179925, 7202.927970720226, 7204.495685302189, 7207.9279207207255, 7218.27817218274, 7428.405727541675, 7593.430492713179, 7657.157712651715, 7658.770236892902, 7663.616819159131, 4713.198756211521, 4738.0, 4763.476017637988, 4767.6662633615315, 4774.594159496342, 7223.458240632079, 7263.673134708845, 7264.455165862476, 7269.3094156055095, 7273.309035641606, 7018.017477553249, 7064.222935477196, 7096.0, 7097.183823860322, 7102.786916392516, 6895.069380573447, 7038.964805175941, 7042.753503627348, 7050.294970502909, 7057.576545407292, 6884.690188941609, 6909.170899491892, 6922.965385173042, 6930.584164950119, 6931.7227310907, 7065.222825489295, 7066.4346852250665, 7094.467914906506, 7112.751053713096, 7125.18060423058, 6870.587764734132, 6896.0, 6905.413039891666, 6916.965415172892, 6945.374916257561], "value": 5189.135790053171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.2894936658274, 824.1173178547199, 904.9773755656108, 908.1100521488943, 933.3839665820556, 14678.853211467882, 14755.336009879555, 14784.408623655054, 14810.18543980082, 14829.77755333671, 14310.642233944156, 14348.210848403334, 14379.137251764902, 14426.567202983928, 14426.639334016654, 758.7458201502503, 892.9464232146059, 907.773056735816, 914.9451032938011, 915.0757734687946, 907.4645958884257, 908.27791905435, 912.4935660708304, 917.0645941140033, 917.5320586500899, 970.4565443351711, 975.1564896364664, 977.1205914676813, 977.2914636888235, 979.3438396274478, 967.3422072990434, 968.7190714692731, 969.8205831921082, 971.9368241064343, 978.5792109392958, 718.4180813541049, 720.4164626652429, 721.5346101764333, 721.8556288742272, 723.2297603052732, 14947.02844315116, 15024.399024039025, 15052.247387630574, 15190.544283671508, 15195.62010949724, 15189.392424303014, 15211.847881521155, 15283.923580382138, 15436.151011694352, 15489.683376912975, 11647.41762911851, 11701.414929253588, 11798.705032374259, 11906.523739050428, 11936.104792140624, 4065.2072845795083, 4117.794110294473, 4143.067809742814, 4143.56492568279, 4173.937390939138, 54416.18375724367, 54679.0, 55810.44189558093, 56174.43825561733, 56642.43357566413, 11534.653960381202, 11565.826512602318, 11623.12826538013, 11706.297622142698, 11758.05935525156, 21371.145154193968, 21426.678599821014, 21428.0, 21433.67849482259, 21437.892810535846, 9135.68025119131, 9253.861192082124, 9266.953665231631, 9301.162895339452, 9307.301952353466, 5161.0, 5167.328247327899, 5214.504622060898, 5274.947250527445, 5295.602829787781, 3571.0715214044535, 3600.207954250061, 3610.9638903610626, 3614.963850361463, 3615.3311637347174, 662.1954325494547, 677.2854638356482, 682.0621645237798, 684.1004079635263, 684.2473279392628, 783.5494590610422, 792.3938187286731, 811.9309858661961, 845.4631309118754, 870.1037930931151, 9611.279154063473, 9638.9036109638, 9655.845546309642, 9666.014142463435, 9990.400575965465, 644.2751904107879, 660.5178219899404, 711.7615598774365, 737.4174402222185, 741.810838236257, 4419.790284442947, 4571.245744452128, 4598.26427771555, 4598.3102534620075, 4629.259318509023, 59423.405765942654, 65439.0, 65454.67272663606, 65756.6712166436, 65872.0, 54789.726051369486, 54877.0, 55193.172102418495, 55500.44499555034, 55786.721066394406, 49336.0, 49487.505124949006, 49575.99999999928, 51699.224511632354, 52004.0, 9382.906170938477, 9599.376040557341, 9741.366811157252, 9853.205720703136, 9967.950160249442, 38036.0, 39240.6075939237, 39923.0, 39961.2007759849, 40540.3918941222, 47085.76457117692, 51094.48905511046, 51583.226251605505, 51590.41959157602, 52258.21612675889, 12934.676633084247, 12938.741225175256, 13053.804192937303, 13334.266615335862, 13362.599122026355, 14397.496087636882, 14523.491677791226, 14636.487722929647, 14695.70608587801, 14704.558863233693, 12996.740065198832, 13293.933530332286, 13384.93307533456, 13539.796903046265, 13639.868087921142, 13481.191128532319, 13559.864401356255, 13837.723245535235, 13900.582982510541, 14297.499587514387, 13408.932955335162, 13730.725385492435, 13773.380197890918, 13956.581302560939, 14114.2942852859, 11158.88841111611, 11253.549858005588, 11489.82765258505, 11627.0, 11671.941640291745, 11130.888691113309, 11462.913519468684, 11559.826602601135, 11595.478203481032, 11757.118216133653], "value": 7276.3022308916, "unit": "score"}], "name": "dromaeo_css", "value": 7605.089246920807, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 113.0, 113.0, 113.0, 102.0, 114.0, 112.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 158.0, 186.0, 135.0, 152.0, 155.0, 128.0, 190.0, 128.0], "value": 152.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 161.0, 163.0, 161.0, 162.0, 163.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 179.0, 76.0, 79.0, 76.0, 77.0, 174.0, 77.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 156.0, 90.0, 92.0, 93.0, 140.0, 93.0, 92.0, 148.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 121.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 150.0, 149.0, 152.0, 149.0, 149.0, 149.0, 148.0], "value": 149.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 58.0, 58.0, 56.0, 85.0, 68.0, 54.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 58.0, 59.0, 58.0, 58.0, 57.0, 57.0, 58.0, 59.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 73.0, 81.0, 74.0, 82.0, 73.0, 75.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 121.0, 121.0, 118.0, 118.0, 122.0, 118.0, 132.0, 129.0], "value": 120.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 160.0, 160.0, 165.0, 160.0, 161.0, 168.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 70.0, 67.0, 67.0, 67.0, 68.0, 69.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1537.6000000000001, "alertThreshold": 2.0}]} 05:20:12 INFO - Return code: 0 05:20:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:20:12 ERROR - # TBPL SUCCESS # 05:20:12 INFO - Running post-action listener: _resource_record_post_action 05:20:12 INFO - Running post-run listener: _resource_record_post_run 05:20:13 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509911040; Read time: 12; Write time: 687784 05:20:13 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 261492736; Read time: 0; Write time: 420900 05:20:13 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248418304; Read time: 12; Write time: 266884 05:20:13 INFO - Running post-run listener: _upload_blobber_files 05:20:13 INFO - Blob upload gear active. 05:20:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:20:13 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 05:20:13 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'] 05:20:13 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 05:20:13 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:14 INFO - (blobuploader) - INFO - Done attempting. 05:20:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:20:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:15 INFO - (blobuploader) - INFO - Done attempting. 05:20:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:15 INFO - Return code: 0 05:20:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:20:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31583fe42e20e453537e675f37c40b3eb7c2a54343510cfc2d8a9fb3ff785c6a23110061228104a610b017ec76a5f0b6266984310f40f66f4bed5c98da2c69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a26afe2e7d6a4003f239d7ab7e6e59db9c95ab1d94458e01b0b9817fc4983be7a43b28e0b09662cc9bfb7c6d8f66c3f988fe05a157cf72561d678b6cd063d4c3"} 05:20:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:20:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:20:15 INFO - Contents: 05:20:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31583fe42e20e453537e675f37c40b3eb7c2a54343510cfc2d8a9fb3ff785c6a23110061228104a610b017ec76a5f0b6266984310f40f66f4bed5c98da2c69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a26afe2e7d6a4003f239d7ab7e6e59db9c95ab1d94458e01b0b9817fc4983be7a43b28e0b09662cc9bfb7c6d8f66c3f988fe05a157cf72561d678b6cd063d4c3"} 05:20:15 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:15 INFO - Copying logs to upload dir... 05:20:15 INFO - mkdir: /builds/slave/test/build/upload/logs 05:20:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.203200 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-24 05:20:14.928661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 05:20:14.932517) ========= 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=fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31583fe42e20e453537e675f37c40b3eb7c2a54343510cfc2d8a9fb3ff785c6a23110061228104a610b017ec76a5f0b6266984310f40f66f4bed5c98da2c69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a26afe2e7d6a4003f239d7ab7e6e59db9c95ab1d94458e01b0b9817fc4983be7a43b28e0b09662cc9bfb7c6d8f66c3f988fe05a157cf72561d678b6cd063d4c3"} build_url:https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/SasM4Ki3R9izo83mmuyhnw/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee31583fe42e20e453537e675f37c40b3eb7c2a54343510cfc2d8a9fb3ff785c6a23110061228104a610b017ec76a5f0b6266984310f40f66f4bed5c98da2c69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a26afe2e7d6a4003f239d7ab7e6e59db9c95ab1d94458e01b0b9817fc4983be7a43b28e0b09662cc9bfb7c6d8f66c3f988fe05a157cf72561d678b6cd063d4c3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 05:20:14.964276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 05:20:14.964916) ========= 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=fa44defc139c4ba8574fe040000001db-1464091137.137284-1388782236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 05:20:15.050268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 05:20:15.050819) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 05:20:15.051313) ========= ========= Total master_lag: 0.18 =========