builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1461402373.21 results: success (0) buildid: 20160422233015 builduid: c4ed0500869142309087576063f95742 revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.205985) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.206415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.206746) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.270342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.270791) ========= 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=745a4373a2a16df560f216e000000264-1461388602.98965-1891095536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-23 02:06:13-- 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% 46.6M=0s 2016-04-23 02:06:13 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.078748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.371247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.371538) ========= 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=745a4373a2a16df560f216e000000264-1461388602.98965-1891095536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018332 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:13.425071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 02:06:13.425404) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 --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=745a4373a2a16df560f216e000000264-1461388602.98965-1891095536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-23 02:06:13,950 truncating revision to first 12 chars 2016-04-23 02:06:13,950 Setting DEBUG logging. 2016-04-23 02:06:13,950 attempt 1/10 2016-04-23 02:06:13,950 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/37f04460ddb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-23 02:06:14,874 unpacking tar archive at: fx-team-37f04460ddb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.195139 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-23 02:06:14.633834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:14.634155) ========= script_repo_revision: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:14.634590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:14.634898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-23 02:06:14.643156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-23 02:06:14.643445) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=745a4373a2a16df560f216e000000264-1461388602.98965-1891095536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:06:15 INFO - MultiFileLogger online at 20160423 02:06:15 in /builds/slave/test 02:06:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:06:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:06:15 INFO - {'append_to_log': False, 02:06:15 INFO - 'base_work_dir': '/builds/slave/test', 02:06:15 INFO - 'blob_upload_branch': 'Fx-Team', 02:06:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:06:15 INFO - 'branch': 'Fx-Team', 02:06:15 INFO - 'buildbot_json_path': 'buildprops.json', 02:06:15 INFO - 'config_files': ('talos/linux_config.py',), 02:06:15 INFO - 'default_actions': ('clobber', 02:06:15 INFO - 'read-buildbot-config', 02:06:15 INFO - 'download-and-extract', 02:06:15 INFO - 'populate-webroot', 02:06:15 INFO - 'create-virtualenv', 02:06:15 INFO - 'install', 02:06:15 INFO - 'run-tests'), 02:06:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:06:15 INFO - 'download_minidump_stackwalk': True, 02:06:15 INFO - 'download_symbols': 'ondemand', 02:06:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:06:15 INFO - 'tooltool.py': '/tools/tooltool.py', 02:06:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:06:15 INFO - '/tools/misc-python/virtualenv.py')}, 02:06:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:06:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:06:15 INFO - 'installer_path': 'installer.exe', 02:06:15 INFO - 'log_level': 'info', 02:06:15 INFO - 'log_name': 'talos', 02:06:15 INFO - 'log_to_console': True, 02:06:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:06:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:06:15 INFO - 'opt_config_files': (), 02:06:15 INFO - 'pip_index': False, 02:06:15 INFO - 'sps_profile': False, 02:06:15 INFO - 'sps_profile_interval': 0, 02:06:15 INFO - 'suite': 'dromaeojs-e10s', 02:06:15 INFO - 'system_bits': '32', 02:06:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:06:15 INFO - 'title': 'talos-linux64-ix-032', 02:06:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:06:15 INFO - 'use_talos_json': True, 02:06:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:06:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:06:15 INFO - 'work_dir': 'build'} 02:06:15 INFO - ##### 02:06:15 INFO - ##### Running clobber step. 02:06:15 INFO - ##### 02:06:15 INFO - Running pre-action listener: _resource_record_pre_action 02:06:15 INFO - Running main action method: clobber 02:06:15 INFO - rmtree: /builds/slave/test/build 02:06:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:06:15 INFO - Running post-action listener: _resource_record_post_action 02:06:15 INFO - ##### 02:06:15 INFO - ##### Running read-buildbot-config step. 02:06:15 INFO - ##### 02:06:15 INFO - Running pre-action listener: _resource_record_pre_action 02:06:15 INFO - Running main action method: read_buildbot_config 02:06:15 INFO - Using buildbot properties: 02:06:15 INFO - { 02:06:15 INFO - "project": "", 02:06:15 INFO - "product": "firefox", 02:06:15 INFO - "script_repo_revision": "production", 02:06:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:06:15 INFO - "repository": "", 02:06:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:06:15 INFO - "buildid": "20160422233015", 02:06:15 INFO - "pgo_build": "True", 02:06:15 INFO - "basedir": "/builds/slave/test", 02:06:15 INFO - "buildnumber": 685, 02:06:15 INFO - "slavename": "talos-linux64-ix-032", 02:06:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:06:15 INFO - "platform": "ubuntu64_hw", 02:06:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:06:15 INFO - "branch": "fx-team", 02:06:15 INFO - "repo_path": "integration/fx-team", 02:06:15 INFO - "revision": "37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776", 02:06:15 INFO - "stage_platform": "linux64-pgo", 02:06:15 INFO - "builduid": "c4ed0500869142309087576063f95742", 02:06:15 INFO - "slavebuilddir": "test" 02:06:15 INFO - } 02:06:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:06:15 INFO - Running post-action listener: _resource_record_post_action 02:06:15 INFO - ##### 02:06:15 INFO - ##### Running download-and-extract step. 02:06:15 INFO - ##### 02:06:15 INFO - Running pre-action listener: _resource_record_pre_action 02:06:15 INFO - Running main action method: download_and_extract 02:06:15 INFO - mkdir: /builds/slave/test/build/tests 02:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:15 INFO - https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:06:27 INFO - Downloaded 1361 bytes. 02:06:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:27 INFO - Using the following test package requirements: 02:06:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:06:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:06:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'jsshell-linux-x86_64.zip'], 02:06:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:06:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:06:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:06:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:06:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:06:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:27 INFO - https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:06:31 INFO - Downloaded 23857749 bytes. 02:06:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:06:32 INFO - Return code: 0 02:06:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:32 INFO - https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:06:39 INFO - Downloaded 23857749 bytes. 02:06:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:06:40 INFO - Return code: 0 02:06:40 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')]} 02:06:40 INFO - https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:06:41 INFO - Downloaded 10840145 bytes. 02:06:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:06:41 INFO - Return code: 0 02:06: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')]} 02:06:41 INFO - https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:06:44 INFO - Downloaded 58373324 bytes. 02:06:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:44 INFO - mkdir: /builds/slave/test/properties 02:06:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:44 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:44 INFO - Contents: 02:06:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:45 INFO - Running post-action listener: _resource_record_post_action 02:06:45 INFO - Running post-action listener: set_extra_try_arguments 02:06:45 INFO - ##### 02:06:45 INFO - ##### Running populate-webroot step. 02:06:45 INFO - ##### 02:06:45 INFO - Running pre-action listener: _resource_record_pre_action 02:06:45 INFO - Running main action method: populate_webroot 02:06:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:45 INFO - '--tppagecycles', 02:06:45 INFO - '7'], 02:06:45 INFO - 'tests': ['tsvgm']}}, 02:06:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:06:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['damp', 'tps']}, 02:06:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'tests': ['damp', 'tps']}, 02:06:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['dromaeo_dom']}, 02:06:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['a11yr', 02:06:45 INFO - 'ts_paint', 02:06:45 INFO - 'tpaint', 02:06:45 INFO - 'sessionrestore', 02:06:45 INFO - 'sessionrestore_no_auto_restore', 02:06:45 INFO - 'tabpaint']}, 02:06:45 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:45 INFO - 'ts_paint', 02:06:45 INFO - 'tpaint', 02:06:45 INFO - 'sessionrestore', 02:06:45 INFO - 'sessionrestore_no_auto_restore', 02:06:45 INFO - 'tabpaint']}, 02:06:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:06:45 INFO - 'ts_paint', 02:06:45 INFO - 'tpaint', 02:06:45 INFO - 'sessionrestore', 02:06:45 INFO - 'sessionrestore_no_auto_restore', 02:06:45 INFO - 'tabpaint']}, 02:06:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:06:45 INFO - 'ts_paint', 02:06:45 INFO - 'tpaint', 02:06:45 INFO - 'sessionrestore', 02:06:45 INFO - 'sessionrestore_no_auto_restore', 02:06:45 INFO - 'tabpaint']}, 02:06:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['a11yr', 02:06:45 INFO - 'ts_paint', 02:06:45 INFO - 'tpaint', 02:06:45 INFO - 'sessionrestore', 02:06:45 INFO - 'sessionrestore_no_auto_restore', 02:06:45 INFO - 'tabpaint']}, 02:06:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['a11yr', 02:06:45 INFO - 'ts_paint', 02:06:45 INFO - 'tpaint', 02:06:45 INFO - 'sessionrestore', 02:06:45 INFO - 'sessionrestore_no_auto_restore', 02:06:45 INFO - 'tabpaint']}, 02:06:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['tsvgx', 02:06:45 INFO - 'tsvgr_opacity', 02:06:45 INFO - 'tart', 02:06:45 INFO - 'tscrollx', 02:06:45 INFO - 'cart']}, 02:06:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:45 INFO - 'tsvgr_opacity', 02:06:45 INFO - 'tart', 02:06:45 INFO - 'tscrollx', 02:06:45 INFO - 'cart']}, 02:06:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'talos_options': ['--disable-e10s'], 02:06:45 INFO - 'tests': ['tp5o']}, 02:06:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'tests': ['tp5o']}, 02:06:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'talos_options': ['--disable-e10s', 02:06:45 INFO - '--xperf_path', 02:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:45 INFO - 'tests': ['tp5n']}, 02:06:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:45 INFO - 'talos_options': ['--xperf_path', 02:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:45 INFO - 'tests': ['tp5n']}}, 02:06:45 INFO - 'talos.zip': {'path': '', 02:06:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:45 INFO - Running post-action listener: _resource_record_post_action 02:06:45 INFO - ##### 02:06:45 INFO - ##### Running create-virtualenv step. 02:06:45 INFO - ##### 02:06:45 INFO - Running pre-action listener: _resource_record_pre_action 02:06:45 INFO - Running main action method: create_virtualenv 02:06:45 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:45 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 02:06:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:06:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:45 INFO - Using real prefix '/usr' 02:06:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:46 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:48 INFO - Installing pip.................done. 02:06:48 INFO - Return code: 0 02:06:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:06:48 INFO - Using env: {'DISPLAY': ':0', 02:06:48 INFO - 'HOME': '/home/cltbld', 02:06:48 INFO - 'LANG': 'en_US.UTF-8', 02:06:48 INFO - 'LANGUAGE': 'en_US:en', 02:06:48 INFO - 'LOGNAME': 'cltbld', 02:06:48 INFO - 'MAIL': '/var/mail/cltbld', 02:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:48 INFO - 'MOZ_NO_REMOTE': '1', 02:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:48 INFO - 'NO_EM_RESTART': '1', 02:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:48 INFO - 'PWD': '/builds/slave/test', 02:06:48 INFO - 'SHELL': '/bin/bash', 02:06:48 INFO - 'SHLVL': '1', 02:06:48 INFO - 'TERM': 'linux', 02:06:48 INFO - 'TMOUT': '86400', 02:06:48 INFO - 'USER': 'cltbld', 02:06:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:48 INFO - '_': '/tools/buildbot/bin/python'} 02:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:48 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 02:06:48 INFO - Cleaning up... 02:06:48 INFO - Return code: 0 02:06:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:06:48 INFO - Using env: {'DISPLAY': ':0', 02:06:48 INFO - 'HOME': '/home/cltbld', 02:06:48 INFO - 'LANG': 'en_US.UTF-8', 02:06:48 INFO - 'LANGUAGE': 'en_US:en', 02:06:48 INFO - 'LOGNAME': 'cltbld', 02:06:48 INFO - 'MAIL': '/var/mail/cltbld', 02:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:48 INFO - 'MOZ_NO_REMOTE': '1', 02:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:48 INFO - 'NO_EM_RESTART': '1', 02:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:48 INFO - 'PWD': '/builds/slave/test', 02:06:48 INFO - 'SHELL': '/bin/bash', 02:06:48 INFO - 'SHLVL': '1', 02:06:48 INFO - 'TERM': 'linux', 02:06:48 INFO - 'TMOUT': '86400', 02:06:48 INFO - 'USER': 'cltbld', 02:06:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:48 INFO - '_': '/tools/buildbot/bin/python'} 02:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:48 INFO - Downloading/unpacking psutil>=0.7.1 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:50 INFO - Installing collected packages: psutil 02:06:50 INFO - Running setup.py install for psutil 02:06:50 INFO - building 'psutil._psutil_linux' extension 02:06:50 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 02:06:50 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 02:06:50 INFO - building 'psutil._psutil_posix' extension 02:06:50 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 02:06:50 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 02:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:51 INFO - Successfully installed psutil 02:06:51 INFO - Cleaning up... 02:06:51 INFO - Return code: 0 02:06:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:51 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 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:06:51 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 02:06:51 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 02:06:51 INFO - Using env: {'DISPLAY': ':0', 02:06:51 INFO - 'HOME': '/home/cltbld', 02:06:51 INFO - 'LANG': 'en_US.UTF-8', 02:06:51 INFO - 'LANGUAGE': 'en_US:en', 02:06:51 INFO - 'LOGNAME': 'cltbld', 02:06:51 INFO - 'MAIL': '/var/mail/cltbld', 02:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:51 INFO - 'MOZ_NO_REMOTE': '1', 02:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:51 INFO - 'NO_EM_RESTART': '1', 02:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:51 INFO - 'PWD': '/builds/slave/test', 02:06:51 INFO - 'SHELL': '/bin/bash', 02:06:51 INFO - 'SHLVL': '1', 02:06:51 INFO - 'TERM': 'linux', 02:06:51 INFO - 'TMOUT': '86400', 02:06:51 INFO - 'USER': 'cltbld', 02:06:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:51 INFO - '_': '/tools/buildbot/bin/python'} 02:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:06:53 INFO - Installing collected packages: mozsystemmonitor 02:06:53 INFO - Running setup.py install for mozsystemmonitor 02:06:53 INFO - Successfully installed mozsystemmonitor 02:06:53 INFO - Cleaning up... 02:06:53 INFO - Return code: 0 02:06:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:53 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')]} 02:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:53 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')]} 02:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:53 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 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:06:53 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 02:06:53 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 02:06:53 INFO - Using env: {'DISPLAY': ':0', 02:06:53 INFO - 'HOME': '/home/cltbld', 02:06:53 INFO - 'LANG': 'en_US.UTF-8', 02:06:53 INFO - 'LANGUAGE': 'en_US:en', 02:06:53 INFO - 'LOGNAME': 'cltbld', 02:06:53 INFO - 'MAIL': '/var/mail/cltbld', 02:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:53 INFO - 'MOZ_NO_REMOTE': '1', 02:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:53 INFO - 'NO_EM_RESTART': '1', 02:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:53 INFO - 'PWD': '/builds/slave/test', 02:06:53 INFO - 'SHELL': '/bin/bash', 02:06:53 INFO - 'SHLVL': '1', 02:06:53 INFO - 'TERM': 'linux', 02:06:53 INFO - 'TMOUT': '86400', 02:06:53 INFO - 'USER': 'cltbld', 02:06:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:53 INFO - '_': '/tools/buildbot/bin/python'} 02:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:53 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:55 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:55 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 02:06:55 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 02:06:55 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 02:06:55 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 02:06:55 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 02:06:55 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 02:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:55 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 02:06:55 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 02:06:55 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 02:06:55 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 02:06:55 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 02:06:55 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 02:06:56 INFO - Downloading docopt-0.6.1.tar.gz 02:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:56 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:56 INFO - Running setup.py install for blobuploader 02:06:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:56 INFO - Running setup.py install for requests 02:06:56 INFO - Running setup.py install for docopt 02:06:56 INFO - Successfully installed blobuploader requests docopt 02:06:56 INFO - Cleaning up... 02:06:56 INFO - Return code: 0 02:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:56 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')]} 02:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:56 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')]} 02:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:56 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 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:06:56 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 02:06:56 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 02:06:56 INFO - Using env: {'DISPLAY': ':0', 02:06:56 INFO - 'HOME': '/home/cltbld', 02:06:56 INFO - 'LANG': 'en_US.UTF-8', 02:06:56 INFO - 'LANGUAGE': 'en_US:en', 02:06:56 INFO - 'LOGNAME': 'cltbld', 02:06:56 INFO - 'MAIL': '/var/mail/cltbld', 02:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:56 INFO - 'MOZ_NO_REMOTE': '1', 02:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:56 INFO - 'NO_EM_RESTART': '1', 02:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:56 INFO - 'PWD': '/builds/slave/test', 02:06:56 INFO - 'SHELL': '/bin/bash', 02:06:56 INFO - 'SHLVL': '1', 02:06:56 INFO - 'TERM': 'linux', 02:06:56 INFO - 'TMOUT': '86400', 02:06:56 INFO - 'USER': 'cltbld', 02:06:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:56 INFO - '_': '/tools/buildbot/bin/python'} 02:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:57 INFO - Running setup.py (path:/tmp/pip-SVAjur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:57 INFO - Running setup.py (path:/tmp/pip-TT_yX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 INFO - Running setup.py (path:/tmp/pip-Jx18OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 INFO - Running setup.py (path:/tmp/pip-z4SK3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:57 INFO - Running setup.py (path:/tmp/pip-NsWIc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:57 INFO - Running setup.py (path:/tmp/pip-cJDzkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:57 INFO - Running setup.py (path:/tmp/pip-KhhQ2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:57 INFO - Running setup.py (path:/tmp/pip-OGpdFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:57 INFO - Running setup.py (path:/tmp/pip-nFB0zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:57 INFO - Running setup.py (path:/tmp/pip-T8PLMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:57 INFO - Running setup.py (path:/tmp/pip-JhmgCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:57 INFO - Running setup.py (path:/tmp/pip-dLDtcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:57 INFO - Running setup.py (path:/tmp/pip-3KSNsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:57 INFO - Running setup.py (path:/tmp/pip-opM_fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 INFO - Running setup.py (path:/tmp/pip-7k7eCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:58 INFO - Running setup.py (path:/tmp/pip-jCKpXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:58 INFO - Running setup.py (path:/tmp/pip-viUlsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:58 INFO - Running setup.py install for manifestparser 02:06:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:58 INFO - Running setup.py install for mozcrash 02:06:58 INFO - Running setup.py install for mozdebug 02:06:58 INFO - Running setup.py install for mozdevice 02:06:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:58 INFO - Running setup.py install for mozfile 02:06:58 INFO - Running setup.py install for mozhttpd 02:06:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:58 INFO - Running setup.py install for mozinfo 02:06:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:58 INFO - Running setup.py install for mozInstall 02:06:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozleak 02:06:59 INFO - Running setup.py install for mozlog 02:06:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for moznetwork 02:06:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozprocess 02:06:59 INFO - Running setup.py install for mozprofile 02:06:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozrunner 02:06:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Running setup.py install for mozscreenshot 02:06:59 INFO - Running setup.py install for moztest 02:06:59 INFO - Running setup.py install for mozversion 02:06:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:59 INFO - Cleaning up... 02:07:00 INFO - Return code: 0 02:07:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:07:00 INFO - Using env: {'DISPLAY': ':0', 02:07:00 INFO - 'HOME': '/home/cltbld', 02:07:00 INFO - 'LANG': 'en_US.UTF-8', 02:07:00 INFO - 'LANGUAGE': 'en_US:en', 02:07:00 INFO - 'LOGNAME': 'cltbld', 02:07:00 INFO - 'MAIL': '/var/mail/cltbld', 02:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:00 INFO - 'MOZ_NO_REMOTE': '1', 02:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:00 INFO - 'NO_EM_RESTART': '1', 02:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:00 INFO - 'PWD': '/builds/slave/test', 02:07:00 INFO - 'SHELL': '/bin/bash', 02:07:00 INFO - 'SHLVL': '1', 02:07:00 INFO - 'TERM': 'linux', 02:07:00 INFO - 'TMOUT': '86400', 02:07:00 INFO - 'USER': 'cltbld', 02:07:00 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:00 INFO - '_': '/tools/buildbot/bin/python'} 02:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:00 INFO - Running setup.py (path:/tmp/pip-YdBPEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:00 INFO - Running setup.py (path:/tmp/pip-uiNkwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:00 INFO - Running setup.py (path:/tmp/pip-Sk4x6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:00 INFO - Running setup.py (path:/tmp/pip-BGSqlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:00 INFO - Running setup.py (path:/tmp/pip-wkA4Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:00 INFO - Running setup.py (path:/tmp/pip-3HXgOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:00 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)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:00 INFO - Running setup.py (path:/tmp/pip-G30x8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:00 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)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:00 INFO - Running setup.py (path:/tmp/pip-LODKFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:00 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)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:00 INFO - Running setup.py (path:/tmp/pip-gfEf_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:00 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)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:00 INFO - Running setup.py (path:/tmp/pip-v72Uhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:00 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)) 02:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:00 INFO - Running setup.py (path:/tmp/pip-mUY8Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:01 INFO - Running setup.py (path:/tmp/pip-h0R0Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:01 INFO - Running setup.py (path:/tmp/pip-NQu8N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:01 INFO - Running setup.py (path:/tmp/pip-Ar1w4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:01 INFO - Running setup.py (path:/tmp/pip-DQSO7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:01 INFO - Running setup.py (path:/tmp/pip-F6gNvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:07:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:01 INFO - Running setup.py (path:/tmp/pip-0QliIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:07:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:03 INFO - Downloading blessings-1.6.tar.gz 02:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:03 INFO - Installing collected packages: blessings 02:07:03 INFO - Running setup.py install for blessings 02:07:03 INFO - Successfully installed blessings 02:07:03 INFO - Cleaning up... 02:07:03 INFO - Return code: 0 02:07:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:03 INFO - Reading from file tmpfile_stdout 02:07:03 INFO - Current package versions: 02:07:03 INFO - argparse == 1.2.1 02:07:03 INFO - blessings == 1.6 02:07:03 INFO - blobuploader == 1.2.4 02:07:03 INFO - docopt == 0.6.1 02:07:03 INFO - manifestparser == 1.1 02:07:03 INFO - mozInstall == 1.12 02:07:03 INFO - mozcrash == 0.17 02:07:03 INFO - mozdebug == 0.1 02:07:03 INFO - mozdevice == 0.48 02:07:03 INFO - mozfile == 1.2 02:07:03 INFO - mozhttpd == 0.7 02:07:03 INFO - mozinfo == 0.9 02:07:03 INFO - mozleak == 0.1 02:07:03 INFO - mozlog == 3.1 02:07:03 INFO - moznetwork == 0.27 02:07:03 INFO - mozprocess == 0.22 02:07:03 INFO - mozprofile == 0.28 02:07:03 INFO - mozrunner == 6.11 02:07:03 INFO - mozscreenshot == 0.1 02:07:03 INFO - mozsystemmonitor == 0.0 02:07:03 INFO - moztest == 0.7 02:07:03 INFO - mozversion == 1.4 02:07:03 INFO - psutil == 3.1.1 02:07:03 INFO - requests == 1.2.3 02:07:03 INFO - wsgiref == 0.1.2 02:07:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:07:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:07:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:07:03 INFO - Using env: {'DISPLAY': ':0', 02:07:03 INFO - 'HOME': '/home/cltbld', 02:07:03 INFO - 'LANG': 'en_US.UTF-8', 02:07:03 INFO - 'LANGUAGE': 'en_US:en', 02:07:03 INFO - 'LOGNAME': 'cltbld', 02:07:03 INFO - 'MAIL': '/var/mail/cltbld', 02:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:03 INFO - 'MOZ_NO_REMOTE': '1', 02:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:03 INFO - 'NO_EM_RESTART': '1', 02:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:03 INFO - 'PWD': '/builds/slave/test', 02:07:03 INFO - 'SHELL': '/bin/bash', 02:07:03 INFO - 'SHLVL': '1', 02:07:03 INFO - 'TERM': 'linux', 02:07:03 INFO - 'TMOUT': '86400', 02:07:03 INFO - 'USER': 'cltbld', 02:07:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:03 INFO - '_': '/tools/buildbot/bin/python'} 02:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:07:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:07:04 INFO - Cleaning up... 02:07:04 INFO - Return code: 0 02:07:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:07:04 INFO - Using env: {'DISPLAY': ':0', 02:07:04 INFO - 'HOME': '/home/cltbld', 02:07:04 INFO - 'LANG': 'en_US.UTF-8', 02:07:04 INFO - 'LANGUAGE': 'en_US:en', 02:07:04 INFO - 'LOGNAME': 'cltbld', 02:07:04 INFO - 'MAIL': '/var/mail/cltbld', 02:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:04 INFO - 'MOZ_NO_REMOTE': '1', 02:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:04 INFO - 'NO_EM_RESTART': '1', 02:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:04 INFO - 'PWD': '/builds/slave/test', 02:07:04 INFO - 'SHELL': '/bin/bash', 02:07:04 INFO - 'SHLVL': '1', 02:07:04 INFO - 'TERM': 'linux', 02:07:04 INFO - 'TMOUT': '86400', 02:07:04 INFO - 'USER': 'cltbld', 02:07:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:04 INFO - '_': '/tools/buildbot/bin/python'} 02:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:04 INFO - Downloading/unpacking jsonschema 02:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:06 INFO - Downloading/unpacking functools32 (from jsonschema) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:06 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:06 INFO - warning: no files found matching '*.txt' 02:07:06 INFO - no previously-included directories found matching 'build' 02:07:06 INFO - no previously-included directories found matching 'dist' 02:07:06 INFO - no previously-included directories found matching '.git*' 02:07:06 INFO - Installing collected packages: jsonschema, functools32 02:07:06 INFO - Running setup.py install for functools32 02:07:06 INFO - warning: no files found matching '*.txt' 02:07:06 INFO - no previously-included directories found matching 'build' 02:07:06 INFO - no previously-included directories found matching 'dist' 02:07:06 INFO - no previously-included directories found matching '.git*' 02:07:06 INFO - Successfully installed jsonschema functools32 02:07:06 INFO - Cleaning up... 02:07:06 INFO - Return code: 0 02:07:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:07: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')]} 02:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07: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')]} 02:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f273b668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x182a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, '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': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', '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 02:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:07:06 INFO - Using env: {'DISPLAY': ':0', 02:07:06 INFO - 'HOME': '/home/cltbld', 02:07:06 INFO - 'LANG': 'en_US.UTF-8', 02:07:06 INFO - 'LANGUAGE': 'en_US:en', 02:07:06 INFO - 'LOGNAME': 'cltbld', 02:07:06 INFO - 'MAIL': '/var/mail/cltbld', 02:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:06 INFO - 'MOZ_NO_REMOTE': '1', 02:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:06 INFO - 'NO_EM_RESTART': '1', 02:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:06 INFO - 'PWD': '/builds/slave/test', 02:07:06 INFO - 'SHELL': '/bin/bash', 02:07:06 INFO - 'SHLVL': '1', 02:07:06 INFO - 'TERM': 'linux', 02:07:06 INFO - 'TMOUT': '86400', 02:07:06 INFO - 'USER': 'cltbld', 02:07:06 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:06 INFO - '_': '/tools/buildbot/bin/python'} 02:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:06 INFO - Downloading/unpacking flake8 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:07:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:07:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07: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 02:07:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:09 INFO - no previously-included directories found matching 'docs/_build' 02:07:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:07:09 INFO - Running setup.py install for pep8 02:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:09 INFO - no previously-included directories found matching 'docs/_build' 02:07:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:07:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:07:09 INFO - Cleaning up... 02:07:09 INFO - Return code: 0 02:07:09 INFO - Running post-action listener: _resource_record_post_action 02:07:09 INFO - Running post-action listener: _start_resource_monitoring 02:07:09 INFO - Starting resource monitoring. 02:07:09 INFO - ##### 02:07:09 INFO - ##### Running install step. 02:07:09 INFO - ##### 02:07:09 INFO - Running pre-action listener: _resource_record_pre_action 02:07:09 INFO - Running main action method: install 02:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:09 INFO - Reading from file tmpfile_stdout 02:07:09 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:09 INFO - Reading from file tmpfile_stdout 02:07:09 INFO - Output received: 02:07:09 INFO - Usage: mozinstall [options] installer 02:07:09 INFO - Options: 02:07:09 INFO - -h, --help show this help message and exit 02:07:09 INFO - -d DEST, --destination=DEST 02:07:09 INFO - Directory to install application into. [default: 02:07:09 INFO - "/builds/slave/test"] 02:07:09 INFO - --app=APP Application being installed. [default: firefox] 02:07:09 INFO - mkdir: /builds/slave/test/build/application 02:07:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:07:26 INFO - Reading from file tmpfile_stdout 02:07:26 INFO - Output received: 02:07:26 INFO - /builds/slave/test/build/application/firefox/firefox 02:07:26 INFO - Running post-action listener: _resource_record_post_action 02:07:26 INFO - ##### 02:07:26 INFO - ##### Running run-tests step. 02:07:26 INFO - ##### 02:07:26 INFO - Running pre-action listener: _resource_record_pre_action 02:07:26 INFO - Running main action method: run_tests 02:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:26 INFO - Python 2.7.3 02:07:26 INFO - Return code: 0 02:07:26 INFO - grabbing minidump binary from tooltool 02:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:26 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 0x1984410>, '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 0x1985310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19857a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:26 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 02:07:26 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 02:07:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:26 INFO - Return code: 0 02:07:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:07:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:07:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:07:27 INFO - Return code: 0 02:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 02:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 02:07:27 INFO - Using env: {'DISPLAY': ':0', 02:07:27 INFO - 'HOME': '/home/cltbld', 02:07:27 INFO - 'LANG': 'en_US.UTF-8', 02:07:27 INFO - 'LANGUAGE': 'en_US:en', 02:07:27 INFO - 'LOGNAME': 'cltbld', 02:07:27 INFO - 'MAIL': '/var/mail/cltbld', 02:07:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:27 INFO - 'MOZ_NO_REMOTE': '1', 02:07:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:27 INFO - 'NO_EM_RESTART': '1', 02:07:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:27 INFO - 'PWD': '/builds/slave/test', 02:07:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:27 INFO - 'SHELL': '/bin/bash', 02:07:27 INFO - 'SHLVL': '1', 02:07:27 INFO - 'TERM': 'linux', 02:07:27 INFO - 'TMOUT': '86400', 02:07:27 INFO - 'USER': 'cltbld', 02:07:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1461388602.98965-1891095536', 02:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:27 INFO - '_': '/tools/buildbot/bin/python'} 02:07:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 02:07:27 INFO - mozversion application_buildid: 20160422233015 02:07:27 INFO - mozversion application_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 02:07:27 INFO - mozversion application_display_name: Nightly 02:07:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:27 INFO - mozversion application_name: Firefox 02:07:27 INFO - mozversion application_remotingname: firefox 02:07:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:07:27 INFO - mozversion application_vendor: Mozilla 02:07:27 INFO - mozversion application_version: 48.0a1 02:07:27 INFO - mozversion platform_buildid: 20160422233015 02:07:27 INFO - mozversion platform_changeset: 37f04460ddb76d6ef4e7c32a8a6b2fbc44cb8776 02:07:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:07:27 INFO - mozversion platform_version: 48.0a1 02:07:27 INFO - using testdate: 1461402447 02:07:27 INFO - actual date: 1461402447 02:07:27 INFO - starting webserver on 'localhost:59954' 02:07:27 INFO - SUITE-START | Running 2 tests 02:07:27 INFO - TEST-START | dromaeo_css 02:07:27 INFO - operating with platform_type : linux_ 02:07:27 INFO - Initialising browser for dromaeo_css test... 02:07:27 INFO - TEST-INFO | started process 31412 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAu23C0/profile http://localhost:59954/getInfo.html) 02:07:33 INFO - PROCESS | 31412 | 02:07:33 INFO - PROCESS | 31412 | (process:31480): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:07:34 INFO - PROCESS | 31412 | __metrics Screen width/height:1600/1200 02:07:34 INFO - PROCESS | 31412 | colorDepth:24 02:07:34 INFO - PROCESS | 31412 | Browser inner width/height: 1024/697 02:07:34 INFO - PROCESS | 31412 | __metrics 02:07:34 ERROR - PROCESS | 31412 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:07:35 INFO - TEST-INFO | 31412: exit 0 02:07:35 INFO - Browser initialized. 02:07:35 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:35 INFO - TEST-INFO | started process 31531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAu23C0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:37 INFO - PROCESS | 31531 | 02:07:37 INFO - PROCESS | 31531 | (process:31592): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:07:47 INFO - PROCESS | 31531 | RSS: Main: 164622336 02:07:47 INFO - PROCESS | 31531 | 02:08:37 INFO - PROCESS | 31531 | 1461402517224 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] 02:10:44 INFO - PROCESS | 31531 | Cycle 1(1): loaded http://localhost:59954/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59954/tests/dromaeo/cssquery-ext.html) 02:10:45 INFO - PROCESS | 31531 | RSS: Main: 169586688 02:10:45 INFO - PROCESS | 31531 | 02:13:47 INFO - PROCESS | 31531 | Cycle 1(1): loaded http://localhost:59954/tests/dromaeo/cssquery-ext.html (next: http://localhost:59954/tests/dromaeo/cssquery-jquery.html) 02:13:48 INFO - PROCESS | 31531 | RSS: Main: 167129088 02:13:48 INFO - PROCESS | 31531 | 02:16:49 INFO - PROCESS | 31531 | Cycle 1(1): loaded http://localhost:59954/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59954/tests/dromaeo/cssquery-mootools.html) 02:16:50 INFO - PROCESS | 31531 | RSS: Main: 167780352 02:16:50 INFO - PROCESS | 31531 | 02:19:52 INFO - PROCESS | 31531 | Cycle 1(1): loaded http://localhost:59954/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59954/tests/dromaeo/cssquery-prototype.html) 02:19:52 INFO - PROCESS | 31531 | RSS: Main: 165363712 02:19:52 INFO - PROCESS | 31531 | 02:22:55 INFO - PROCESS | 31531 | Cycle 1(1): loaded http://localhost:59954/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59954/tests/dromaeo/cssquery-yui.html) 02:22:55 INFO - PROCESS | 31531 | RSS: Main: 166838272 02:22:55 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | Cycle 1(1): loaded http://localhost:59954/tests/dromaeo/cssquery-yui.html (next: http://localhost:59954/tests/dromaeo/cssquery-dojo.html) 02:25:58 INFO - PROCESS | 31531 | RSS: Main: 168484864 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | __start_tp_report 02:25:58 INFO - PROCESS | 31531 | _x_x_mozilla_page_load 02:25:58 INFO - PROCESS | 31531 | _x_x_mozilla_page_load_details 02:25:58 INFO - PROCESS | 31531 | |i|pagename|runs| 02:25:58 INFO - PROCESS | 31531 | |0;dojo.html;3130.0609817054883;3166.097662166282;3194.313222657131;3214.1000519854447;3216.40496508146;5328.866778330544;5329.706866122362;5338.199270109486;5358.41057483677;5405.54052905503;5283.762230699618;5291.576673866081;5377.059014672436;5431.049566325897;5434.429384914576;4808.7595620218935;4835.516448355154;4877.341558889558;4903.338049363326;4933.7533123343865;4784.808607655707;4886.584640305578;4949.010197960404;4953.826616068438;4976.4525902150735;4823.20417131173;4832.081904438145;4854.17479028566;4887.633427492934;4905.96974635327;4862.173430516786;4896.192128298862;4902.362692849907;4921.990991846663;4935.506449355072;4855.562999330042;4864.6108311335365;4864.756762161913;4872.756362181912;4891.584215341701;5060.645754797166;5291.550218231417;5361.544268737162;5362.731863406814;5378.542823859977;5702.971485142589;5746.224259724925;5756.079027355645;5760.8271751847515;5781.508571771405;5623.437656234385;5761.539076873882;5790;5791.82624521265;5806.071028635441;5276.076686579833;5295.814646487354;5307.495787900143;5321.281626980347;5349.43830897754;5763.510101641407;5766.769329226784;5801.738921748447;5808.912866307009;5810.941890581124;5448.727563621803;5551.361593416808;5598.076317407664;5599.384067752544;5626.677730733274;5694.316681998187;5695.345035320991;5699.316082070178;5700.25896633435;5764.423557644202;5601.047821870292;5622.044252477089;5659.26429564154;5668.319801623831;5674.744636491368;5684.857878553069;5687.630304030225;5693.5160511357;5719.914201286984;5742.3396309424115;4277.615014648696;4323.956760432356;4324.221640104748;4327.480702315679;4369.43197384338;3803.980980095082;3859.749116307431;3898.9610103899167;3919.1573811630637;3939.7045221608496;5405.621606487508;5413.918791218135;5427.9185812212845;5432.212329212242;5455.099908515051;5645.125005624052;5668.829935101953;5676.7161641918565;5684.005299072645;5700.315962084576;5346.304980352607;5425.972870135624;5458.536024437888;5498.120300751861;5518.392976772552;4843.660943733905;4868.41579010521;4876;4898.069366820293;4899.093667671421;5835.824925252249;5888.234529511136;5888.293404791367;5891.764329426775;5897.262842144732;5585.162225666182;5655.7454914528125;5728.398518155534;5747.827565173052;5750.7987220447085;5896.145058966512;5899.056151015817;5900.262467191601;5902.2327097477055;5907.881842363043;5630.915536266877;5638.802641907678;5643;5646.632968857011;5651.491365777099;5651.6043876928225;5728.971355143198;5780.248567686174;5794.217780599565;5838.620489668158;5496.148097044965;5533.474319939599;5541.196526503554;5543.9168412474655;5552.472515111058;5514.889702206014;5521.643171017752;5524.309461317335;5542.7782888685615;5544.168374743659;5333.493318134926;5464.1257398816;5468.644538105011;5501.202325662676;5507.779688812563;5550.222968784293;5552.305961754781;5599.384067752462;5672.234248376416;5673.631213971079;5492.368377636463;5494.725263736877;5496.615236933376;5502.724863756876;5508.394076651485 02:25:58 INFO - PROCESS | 31531 | |1;ext.html;641.147274125413;645.0936434309795;651.7555916531302;675.2066322071564;742.6954948471127;34665.82667086664;35603;35615.64384356156;35628.99999999997;35629.2874142517;35312.293754124905;35999;36003.639963600355;36075.278494430095;36121.63878361216;8101.513909165455;8283.461574997636;8298.294644955186;8310.459820111704;8317.958410207972;8592.656293748243;8695.39132260739;8712.695055673054;8719.302455803552;8722.825543489127;8706.390552661316;8786.384953053288;8802;8813.779655508599;8821.382503224777;8619.396642235077;8627.525486098262;8641.827163456726;8680.956595217047;8730.694425695103;8334.541600211985;8411.747647570583;8450.366222533274;8456.450330728483;8469.534175620338;31579.21051973696;36910.81544592287;36911.63088369109;37407.06482337936;37480.25039499222;3099.8450077496036;3370.0563842124243;3414.607320158164;4072.8574499892657;4122.031322639177;27153;27388.863055684793;27595.448091038066;27723.584146237823;27849;3507.228409749851;3620.2397496525496;3674.0998455378335;3676.7977761223124;3909.3940439231965;204627;205731;206864;208906;209072;34653.30693386118;35654.28691426157;35716.285674286366;35845;51692.48307516952;33941.490877636854;33958.32083358319;34116.829415852764;34260.65739342625;34266.65733342685;13256.867431325563;13379;13390.464381424828;13398.665033374049;13451.394687239097;12169.087318450975;12395.62813115608;12403.379831008413;12416.255024698547;12607.936960315139;8546.273566746897;8557.673560598118;8593.44142630727;8630.654773808978;8642.135786421308;3273.885414010498;3339.899803005865;3343.6656334366367;3356;3387.593488781362;1133.4502766158407;1235.6478403655094;1249.4315086635559;1258.5532136091738;1261.880121388485;29179.41641167165;29674;30051;30387.848060759556;30484.390312194075;1130.6099395708468;1207.0445877678042;1227.5642147037672;1246.1526162209602;1250.6435665835193;16200.351985920666;16320.75518867218;16403.507894763177;16449.342026319053;16759.748603770953;456734;466672;467993;470709;472560;53446.73276633592;54040.729796350766;54491;54503.72748136234;56291.71854140703;1336.171573624359;1339.1429485129524;1396.406527225925;1421.3319739722315;1422.1253928833694;29930;29987.400251995274;30250.09249722512;30342.696573033987;30356.54465183068;49774;49777.751111244215;50469.24296135634;50539;50590.49409505858;411426;412888;412957;414847;415459;27898.16305510838;28435;28665.42669146647;36616.45075323819;37668.62331376761;41392;41422.378664319454;41547.37678934879;41584.792076039426;42679.78660106679;38221;39145.6085439142;39289.60710392974;39795;40437.79781101076;38672.613273866904;39384.40923386209;39447.408288876264;40089.39865902072;40239.1952160961;34153.48769768505;39434;40763.1847363057;40810.18379632331;42056;34367;34665.306693866485;34678.479822802175;35232.47151292784;35381.469277960336;26738.7326126744;27446.86276568684;27466.313342166606;27606;27783.30541736473 02:25:58 INFO - PROCESS | 31531 | |2;jquery.html;399.67825900150376;402.633603420887;403.95556488786247;404.88460788675224;406.6746602717825;13656.658583535416;17995.820041799594;18347.08264586772;18643.1610577524;18735.906320468377;17435.82564174358;17680.82319176808;18074.186661600226;18169.454916352497;18282.542936426562;5414.702191379492;5483.506484416402;5643.576731745115;5661.811019685871;5688.687122208277;5516.393196748354;5590.18942253373;5621.128725047624;5655.123455864347;5656.264685590888;5377.623566350357;5560.916586251209;5577.107662773957;5621.241132447129;5623.437656234364;5618.15727640853;5626.578006649477;5641.915371269413;5646.18130371096;5663.660180389149;4803.135435621587;4999.100161970844;5026.723530205837;5027.824026159104;5038.067957427887;22740.65889011666;23136.4215894604;23574.29277121672;23947.84469397745;24093;2411.9397015074765;2441.5849305617908;2513.8743062846966;2516.937076573082;2802.7757779377603;14032.92983535086;14264.429422823074;14299.499517516837;14311.856881431157;14820.258987050604;1984.573316736894;1985.106701984113;2010.2863483463307;2024.2813801100692;2048.805363490466;56063.43936560664;63960.68019659918;68864.9999999995;80771;83393.58303208445;10155;10180.490975451197;10285.177185825116;10293.382397056052;10589.205809564313;14285.64285892861;14326.856731432761;14395;14434;14435.133891966305;8102.918970810334;8406.327493800482;8494.235518803214;8524.8721269181;8600.354973377021;8236.299914507214;8250.46371985831;8321.04308004575;8383.874241886377;8387.874181887155;6412.23053233615;6595.637239951753;6645.368689974444;6656;6699.9665001674675;1907.122723547156;1931.2371613212702;1941.6116776644728;1969.399333203358;1972.9013549322476;941.651588912107;988.851672249154;1031.8245898197324;1040.427764729411;1062.8405739139191;19176.71234931477;19314.227430902607;19428.417147485598;19630.509237269183;20092.19631214735;1028.5371582787625;1028.88682244953;1047.4186826311318;1070.5557193764657;1097.8737445193744;10860.891391086147;11202.775944481065;11340.546378144782;11434.771304574027;11474.541018359172;479084;484868;491271;493497;495639;77435.22564774392;77816;78388.60805695935;79903;82164.17835821684;1048.2662136504478;1066.3548553125402;1073.2433634287809;1074.5272080284649;1084.2789544952675;16068.35726570924;16134.435294764628;16166.838331616533;16319.918400407922;16383.67232655364;35761.821190893876;35796.821015895795;36513;36810.26379472342;37363.813180933925;48286;49628.25557616711;50253.24620130774;50360;50935.23597145972;8097.149799270992;8110.878336824834;8242.216989386;8251.752447426346;8307.958460207661;10948.45257737126;11598.710032248924;11863.169578129793;12075.818862716891;12310.692232694255;11505.48225329879;11702;11713.941430292794;11912.940435297767;11968.521259149536;11224.7755044897;11314.321140731583;11357.318560886373;11416.94291528537;11440.256383335056;11256.155788316073;11433.828492572784;12005;12087.456064476944;12282.324472154118;8209.425340226127;8304.169583041648;8407.152517504426;8434.831303373776;8496.872546911925;10737.946310268399;11172.106231501299;11456.770864582495;11508.309501429942;12230.104642873195 02:25:58 INFO - PROCESS | 31531 | |3;mootools.html;1381.5440904501513;1459.656980609557;1508.8340282568915;1683.1163639089484;1709.0514764305813;6843.965780171105;7629.2752188542;8011.238932301437;8274.379421543379;8308.62611182496;7612.61936903154;7697.692092316314;7698.422618303635;7709.922900770991;7717.1896950820055;2272.9090836366527;2308.8730119843403;2313.664518644804;2316.8262380321457;2321.3384185507134;2230.397792595998;2248.168177774218;2254.921077762279;2267.5918334699745;2276.5333106713165;2258.9322320330416;2265.4109931417784;2283.954320913581;2294.0823670531754;2297.9770202298014;2202.427368884086;2211.148707747521;2241.4620491082187;2246.180144247346;2252.549490101986;2197.7362716474127;2223.8776867272295;2225.499262665903;2228.119892642397;2244.124791331382;7820.257075577811;7829.843403131906;7864.4888082274465;7868.685252589889;7885.684572617089;4935.259711043336;5126.872088140603;5150.510701483353;5166.844994650167;5173.120569503156;3162.446571849917;3170.429322721909;3226.6612005739294;3258.3809076275434;3297.5383446317533;972.0668158567784;982.3123813330698;987.2151639446586;997.3616885193481;1004.5379125602232;11130.053945414731;11206;11207.775844483147;11259.718507037389;11316.547338106466;4355.934660980088;4441.733495990251;4525.162844873709;4603.102395033004;4615.399998000238;9640.276979226586;9643.855342169873;9644.855327170098;9647.517624118766;9647.758806029766;5018.673786203885;5030.572401345927;5041.445441001487;5051.494850514992;5060.7216603086445;4211.136716973013;4577.679562430598;4624.468186158568;4646.697964632288;4727.030958653468;3723.31118743028;3729.589745128034;3791.1469919267943;3811.19964807388;3813.9427908581392;1220.9450574724158;1225.503671013241;1229.0843321725372;1240.9875901241053;1253.1040306180942;962.8603852441497;965.7971825916495;973.6251543155936;984.6455276100598;990.7424069741919;5258.842234732964;5409.513143817076;5446.809361672402;5586.357568879631;5880.970595146997;946.621351459408;975.2880397309862;1000.9699709008742;1015.8553103338362;1031.4584842957506;4087.8773636790943;4105.7331273467125;4113.25961326964;4126.09225970286;4175;9988.850167247498;10268.794624107475;10295.3822770634;10359.22305827066;10359.430231337348;10169;10222.846657300146;10231.539580718736;10247.846282305622;10271.537780799881;7198.460115491359;7508;7536.359409450258;7551.244875512514;7587.544747315179;5667.121596152603;5792.797252096157;5824.796132135355;5840.766369345179;5962.07587823888;9021.774455638662;9073.31950103758;9184.770380740267;9188.724338269863;9302.767430814283;9014.909850901407;9201.76995575116;9392.295577831826;9660.420374777535;9680.370775899544;6882.931170688229;6933.168019837652;7063.328983746535;7319.2314806944505;7328.560286382621;7896.289333959971;7913.208679132041;7953.721619743281;7976.760697179094;8027.799305017188;6951.7914462566205;7100;7147.213806481179;7227.891581626174;7274.745383911538;6776.119104516381;7014.649267536501;7188.568685878655;7275.963620181865;7324.487285889936;6333.8733225336155;6572.80281591553;6580.901286480611;6587.80236592903;6598.5710928791395;4954.256861470808;5013.849584512324;5072.239164125411;5224.738763061908;5276.20856871457;4889.364382630235;5058.392992840735;5073.746312684425;5081.796728130981;5091.1854103343285 02:25:58 INFO - PROCESS | 31531 | |4;prototype.html;333.1338519848396;334.9162709322669;342.68921375737796;342.73438085483747;348.48250348232887;5868.794592189274;5926.792562260322;6023.216981792366;6024.307204671464;6040.335563088062;6046.667433291167;6059.545534084939;6075.301340345862;6084.239470066242;6084.878302433949;4634.351190833286;4645.768871249104;4647.209974304359;4649.976750116261;4661.09108723799;4312.633426158764;4525.117602067582;4570;4570.65720070996;4647.907041859161;4508.323751437278;4527.388802511652;4528.818847246106;4533.682642215046;4544.454665440136;4525.343825145352;4562.338460923181;4563.520830312803;4568.611668008223;4575.22221222393;3742.4760533525055;3911.178652482982;3938.2517321708783;3970.146418520003;3975.4434379186937;5804.941950580483;5820.82537523875;5826.766929322822;5831.970840145772;5850.327212370589;5262.657927234717;5266.15741481365;5269.130593452076;5270.4729527047375;5287.101192797195;6015.669138197398;6305.117283580303;6313.179286692746;6318.968405157945;6330.208723909512;4327.0913108247305;4332.696711230215;4352.236329930485;4357.912841743179;4363;6236.345183755731;6437.935620643781;6516.446102081329;6603.504737144685;6632.436242919358;4578.67218506636;4586.197415452282;4587.082583483317;4597.494275629678;4620.768961551909;4642.79107440166;4651.953480465152;4670.159371313128;4693.859184224479;4705.811767529329;5056.443791182967;5356.303680521585;5384.273123128406;5401.1358182691365;5431.918521222185;6069.908951365733;6091.756329746849;6315.589486683442;6408.935910640927;6449.226092868886;1618.4173697468902;1628.6579818238304;1632.795900512436;1634.7057529644778;1646.1686848141612;1090.5038207615673;1098.7363032872054;1118.3737107219983;1119.9160062995309;1125.1954852280494;6129.693515324216;6133.44798968095;6149.538784591174;6164.907526387108;6185.8453538661;6525.347465253437;6526.543141980016;6534.509911756637;6539.683808686244;6556.737730490822;5959.642421454727;6045.939540604626;6064.545159112996;6072.36240194782;6115.3578874217565;3452.37857185709;3484.7212223022602;3499.492573576868;3503.491993660905;3512.1921957949303;6474.287828338879;6701.832454188587;6731.394174524316;6768.120144381199;6782.864342713118;6643.24656569037;6654.70053847578;6667.3997141115005;6676.599404035774;6714.093597364391;6617.569857959217;6755.162831610735;6759;6770.763023294259;6806.14923134618;6463.479243095103;6468.8059358219325;6508;6517.543771935919;6528.551793077596;6290.1508296381235;6375.4262116409745;6462.4439769963;6474.5791523550815;6476.0933469313395;6727.495437842083;6734.730610775514;6742.123523941857;6758.662066896733;6779.694913728993;4570.81716731327;4586.289125185602;4589.173948689135;4593.471750748707;4599.057193275304;6299.330677370592;6418.614883107029;6448.903266450913;6535.967320163369;6642.6014439133805;6391.3289104643345;6411.230652321751;6418.261899881387;6418.4544313731985;6425.132607097982;6285.5600107992;6409.487241020801;6430.710618022294;6435.549511534147;6437.259715132633;6323.146375239284;6329.651869147241;6342.175517182736;6346.555741098079;6375.151206150164;6481.157449531531;6487.3188315226225;6497.285298617054;6506.219253689587;6512.6092434454085;6214.4407003369915;6225.3774622537385;6267.122602835516;6319.368063193828;6322.873542529215 02:25:58 INFO - PROCESS | 31531 | |5;yui.html;656.8587753632969;781.8514482248372;782.346740471706;812.1310198088048;812.1715849833166;12399.13206075575;12450.066245031614;12526.624201273977;12585.307808070553;12756.55352062678;11970.82043769344;12067.698307542316;12076.154669173162;12077.154599178039;12084.57703980361;683.9213490448587;796.41861441148;806.4677312973424;827.8137419080689;827.9089300176976;821.195228675898;823.8228780812124;828.9502629842199;830.3813658824184;830.8753686946976;871.7384784564637;875.9386842920966;876.837785009772;878.029777096309;879.7580665317057;869.6651789061194;872.9650813967434;873.2228316798023;874.6676263020044;875.3303722652176;644.4522156167267;644.8355669304298;646.066434002866;646.2245305633259;647.0520687193238;12311.815322770166;12418.503259869685;12441.502339906392;12463.688407789787;12478.875211247861;12107.818382724266;12323.445444955;12390.81413778794;12499.18755280913;12574.11981161319;11086.445677716081;11200.383978881158;11284.548618055267;11416.771664566746;11600.477978490988;3665.5784584772828;3690.1143725505954;3743.21392507571;3744.586274811345;3793.468914351993;55649.721751390985;55787.72106139443;56317;56337;56606;10387.84418233712;10436.791264174673;10537.524746535491;10710.46447677613;10765.192610554082;17805.643887122445;17868.910655446638;17891.37380191687;18056.277748889897;18102.366417175337;7494.475386722877;7569.053868266466;7636.923630763732;7908.4464087513325;7955.204479551999;4332.328489084197;4335.891602709958;4347.152305300436;4390.363397307437;4453.710508816916;3162.794418362799;3218.6459489456142;3226.2418331692033;3227.0964130043626;3237.5143728440453;550.3395924890148;565.9688717120598;566.577899464893;569.2201683693366;577.3158806813939;593.5222146172287;608.428077607048;650.3723906430317;654.3456543456543;705.3792662457005;8768.991565969867;8894.155055269739;9027.187553120119;9351;9449.38578992377;696.5959743348845;717.8600172966326;729.6825880741894;744.140517702055;763.9541627502367;4019.2363450944813;4058.0869304406274;4068.4710987571425;4122.532768021801;4156.7921603919685;50264;52559;52648.73675631674;53264.20103698448;62914;44289;46656.533434665216;50730.49269507331;51584.484155158716;51837.48162518402;43638;43749;44218;45058.999999999345;46840;8380.413371063967;8432.325413966746;8575.571221439028;8588.914110858812;9053.004169541213;30448.238794030327;31089.844550778005;31240.531392028683;31451;31790.523142152422;42393.788031059645;43003.56996429995;43308.35037474377;43543.78228108966;44051.559484404745;12126.151169418408;12221.266723996234;12238.265704057785;12350.258984460961;12457.750844983231;12006.699832504257;12048.578299759467;12098.697532561757;12399.628011159679;12453.875461245272;11708.180427370344;11728.648140555797;11866.466009029442;12151.513939442324;12808.6797830055;12412.379381031093;12437.129400942209;12440.81338779901;12474.750504989668;12522.248665080124;11351;12358.50565977351;12583.937080314907;12837.29394883253;12937.029722771018;10016.449095299828;10116.443595602019;10334.793304134026;10816.134709223086;10840.295380800222;10475.895241047492;10506.842397363893;10514.631987880388;10516.421596812248;10655.733606659896 02:25:58 INFO - PROCESS | 31531 | __end_tp_report 02:25:58 INFO - PROCESS | 31531 | __start_cc_report 02:25:58 INFO - PROCESS | 31531 | _x_x_mozilla_cycle_collect,343 02:25:58 INFO - PROCESS | 31531 | __end_cc_report 02:25:58 INFO - PROCESS | 31531 | __startTimestamp1461403558475__endTimestamp 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | ------- Summary: start ------- 02:25:58 INFO - PROCESS | 31531 | Number of tests: 6 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | [#0] dojo.html Cycles:165 Average:5302.35 Median:5501.20 stddev:588.29 (10.7%) stddev-sans-first:564.88 02:25:58 INFO - PROCESS | 31531 | Values: 3130.1 3166.1 3194.3 3214.1 3216.4 5328.9 5329.7 5338.2 5358.4 5405.5 5283.8 5291.6 5377.1 5431.0 5434.4 4808.8 4835.5 4877.3 4903.3 4933.8 4784.8 4886.6 4949.0 4953.8 4976.5 4823.2 4832.1 4854.2 4887.6 4906.0 4862.2 4896.2 4902.4 4922.0 4935.5 4855.6 4864.6 4864.8 4872.8 4891.6 5060.6 5291.6 5361.5 5362.7 5378.5 5703.0 5746.2 5756.1 5760.8 5781.5 5623.4 5761.5 5790.0 5791.8 5806.1 5276.1 5295.8 5307.5 5321.3 5349.4 5763.5 5766.8 5801.7 5808.9 5810.9 5448.7 5551.4 5598.1 5599.4 5626.7 5694.3 5695.3 5699.3 5700.3 5764.4 5601.0 5622.0 5659.3 5668.3 5674.7 5684.9 5687.6 5693.5 5719.9 5742.3 4277.6 4324.0 4324.2 4327.5 4369.4 3804.0 3859.7 3899.0 3919.2 3939.7 5405.6 5413.9 5427.9 5432.2 5455.1 5645.1 5668.8 5676.7 5684.0 5700.3 5346.3 5426.0 5458.5 5498.1 5518.4 4843.7 4868.4 4876.0 4898.1 4899.1 5835.8 5888.2 5888.3 5891.8 5897.3 5585.2 5655.7 5728.4 5747.8 5750.8 5896.1 5899.1 5900.3 5902.2 5907.9 5630.9 5638.8 5643.0 5646.6 5651.5 5651.6 5729.0 5780.2 5794.2 5838.6 5496.1 5533.5 5541.2 5543.9 5552.5 5514.9 5521.6 5524.3 5542.8 5544.2 5333.5 5464.1 5468.6 5501.2 5507.8 5550.2 5552.3 5599.4 5672.2 5673.6 5492.4 5494.7 5496.6 5502.7 5508.4 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | [#1] ext.html Cycles:180 Average:50642.82 Median:36039.46 stddev:100934.72 (280.1%) stddev-sans-first:101148.05 02:25:58 INFO - PROCESS | 31531 | Values: 641.1 645.1 651.8 675.2 742.7 34665.8 35603.0 35615.6 35629.0 35629.3 35312.3 35999.0 36003.6 36075.3 36121.6 8101.5 8283.5 8298.3 8310.5 8318.0 8592.7 8695.4 8712.7 8719.3 8722.8 8706.4 8786.4 8802.0 8813.8 8821.4 8619.4 8627.5 8641.8 8681.0 8730.7 8334.5 8411.7 8450.4 8456.5 8469.5 31579.2 36910.8 36911.6 37407.1 37480.3 3099.8 3370.1 3414.6 4072.9 4122.0 27153.0 27388.9 27595.4 27723.6 27849.0 3507.2 3620.2 3674.1 3676.8 3909.4 204627.0 205731.0 206864.0 208906.0 209072.0 34653.3 35654.3 35716.3 35845.0 51692.5 33941.5 33958.3 34116.8 34260.7 34266.7 13256.9 13379.0 13390.5 13398.7 13451.4 12169.1 12395.6 12403.4 12416.3 12607.9 8546.3 8557.7 8593.4 8630.7 8642.1 3273.9 3339.9 3343.7 3356.0 3387.6 1133.5 1235.6 1249.4 1258.6 1261.9 29179.4 29674.0 30051.0 30387.8 30484.4 1130.6 1207.0 1227.6 1246.2 1250.6 16200.4 16320.8 16403.5 16449.3 16759.7 456734.0 466672.0 467993.0 470709.0 472560.0 53446.7 54040.7 54491.0 54503.7 56291.7 1336.2 1339.1 1396.4 1421.3 1422.1 29930.0 29987.4 30250.1 30342.7 30356.5 49774.0 49777.8 50469.2 50539.0 50590.5 411426.0 412888.0 412957.0 414847.0 415459.0 27898.2 28435.0 28665.4 36616.5 37668.6 41392.0 41422.4 41547.4 41584.8 42679.8 38221.0 39145.6 39289.6 39795.0 40437.8 38672.6 39384.4 39447.4 40089.4 40239.2 34153.5 39434.0 40763.2 40810.2 42056.0 34367.0 34665.3 34678.5 35232.5 35381.5 26738.7 27446.9 27466.3 27606.0 27783.3 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | [#2] jquery.html Cycles:180 Average:27925.18 Median:23761.07 stddev:80114.01 (337.2%) stddev-sans-first:80312.09 02:25:58 INFO - PROCESS | 31531 | Values: 399.7 402.6 404.0 404.9 406.7 13656.7 17995.8 18347.1 18643.2 18735.9 17435.8 17680.8 18074.2 18169.5 18282.5 5414.7 5483.5 5643.6 5661.8 5688.7 5516.4 5590.2 5621.1 5655.1 5656.3 5377.6 5560.9 5577.1 5621.2 5623.4 5618.2 5626.6 5641.9 5646.2 5663.7 4803.1 4999.1 5026.7 5027.8 5038.1 22740.7 23136.4 23574.3 23947.8 24093.0 2411.9 2441.6 2513.9 2516.9 2802.8 14032.9 14264.4 14299.5 14311.9 14820.3 1984.6 1985.1 2010.3 2024.3 2048.8 56063.4 63960.7 68865.0 80771.0 83393.6 10155.0 10180.5 10285.2 10293.4 10589.2 14285.6 14326.9 14395.0 14434.0 14435.1 8102.9 8406.3 8494.2 8524.9 8600.4 8236.3 8250.5 8321.0 8383.9 8387.9 6412.2 6595.6 6645.4 6656.0 6700.0 1907.1 1931.2 1941.6 1969.4 1972.9 941.7 988.9 1031.8 1040.4 1062.8 19176.7 19314.2 19428.4 19630.5 20092.2 1028.5 1028.9 1047.4 1070.6 1097.9 10860.9 11202.8 11340.5 11434.8 11474.5 479084.0 484868.0 491271.0 493497.0 495639.0 77435.2 77816.0 78388.6 79903.0 82164.2 1048.3 1066.4 1073.2 1074.5 1084.3 16068.4 16134.4 16166.8 16319.9 16383.7 35761.8 35796.8 36513.0 36810.3 37363.8 48286.0 49628.3 50253.2 50360.0 50935.2 8097.1 8110.9 8242.2 8251.8 8308.0 10948.5 11598.7 11863.2 12075.8 12310.7 11505.5 11702.0 11713.9 11912.9 11968.5 11224.8 11314.3 11357.3 11416.9 11440.3 11256.2 11433.8 12005.0 12087.5 12282.3 8209.4 8304.2 8407.2 8434.8 8496.9 10737.9 11172.1 11456.8 11508.3 12230.1 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | [#3] mootools.html Cycles:180 Average:5428.64 Median:5086.49 stddev:2983.41 (58.7%) stddev-sans-first:2976.27 02:25:58 INFO - PROCESS | 31531 | Values: 1381.5 1459.7 1508.8 1683.1 1709.1 6844.0 7629.3 8011.2 8274.4 8308.6 7612.6 7697.7 7698.4 7709.9 7717.2 2272.9 2308.9 2313.7 2316.8 2321.3 2230.4 2248.2 2254.9 2267.6 2276.5 2258.9 2265.4 2284.0 2294.1 2298.0 2202.4 2211.1 2241.5 2246.2 2252.5 2197.7 2223.9 2225.5 2228.1 2244.1 7820.3 7829.8 7864.5 7868.7 7885.7 4935.3 5126.9 5150.5 5166.8 5173.1 3162.4 3170.4 3226.7 3258.4 3297.5 972.1 982.3 987.2 997.4 1004.5 11130.1 11206.0 11207.8 11259.7 11316.5 4355.9 4441.7 4525.2 4603.1 4615.4 9640.3 9643.9 9644.9 9647.5 9647.8 5018.7 5030.6 5041.4 5051.5 5060.7 4211.1 4577.7 4624.5 4646.7 4727.0 3723.3 3729.6 3791.1 3811.2 3813.9 1220.9 1225.5 1229.1 1241.0 1253.1 962.9 965.8 973.6 984.6 990.7 5258.8 5409.5 5446.8 5586.4 5881.0 946.6 975.3 1001.0 1015.9 1031.5 4087.9 4105.7 4113.3 4126.1 4175.0 9988.9 10268.8 10295.4 10359.2 10359.4 10169.0 10222.8 10231.5 10247.8 10271.5 7198.5 7508.0 7536.4 7551.2 7587.5 5667.1 5792.8 5824.8 5840.8 5962.1 9021.8 9073.3 9184.8 9188.7 9302.8 9014.9 9201.8 9392.3 9660.4 9680.4 6882.9 6933.2 7063.3 7319.2 7328.6 7896.3 7913.2 7953.7 7976.8 8027.8 6951.8 7100.0 7147.2 7227.9 7274.7 6776.1 7014.6 7188.6 7276.0 7324.5 6333.9 6572.8 6580.9 6587.8 6598.6 4954.3 5013.8 5072.2 5224.7 5276.2 4889.4 5058.4 5073.7 5081.8 5091.2 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | [#4] prototype.html Cycles:180 Average:5314.49 Median:6067.23 stddev:1592.53 (26.2%) stddev-sans-first:1552.48 02:25:58 INFO - PROCESS | 31531 | Values: 333.1 334.9 342.7 342.7 348.5 5868.8 5926.8 6023.2 6024.3 6040.3 6046.7 6059.5 6075.3 6084.2 6084.9 4634.4 4645.8 4647.2 4650.0 4661.1 4312.6 4525.1 4570.0 4570.7 4647.9 4508.3 4527.4 4528.8 4533.7 4544.5 4525.3 4562.3 4563.5 4568.6 4575.2 3742.5 3911.2 3938.3 3970.1 3975.4 5804.9 5820.8 5826.8 5832.0 5850.3 5262.7 5266.2 5269.1 5270.5 5287.1 6015.7 6305.1 6313.2 6319.0 6330.2 4327.1 4332.7 4352.2 4357.9 4363.0 6236.3 6437.9 6516.4 6603.5 6632.4 4578.7 4586.2 4587.1 4597.5 4620.8 4642.8 4652.0 4670.2 4693.9 4705.8 5056.4 5356.3 5384.3 5401.1 5431.9 6069.9 6091.8 6315.6 6408.9 6449.2 1618.4 1628.7 1632.8 1634.7 1646.2 1090.5 1098.7 1118.4 1119.9 1125.2 6129.7 6133.4 6149.5 6164.9 6185.8 6525.3 6526.5 6534.5 6539.7 6556.7 5959.6 6045.9 6064.5 6072.4 6115.4 3452.4 3484.7 3499.5 3503.5 3512.2 6474.3 6701.8 6731.4 6768.1 6782.9 6643.2 6654.7 6667.4 6676.6 6714.1 6617.6 6755.2 6759.0 6770.8 6806.1 6463.5 6468.8 6508.0 6517.5 6528.6 6290.2 6375.4 6462.4 6474.6 6476.1 6727.5 6734.7 6742.1 6758.7 6779.7 4570.8 4586.3 4589.2 4593.5 4599.1 6299.3 6418.6 6448.9 6536.0 6642.6 6391.3 6411.2 6418.3 6418.5 6425.1 6285.6 6409.5 6430.7 6435.5 6437.3 6323.1 6329.7 6342.2 6346.6 6375.2 6481.2 6487.3 6497.3 6506.2 6512.6 6214.4 6225.4 6267.1 6319.4 6322.9 02:25:58 INFO - PROCESS | 31531 | 02:25:58 INFO - PROCESS | 31531 | [#5] yui.html Cycles:180 Average:13827.29 Median:42698.68 stddev:15789.72 (37.0%) stddev-sans-first:15803.03 02:25:58 INFO - PROCESS | 31531 | Values: 656.9 781.9 782.3 812.1 812.2 12399.1 12450.1 12526.6 12585.3 12756.6 11970.8 12067.7 12076.2 12077.2 12084.6 683.9 796.4 806.5 827.8 827.9 821.2 823.8 829.0 830.4 830.9 871.7 875.9 876.8 878.0 879.8 869.7 873.0 873.2 874.7 875.3 644.5 644.8 646.1 646.2 647.1 12311.8 12418.5 12441.5 12463.7 12478.9 12107.8 12323.4 12390.8 12499.2 12574.1 11086.4 11200.4 11284.5 11416.8 11600.5 3665.6 3690.1 3743.2 3744.6 3793.5 55649.7 55787.7 56317.0 56337.0 56606.0 10387.8 10436.8 10537.5 10710.5 10765.2 17805.6 17868.9 17891.4 18056.3 18102.4 7494.5 7569.1 7636.9 7908.4 7955.2 4332.3 4335.9 4347.2 4390.4 4453.7 3162.8 3218.6 3226.2 3227.1 3237.5 550.3 566.0 566.6 569.2 577.3 593.5 608.4 650.4 654.3 705.4 8769.0 8894.2 9027.2 9351.0 9449.4 696.6 717.9 729.7 744.1 764.0 4019.2 4058.1 4068.5 4122.5 4156.8 50264.0 52559.0 52648.7 53264.2 62914.0 44289.0 46656.5 50730.5 51584.5 51837.5 43638.0 43749.0 44218.0 45059.0 46840.0 8380.4 8432.3 8575.6 8588.9 9053.0 30448.2 31089.8 31240.5 31451.0 31790.5 42393.8 43003.6 43308.4 43543.8 44051.6 12126.2 12221.3 12238.3 12350.3 12457.8 12006.7 12048.6 12098.7 12399.6 12453.9 11708.2 11728.6 11866.5 12151.5 12808.7 12412.4 12437.1 12440.8 12474.8 12522.2 11351.0 12358.5 12583.9 12837.3 12937.0 10016.4 10116.4 10334.8 10816.1 10840.3 10475.9 10506.8 10514.6 10516.4 10655.7 02:25:58 INFO - PROCESS | 31531 | -------- Summary: end -------- 02:25:58 INFO - PROCESS | 31531 | 02:25:59 INFO - TEST-INFO | 31531: exit 0 02:25:59 INFO - TEST-OK | dromaeo_css | took 1111398ms 02:25:59 INFO - TEST-START | kraken 02:25:59 INFO - operating with platform_type : linux_ 02:25:59 INFO - Initialising browser for kraken test... 02:25:59 INFO - TEST-INFO | started process 31763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw2K3vp/profile http://localhost:59954/getInfo.html) 02:26:03 INFO - PROCESS | 31763 | 02:26:03 INFO - PROCESS | 31763 | (process:31831): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:26:04 INFO - PROCESS | 31763 | __metrics Screen width/height:1600/1200 02:26:04 INFO - PROCESS | 31763 | colorDepth:24 02:26:04 INFO - PROCESS | 31763 | Browser inner width/height: 1024/697 02:26:04 INFO - PROCESS | 31763 | __metrics 02:26:05 ERROR - PROCESS | 31763 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:26:05 INFO - TEST-INFO | 31763: exit 0 02:26:05 INFO - Browser initialized. 02:26:05 INFO - Running cycle 1/1 for kraken test... 02:26:05 INFO - TEST-INFO | started process 31882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw2K3vp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:07 INFO - PROCESS | 31882 | 02:26:07 INFO - PROCESS | 31882 | (process:31944): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:26:17 INFO - PROCESS | 31882 | RSS: Main: 164315136 02:26:17 INFO - PROCESS | 31882 | 02:26:20 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59954/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:21 INFO - PROCESS | 31882 | RSS: Main: 169373696 02:26:21 INFO - PROCESS | 31882 | 02:26:23 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59954/tests/kraken/driver.html?testName=audio-dft) 02:26:24 INFO - PROCESS | 31882 | RSS: Main: 173211648 02:26:24 INFO - PROCESS | 31882 | 02:26:27 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59954/tests/kraken/driver.html?testName=audio-fft) 02:26:27 INFO - PROCESS | 31882 | RSS: Main: 163373056 02:26:27 INFO - PROCESS | 31882 | 02:26:30 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59954/tests/kraken/driver.html?testName=audio-oscillator) 02:26:30 INFO - PROCESS | 31882 | RSS: Main: 163078144 02:26:30 INFO - PROCESS | 31882 | 02:26:33 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59954/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:33 INFO - PROCESS | 31882 | RSS: Main: 164454400 02:26:33 INFO - PROCESS | 31882 | 02:26:36 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59954/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:37 INFO - PROCESS | 31882 | RSS: Main: 164872192 02:26:37 INFO - PROCESS | 31882 | 02:26:40 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59954/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:41 INFO - PROCESS | 31882 | RSS: Main: 167133184 02:26:41 INFO - PROCESS | 31882 | 02:26:44 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59954/tests/kraken/driver.html?testName=json-parse-financial) 02:26:44 INFO - PROCESS | 31882 | RSS: Main: 167043072 02:26:44 INFO - PROCESS | 31882 | 02:26:46 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59954/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:47 INFO - PROCESS | 31882 | RSS: Main: 167583744 02:26:47 INFO - PROCESS | 31882 | 02:26:48 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:49 INFO - PROCESS | 31882 | RSS: Main: 167235584 02:26:49 INFO - PROCESS | 31882 | 02:26:51 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:52 INFO - PROCESS | 31882 | RSS: Main: 167596032 02:26:52 INFO - PROCESS | 31882 | 02:26:54 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:55 INFO - PROCESS | 31882 | RSS: Main: 168165376 02:26:55 INFO - PROCESS | 31882 | 02:26:58 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:58 INFO - PROCESS | 31882 | RSS: Main: 168013824 02:26:58 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | Cycle 1(1): loaded http://localhost:59954/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59954/tests/kraken/driver.html?testName=ai-astar) 02:27:00 INFO - PROCESS | 31882 | RSS: Main: 169422848 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | __start_tp_report 02:27:00 INFO - PROCESS | 31882 | _x_x_mozilla_page_load 02:27:00 INFO - PROCESS | 31882 | _x_x_mozilla_page_load_details 02:27:00 INFO - PROCESS | 31882 | |i|pagename|runs| 02:27:00 INFO - PROCESS | 31882 | |0;ai-astar;113;109;116;111;112;126;113;115;112;112 02:27:00 INFO - PROCESS | 31882 | |1;audio-beat-detection;156;129;151;183;130;157;163;130;202;128 02:27:00 INFO - PROCESS | 31882 | |2;audio-dft;161;163;162;162;161;164;167;162;166;163 02:27:00 INFO - PROCESS | 31882 | |3;audio-fft;74;73;72;161;75;73;73;72;169;76 02:27:00 INFO - PROCESS | 31882 | |4;audio-oscillator;93;93;151;92;92;92;138;92;92;147 02:27:00 INFO - PROCESS | 31882 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;117;118;117 02:27:00 INFO - PROCESS | 31882 | |6;imaging-darkroom;147;148;149;148;147;148;147;150;151;146 02:27:00 INFO - PROCESS | 31882 | |7;imaging-desaturate;95;95;95;96;95;95;95;96;95;95 02:27:00 INFO - PROCESS | 31882 | |8;json-parse-financial;59;59;60;58;66;57;58;77;56;60 02:27:00 INFO - PROCESS | 31882 | |9;json-stringify-tinderbox;61;61;61;61;62;62;62;61;66;61 02:27:00 INFO - PROCESS | 31882 | |10;stanford-crypto-aes;77;77;78;79;78;80;86;79;79;77 02:27:00 INFO - PROCESS | 31882 | |11;stanford-crypto-ccm;136;127;125;127;139;126;126;128;158;127 02:27:00 INFO - PROCESS | 31882 | |12;stanford-crypto-pbkdf2;169;175;172;173;170;167;172;169;169;168 02:27:00 INFO - PROCESS | 31882 | |13;stanford-crypto-sha256-iterative;67;68;68;69;73;70;68;66;67;69 02:27:00 INFO - PROCESS | 31882 | __end_tp_report 02:27:00 INFO - PROCESS | 31882 | __start_cc_report 02:27:00 INFO - PROCESS | 31882 | _x_x_mozilla_cycle_collect,837 02:27:00 INFO - PROCESS | 31882 | __end_cc_report 02:27:00 INFO - PROCESS | 31882 | __startTimestamp1461403620827__endTimestamp 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | ------- Summary: start ------- 02:27:00 INFO - PROCESS | 31882 | Number of tests: 14 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.00 stddev:4.68 (4.1%) stddev-sans-first:4.95 02:27:00 INFO - PROCESS | 31882 | Values: 113.0 109.0 116.0 111.0 112.0 126.0 113.0 115.0 112.0 112.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:156.50 stddev:25.14 (16.1%) stddev-sans-first:26.64 02:27:00 INFO - PROCESS | 31882 | Values: 156.0 129.0 151.0 183.0 130.0 157.0 163.0 130.0 202.0 128.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.02 (1.2%) stddev-sans-first:2.00 02:27:00 INFO - PROCESS | 31882 | Values: 161.0 163.0 162.0 162.0 161.0 164.0 167.0 162.0 166.0 163.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#3] audio-fft Cycles:10 Average:91.80 Median:73.00 stddev:38.65 (52.9%) stddev-sans-first:40.45 02:27:00 INFO - PROCESS | 31882 | Values: 74.0 73.0 72.0 161.0 75.0 73.0 73.0 72.0 169.0 76.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.00 stddev:25.82 (28.1%) stddev-sans-first:26.79 02:27:00 INFO - PROCESS | 31882 | Values: 93.0 93.0 151.0 92.0 92.0 92.0 138.0 92.0 92.0 147.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:27:00 INFO - PROCESS | 31882 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.52 (1.0%) stddev-sans-first:1.56 02:27:00 INFO - PROCESS | 31882 | Values: 147.0 148.0 149.0 148.0 147.0 148.0 147.0 150.0 151.0 146.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:27:00 INFO - PROCESS | 31882 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#8] json-parse-financial Cycles:10 Average:61.00 Median:59.50 stddev:6.24 (10.5%) stddev-sans-first:6.57 02:27:00 INFO - PROCESS | 31882 | Values: 59.0 59.0 60.0 58.0 66.0 57.0 58.0 77.0 56.0 60.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.50 stddev:1.55 (2.5%) stddev-sans-first:1.62 02:27:00 INFO - PROCESS | 31882 | Values: 61.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 66.0 61.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.67 (3.4%) stddev-sans-first:2.73 02:27:00 INFO - PROCESS | 31882 | Values: 77.0 77.0 78.0 79.0 78.0 80.0 86.0 79.0 79.0 77.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:127.50 stddev:10.29 (8.1%) stddev-sans-first:10.81 02:27:00 INFO - PROCESS | 31882 | Values: 136.0 127.0 125.0 127.0 139.0 126.0 126.0 128.0 158.0 127.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:2.50 (1.5%) stddev-sans-first:2.60 02:27:00 INFO - PROCESS | 31882 | Values: 169.0 175.0 172.0 173.0 170.0 167.0 172.0 169.0 169.0 168.0 02:27:00 INFO - PROCESS | 31882 | 02:27:00 INFO - PROCESS | 31882 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.96 (2.9%) stddev-sans-first:2.00 02:27:00 INFO - PROCESS | 31882 | Values: 67.0 68.0 68.0 69.0 73.0 70.0 68.0 66.0 67.0 69.0 02:27:00 INFO - PROCESS | 31882 | -------- Summary: end -------- 02:27:00 INFO - PROCESS | 31882 | 02:27:01 INFO - TEST-INFO | 31882: exit 0 02:27:01 INFO - TEST-OK | kraken | took 62591ms 02:27:01 INFO - SUITE-END | took 1173s 02:27:01 INFO - Completed test suite (00:19:34) 02:27:01 INFO - javascript benchmark 02:27:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.0609817054883, 3166.097662166282, 3194.313222657131, 3214.1000519854447, 3216.40496508146, 5328.866778330544, 5329.706866122362, 5338.199270109486, 5358.41057483677, 5405.54052905503, 5283.762230699618, 5291.576673866081, 5377.059014672436, 5431.049566325897, 5434.429384914576, 4808.7595620218935, 4835.516448355154, 4877.341558889558, 4903.338049363326, 4933.7533123343865, 4784.808607655707, 4886.584640305578, 4949.010197960404, 4953.826616068438, 4976.4525902150735, 4823.20417131173, 4832.081904438145, 4854.17479028566, 4887.633427492934, 4905.96974635327, 4862.173430516786, 4896.192128298862, 4902.362692849907, 4921.990991846663, 4935.506449355072, 4855.562999330042, 4864.6108311335365, 4864.756762161913, 4872.756362181912, 4891.584215341701, 5060.645754797166, 5291.550218231417, 5361.544268737162, 5362.731863406814, 5378.542823859977, 5702.971485142589, 5746.224259724925, 5756.079027355645, 5760.8271751847515, 5781.508571771405, 5623.437656234385, 5761.539076873882, 5790.0, 5791.82624521265, 5806.071028635441, 5276.076686579833, 5295.814646487354, 5307.495787900143, 5321.281626980347, 5349.43830897754, 5763.510101641407, 5766.769329226784, 5801.738921748447, 5808.912866307009, 5810.941890581124, 5448.727563621803, 5551.361593416808, 5598.076317407664, 5599.384067752544, 5626.677730733274, 5694.316681998187, 5695.345035320991, 5699.316082070178, 5700.25896633435, 5764.423557644202, 5601.047821870292, 5622.044252477089, 5659.26429564154, 5668.319801623831, 5674.744636491368, 5684.857878553069, 5687.630304030225, 5693.5160511357, 5719.914201286984, 5742.3396309424115, 4277.615014648696, 4323.956760432356, 4324.221640104748, 4327.480702315679, 4369.43197384338, 3803.980980095082, 3859.749116307431, 3898.9610103899167, 3919.1573811630637, 3939.7045221608496, 5405.621606487508, 5413.918791218135, 5427.9185812212845, 5432.212329212242, 5455.099908515051, 5645.125005624052, 5668.829935101953, 5676.7161641918565, 5684.005299072645, 5700.315962084576, 5346.304980352607, 5425.972870135624, 5458.536024437888, 5498.120300751861, 5518.392976772552, 4843.660943733905, 4868.41579010521, 4876.0, 4898.069366820293, 4899.093667671421, 5835.824925252249, 5888.234529511136, 5888.293404791367, 5891.764329426775, 5897.262842144732, 5585.162225666182, 5655.7454914528125, 5728.398518155534, 5747.827565173052, 5750.7987220447085, 5896.145058966512, 5899.056151015817, 5900.262467191601, 5902.2327097477055, 5907.881842363043, 5630.915536266877, 5638.802641907678, 5643.0, 5646.632968857011, 5651.491365777099, 5651.6043876928225, 5728.971355143198, 5780.248567686174, 5794.217780599565, 5838.620489668158, 5496.148097044965, 5533.474319939599, 5541.196526503554, 5543.9168412474655, 5552.472515111058, 5514.889702206014, 5521.643171017752, 5524.309461317335, 5542.7782888685615, 5544.168374743659, 5333.493318134926, 5464.1257398816, 5468.644538105011, 5501.202325662676, 5507.779688812563, 5550.222968784293, 5552.305961754781, 5599.384067752462, 5672.234248376416, 5673.631213971079, 5492.368377636463, 5494.725263736877, 5496.615236933376, 5502.724863756876, 5508.394076651485], "value": 5263.87654656512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.147274125413, 645.0936434309795, 651.7555916531302, 675.2066322071564, 742.6954948471127, 34665.82667086664, 35603.0, 35615.64384356156, 35628.99999999997, 35629.2874142517, 35312.293754124905, 35999.0, 36003.639963600355, 36075.278494430095, 36121.63878361216, 8101.513909165455, 8283.461574997636, 8298.294644955186, 8310.459820111704, 8317.958410207972, 8592.656293748243, 8695.39132260739, 8712.695055673054, 8719.302455803552, 8722.825543489127, 8706.390552661316, 8786.384953053288, 8802.0, 8813.779655508599, 8821.382503224777, 8619.396642235077, 8627.525486098262, 8641.827163456726, 8680.956595217047, 8730.694425695103, 8334.541600211985, 8411.747647570583, 8450.366222533274, 8456.450330728483, 8469.534175620338, 31579.21051973696, 36910.81544592287, 36911.63088369109, 37407.06482337936, 37480.25039499222, 3099.8450077496036, 3370.0563842124243, 3414.607320158164, 4072.8574499892657, 4122.031322639177, 27153.0, 27388.863055684793, 27595.448091038066, 27723.584146237823, 27849.0, 3507.228409749851, 3620.2397496525496, 3674.0998455378335, 3676.7977761223124, 3909.3940439231965, 204627.0, 205731.0, 206864.0, 208906.0, 209072.0, 34653.30693386118, 35654.28691426157, 35716.285674286366, 35845.0, 51692.48307516952, 33941.490877636854, 33958.32083358319, 34116.829415852764, 34260.65739342625, 34266.65733342685, 13256.867431325563, 13379.0, 13390.464381424828, 13398.665033374049, 13451.394687239097, 12169.087318450975, 12395.62813115608, 12403.379831008413, 12416.255024698547, 12607.936960315139, 8546.273566746897, 8557.673560598118, 8593.44142630727, 8630.654773808978, 8642.135786421308, 3273.885414010498, 3339.899803005865, 3343.6656334366367, 3356.0, 3387.593488781362, 1133.4502766158407, 1235.6478403655094, 1249.4315086635559, 1258.5532136091738, 1261.880121388485, 29179.41641167165, 29674.0, 30051.0, 30387.848060759556, 30484.390312194075, 1130.6099395708468, 1207.0445877678042, 1227.5642147037672, 1246.1526162209602, 1250.6435665835193, 16200.351985920666, 16320.75518867218, 16403.507894763177, 16449.342026319053, 16759.748603770953, 456734.0, 466672.0, 467993.0, 470709.0, 472560.0, 53446.73276633592, 54040.729796350766, 54491.0, 54503.72748136234, 56291.71854140703, 1336.171573624359, 1339.1429485129524, 1396.406527225925, 1421.3319739722315, 1422.1253928833694, 29930.0, 29987.400251995274, 30250.09249722512, 30342.696573033987, 30356.54465183068, 49774.0, 49777.751111244215, 50469.24296135634, 50539.0, 50590.49409505858, 411426.0, 412888.0, 412957.0, 414847.0, 415459.0, 27898.16305510838, 28435.0, 28665.42669146647, 36616.45075323819, 37668.62331376761, 41392.0, 41422.378664319454, 41547.37678934879, 41584.792076039426, 42679.78660106679, 38221.0, 39145.6085439142, 39289.60710392974, 39795.0, 40437.79781101076, 38672.613273866904, 39384.40923386209, 39447.408288876264, 40089.39865902072, 40239.1952160961, 34153.48769768505, 39434.0, 40763.1847363057, 40810.18379632331, 42056.0, 34367.0, 34665.306693866485, 34678.479822802175, 35232.47151292784, 35381.469277960336, 26738.7326126744, 27446.86276568684, 27466.313342166606, 27606.0, 27783.30541736473], "value": 17706.062611226334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.67825900150376, 402.633603420887, 403.95556488786247, 404.88460788675224, 406.6746602717825, 13656.658583535416, 17995.820041799594, 18347.08264586772, 18643.1610577524, 18735.906320468377, 17435.82564174358, 17680.82319176808, 18074.186661600226, 18169.454916352497, 18282.542936426562, 5414.702191379492, 5483.506484416402, 5643.576731745115, 5661.811019685871, 5688.687122208277, 5516.393196748354, 5590.18942253373, 5621.128725047624, 5655.123455864347, 5656.264685590888, 5377.623566350357, 5560.916586251209, 5577.107662773957, 5621.241132447129, 5623.437656234364, 5618.15727640853, 5626.578006649477, 5641.915371269413, 5646.18130371096, 5663.660180389149, 4803.135435621587, 4999.100161970844, 5026.723530205837, 5027.824026159104, 5038.067957427887, 22740.65889011666, 23136.4215894604, 23574.29277121672, 23947.84469397745, 24093.0, 2411.9397015074765, 2441.5849305617908, 2513.8743062846966, 2516.937076573082, 2802.7757779377603, 14032.92983535086, 14264.429422823074, 14299.499517516837, 14311.856881431157, 14820.258987050604, 1984.573316736894, 1985.106701984113, 2010.2863483463307, 2024.2813801100692, 2048.805363490466, 56063.43936560664, 63960.68019659918, 68864.9999999995, 80771.0, 83393.58303208445, 10155.0, 10180.490975451197, 10285.177185825116, 10293.382397056052, 10589.205809564313, 14285.64285892861, 14326.856731432761, 14395.0, 14434.0, 14435.133891966305, 8102.918970810334, 8406.327493800482, 8494.235518803214, 8524.8721269181, 8600.354973377021, 8236.299914507214, 8250.46371985831, 8321.04308004575, 8383.874241886377, 8387.874181887155, 6412.23053233615, 6595.637239951753, 6645.368689974444, 6656.0, 6699.9665001674675, 1907.122723547156, 1931.2371613212702, 1941.6116776644728, 1969.399333203358, 1972.9013549322476, 941.651588912107, 988.851672249154, 1031.8245898197324, 1040.427764729411, 1062.8405739139191, 19176.71234931477, 19314.227430902607, 19428.417147485598, 19630.509237269183, 20092.19631214735, 1028.5371582787625, 1028.88682244953, 1047.4186826311318, 1070.5557193764657, 1097.8737445193744, 10860.891391086147, 11202.775944481065, 11340.546378144782, 11434.771304574027, 11474.541018359172, 479084.0, 484868.0, 491271.0, 493497.0, 495639.0, 77435.22564774392, 77816.0, 78388.60805695935, 79903.0, 82164.17835821684, 1048.2662136504478, 1066.3548553125402, 1073.2433634287809, 1074.5272080284649, 1084.2789544952675, 16068.35726570924, 16134.435294764628, 16166.838331616533, 16319.918400407922, 16383.67232655364, 35761.821190893876, 35796.821015895795, 36513.0, 36810.26379472342, 37363.813180933925, 48286.0, 49628.25557616711, 50253.24620130774, 50360.0, 50935.23597145972, 8097.149799270992, 8110.878336824834, 8242.216989386, 8251.752447426346, 8307.958460207661, 10948.45257737126, 11598.710032248924, 11863.169578129793, 12075.818862716891, 12310.692232694255, 11505.48225329879, 11702.0, 11713.941430292794, 11912.940435297767, 11968.521259149536, 11224.7755044897, 11314.321140731583, 11357.318560886373, 11416.94291528537, 11440.256383335056, 11256.155788316073, 11433.828492572784, 12005.0, 12087.456064476944, 12282.324472154118, 8209.425340226127, 8304.169583041648, 8407.152517504426, 8434.831303373776, 8496.872546911925, 10737.946310268399, 11172.106231501299, 11456.770864582495, 11508.309501429942, 12230.104642873195], "value": 9155.8825680303, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.5440904501513, 1459.656980609557, 1508.8340282568915, 1683.1163639089484, 1709.0514764305813, 6843.965780171105, 7629.2752188542, 8011.238932301437, 8274.379421543379, 8308.62611182496, 7612.61936903154, 7697.692092316314, 7698.422618303635, 7709.922900770991, 7717.1896950820055, 2272.9090836366527, 2308.8730119843403, 2313.664518644804, 2316.8262380321457, 2321.3384185507134, 2230.397792595998, 2248.168177774218, 2254.921077762279, 2267.5918334699745, 2276.5333106713165, 2258.9322320330416, 2265.4109931417784, 2283.954320913581, 2294.0823670531754, 2297.9770202298014, 2202.427368884086, 2211.148707747521, 2241.4620491082187, 2246.180144247346, 2252.549490101986, 2197.7362716474127, 2223.8776867272295, 2225.499262665903, 2228.119892642397, 2244.124791331382, 7820.257075577811, 7829.843403131906, 7864.4888082274465, 7868.685252589889, 7885.684572617089, 4935.259711043336, 5126.872088140603, 5150.510701483353, 5166.844994650167, 5173.120569503156, 3162.446571849917, 3170.429322721909, 3226.6612005739294, 3258.3809076275434, 3297.5383446317533, 972.0668158567784, 982.3123813330698, 987.2151639446586, 997.3616885193481, 1004.5379125602232, 11130.053945414731, 11206.0, 11207.775844483147, 11259.718507037389, 11316.547338106466, 4355.934660980088, 4441.733495990251, 4525.162844873709, 4603.102395033004, 4615.399998000238, 9640.276979226586, 9643.855342169873, 9644.855327170098, 9647.517624118766, 9647.758806029766, 5018.673786203885, 5030.572401345927, 5041.445441001487, 5051.494850514992, 5060.7216603086445, 4211.136716973013, 4577.679562430598, 4624.468186158568, 4646.697964632288, 4727.030958653468, 3723.31118743028, 3729.589745128034, 3791.1469919267943, 3811.19964807388, 3813.9427908581392, 1220.9450574724158, 1225.503671013241, 1229.0843321725372, 1240.9875901241053, 1253.1040306180942, 962.8603852441497, 965.7971825916495, 973.6251543155936, 984.6455276100598, 990.7424069741919, 5258.842234732964, 5409.513143817076, 5446.809361672402, 5586.357568879631, 5880.970595146997, 946.621351459408, 975.2880397309862, 1000.9699709008742, 1015.8553103338362, 1031.4584842957506, 4087.8773636790943, 4105.7331273467125, 4113.25961326964, 4126.09225970286, 4175.0, 9988.850167247498, 10268.794624107475, 10295.3822770634, 10359.22305827066, 10359.430231337348, 10169.0, 10222.846657300146, 10231.539580718736, 10247.846282305622, 10271.537780799881, 7198.460115491359, 7508.0, 7536.359409450258, 7551.244875512514, 7587.544747315179, 5667.121596152603, 5792.797252096157, 5824.796132135355, 5840.766369345179, 5962.07587823888, 9021.774455638662, 9073.31950103758, 9184.770380740267, 9188.724338269863, 9302.767430814283, 9014.909850901407, 9201.76995575116, 9392.295577831826, 9660.420374777535, 9680.370775899544, 6882.931170688229, 6933.168019837652, 7063.328983746535, 7319.2314806944505, 7328.560286382621, 7896.289333959971, 7913.208679132041, 7953.721619743281, 7976.760697179094, 8027.799305017188, 6951.7914462566205, 7100.0, 7147.213806481179, 7227.891581626174, 7274.745383911538, 6776.119104516381, 7014.649267536501, 7188.568685878655, 7275.963620181865, 7324.487285889936, 6333.8733225336155, 6572.80281591553, 6580.901286480611, 6587.80236592903, 6598.5710928791395, 4954.256861470808, 5013.849584512324, 5072.239164125411, 5224.738763061908, 5276.20856871457, 4889.364382630235, 5058.392992840735, 5073.746312684425, 5081.796728130981, 5091.1854103343285], "value": 4405.778563157396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.1338519848396, 334.9162709322669, 342.68921375737796, 342.73438085483747, 348.48250348232887, 5868.794592189274, 5926.792562260322, 6023.216981792366, 6024.307204671464, 6040.335563088062, 6046.667433291167, 6059.545534084939, 6075.301340345862, 6084.239470066242, 6084.878302433949, 4634.351190833286, 4645.768871249104, 4647.209974304359, 4649.976750116261, 4661.09108723799, 4312.633426158764, 4525.117602067582, 4570.0, 4570.65720070996, 4647.907041859161, 4508.323751437278, 4527.388802511652, 4528.818847246106, 4533.682642215046, 4544.454665440136, 4525.343825145352, 4562.338460923181, 4563.520830312803, 4568.611668008223, 4575.22221222393, 3742.4760533525055, 3911.178652482982, 3938.2517321708783, 3970.146418520003, 3975.4434379186937, 5804.941950580483, 5820.82537523875, 5826.766929322822, 5831.970840145772, 5850.327212370589, 5262.657927234717, 5266.15741481365, 5269.130593452076, 5270.4729527047375, 5287.101192797195, 6015.669138197398, 6305.117283580303, 6313.179286692746, 6318.968405157945, 6330.208723909512, 4327.0913108247305, 4332.696711230215, 4352.236329930485, 4357.912841743179, 4363.0, 6236.345183755731, 6437.935620643781, 6516.446102081329, 6603.504737144685, 6632.436242919358, 4578.67218506636, 4586.197415452282, 4587.082583483317, 4597.494275629678, 4620.768961551909, 4642.79107440166, 4651.953480465152, 4670.159371313128, 4693.859184224479, 4705.811767529329, 5056.443791182967, 5356.303680521585, 5384.273123128406, 5401.1358182691365, 5431.918521222185, 6069.908951365733, 6091.756329746849, 6315.589486683442, 6408.935910640927, 6449.226092868886, 1618.4173697468902, 1628.6579818238304, 1632.795900512436, 1634.7057529644778, 1646.1686848141612, 1090.5038207615673, 1098.7363032872054, 1118.3737107219983, 1119.9160062995309, 1125.1954852280494, 6129.693515324216, 6133.44798968095, 6149.538784591174, 6164.907526387108, 6185.8453538661, 6525.347465253437, 6526.543141980016, 6534.509911756637, 6539.683808686244, 6556.737730490822, 5959.642421454727, 6045.939540604626, 6064.545159112996, 6072.36240194782, 6115.3578874217565, 3452.37857185709, 3484.7212223022602, 3499.492573576868, 3503.491993660905, 3512.1921957949303, 6474.287828338879, 6701.832454188587, 6731.394174524316, 6768.120144381199, 6782.864342713118, 6643.24656569037, 6654.70053847578, 6667.3997141115005, 6676.599404035774, 6714.093597364391, 6617.569857959217, 6755.162831610735, 6759.0, 6770.763023294259, 6806.14923134618, 6463.479243095103, 6468.8059358219325, 6508.0, 6517.543771935919, 6528.551793077596, 6290.1508296381235, 6375.4262116409745, 6462.4439769963, 6474.5791523550815, 6476.0933469313395, 6727.495437842083, 6734.730610775514, 6742.123523941857, 6758.662066896733, 6779.694913728993, 4570.81716731327, 4586.289125185602, 4589.173948689135, 4593.471750748707, 4599.057193275304, 6299.330677370592, 6418.614883107029, 6448.903266450913, 6535.967320163369, 6642.6014439133805, 6391.3289104643345, 6411.230652321751, 6418.261899881387, 6418.4544313731985, 6425.132607097982, 6285.5600107992, 6409.487241020801, 6430.710618022294, 6435.549511534147, 6437.259715132633, 6323.146375239284, 6329.651869147241, 6342.175517182736, 6346.555741098079, 6375.151206150164, 6481.157449531531, 6487.3188315226225, 6497.285298617054, 6506.219253689587, 6512.6092434454085, 6214.4407003369915, 6225.3774622537385, 6267.122602835516, 6319.368063193828, 6322.873542529215], "value": 4799.9828394028145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.8587753632969, 781.8514482248372, 782.346740471706, 812.1310198088048, 812.1715849833166, 12399.13206075575, 12450.066245031614, 12526.624201273977, 12585.307808070553, 12756.55352062678, 11970.82043769344, 12067.698307542316, 12076.154669173162, 12077.154599178039, 12084.57703980361, 683.9213490448587, 796.41861441148, 806.4677312973424, 827.8137419080689, 827.9089300176976, 821.195228675898, 823.8228780812124, 828.9502629842199, 830.3813658824184, 830.8753686946976, 871.7384784564637, 875.9386842920966, 876.837785009772, 878.029777096309, 879.7580665317057, 869.6651789061194, 872.9650813967434, 873.2228316798023, 874.6676263020044, 875.3303722652176, 644.4522156167267, 644.8355669304298, 646.066434002866, 646.2245305633259, 647.0520687193238, 12311.815322770166, 12418.503259869685, 12441.502339906392, 12463.688407789787, 12478.875211247861, 12107.818382724266, 12323.445444955, 12390.81413778794, 12499.18755280913, 12574.11981161319, 11086.445677716081, 11200.383978881158, 11284.548618055267, 11416.771664566746, 11600.477978490988, 3665.5784584772828, 3690.1143725505954, 3743.21392507571, 3744.586274811345, 3793.468914351993, 55649.721751390985, 55787.72106139443, 56317.0, 56337.0, 56606.0, 10387.84418233712, 10436.791264174673, 10537.524746535491, 10710.46447677613, 10765.192610554082, 17805.643887122445, 17868.910655446638, 17891.37380191687, 18056.277748889897, 18102.366417175337, 7494.475386722877, 7569.053868266466, 7636.923630763732, 7908.4464087513325, 7955.204479551999, 4332.328489084197, 4335.891602709958, 4347.152305300436, 4390.363397307437, 4453.710508816916, 3162.794418362799, 3218.6459489456142, 3226.2418331692033, 3227.0964130043626, 3237.5143728440453, 550.3395924890148, 565.9688717120598, 566.577899464893, 569.2201683693366, 577.3158806813939, 593.5222146172287, 608.428077607048, 650.3723906430317, 654.3456543456543, 705.3792662457005, 8768.991565969867, 8894.155055269739, 9027.187553120119, 9351.0, 9449.38578992377, 696.5959743348845, 717.8600172966326, 729.6825880741894, 744.140517702055, 763.9541627502367, 4019.2363450944813, 4058.0869304406274, 4068.4710987571425, 4122.532768021801, 4156.7921603919685, 50264.0, 52559.0, 52648.73675631674, 53264.20103698448, 62914.0, 44289.0, 46656.533434665216, 50730.49269507331, 51584.484155158716, 51837.48162518402, 43638.0, 43749.0, 44218.0, 45058.999999999345, 46840.0, 8380.413371063967, 8432.325413966746, 8575.571221439028, 8588.914110858812, 9053.004169541213, 30448.238794030327, 31089.844550778005, 31240.531392028683, 31451.0, 31790.523142152422, 42393.788031059645, 43003.56996429995, 43308.35037474377, 43543.78228108966, 44051.559484404745, 12126.151169418408, 12221.266723996234, 12238.265704057785, 12350.258984460961, 12457.750844983231, 12006.699832504257, 12048.578299759467, 12098.697532561757, 12399.628011159679, 12453.875461245272, 11708.180427370344, 11728.648140555797, 11866.466009029442, 12151.513939442324, 12808.6797830055, 12412.379381031093, 12437.129400942209, 12440.81338779901, 12474.750504989668, 12522.248665080124, 11351.0, 12358.50565977351, 12583.937080314907, 12837.29394883253, 12937.029722771018, 10016.449095299828, 10116.443595602019, 10334.793304134026, 10816.134709223086, 10840.295380800222, 10475.895241047492, 10506.842397363893, 10514.631987880388, 10516.421596812248, 10655.733606659896], "value": 6421.061445661731, "unit": "score"}], "name": "dromaeo_css", "value": 6982.417919773266, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 116.0, 111.0, 112.0, 126.0, 113.0, 115.0, 112.0, 112.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 151.0, 183.0, 130.0, 157.0, 163.0, 130.0, 202.0, 128.0], "value": 152.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 161.0, 164.0, 167.0, 162.0, 166.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 161.0, 75.0, 73.0, 73.0, 72.0, 169.0, 76.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 151.0, 92.0, 92.0, 92.0, 138.0, 92.0, 92.0, 147.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 150.0, 151.0, 146.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 58.0, 66.0, 57.0, 58.0, 77.0, 56.0, 60.0], "value": 61.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 66.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 79.0, 78.0, 80.0, 86.0, 79.0, 79.0, 77.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 125.0, 127.0, 139.0, 126.0, 126.0, 128.0, 158.0, 127.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 172.0, 173.0, 170.0, 167.0, 172.0, 169.0, 169.0, 168.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 69.0, 73.0, 70.0, 68.0, 66.0, 67.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1563.1000000000001, "alertThreshold": 2.0}]} 02:27:02 INFO - Return code: 0 02:27:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:02 ERROR - # TBPL SUCCESS # 02:27:02 INFO - Running post-action listener: _resource_record_post_action 02:27:02 INFO - Running post-run listener: _resource_record_post_run 02:27:03 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534753280; Read time: 80; Write time: 1242188 02:27:03 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 244830208; Read time: 0; Write time: 863820 02:27:03 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289923072; Read time: 80; Write time: 378368 02:27:03 INFO - Running post-run listener: _upload_blobber_files 02:27:03 INFO - Blob upload gear active. 02:27:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:03 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 02:27:03 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:27:03 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:27:03 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:27:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:27:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:04 INFO - (blobuploader) - INFO - Done attempting. 02:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:05 INFO - (blobuploader) - INFO - Done attempting. 02:27:05 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:05 INFO - Return code: 0 02:27:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/752cb5c91c36afe8c84e8c1c57949a2929e94b8d32d0e04d1883aec87e86fc290d695c17e538d4be02c4d2c2b67dc15c4b4184e53351829845f9759ddaee6be9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0da44ab0791463c99f1c6283f3bc3da43c8f0a5bb2b58853238f93d4e8337be6e93289ff03aa14ef11280a99b392d6b80cc8f71cfaa39b30700913f0cde27c43"} 02:27:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:05 INFO - Contents: 02:27:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/752cb5c91c36afe8c84e8c1c57949a2929e94b8d32d0e04d1883aec87e86fc290d695c17e538d4be02c4d2c2b67dc15c4b4184e53351829845f9759ddaee6be9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0da44ab0791463c99f1c6283f3bc3da43c8f0a5bb2b58853238f93d4e8337be6e93289ff03aa14ef11280a99b392d6b80cc8f71cfaa39b30700913f0cde27c43"} 02:27:05 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:05 INFO - Copying logs to upload dir... 02:27:05 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.158093 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-23 02:27:04.818220) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 02:27:04.822136) ========= 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=745a4373a2a16df560f216e000000264-1461388602.98965-1891095536 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/Fx-Team/sha512/752cb5c91c36afe8c84e8c1c57949a2929e94b8d32d0e04d1883aec87e86fc290d695c17e538d4be02c4d2c2b67dc15c4b4184e53351829845f9759ddaee6be9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0da44ab0791463c99f1c6283f3bc3da43c8f0a5bb2b58853238f93d4e8337be6e93289ff03aa14ef11280a99b392d6b80cc8f71cfaa39b30700913f0cde27c43"} build_url:https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/Eu7YXQgeQk-LvQgJaTYccQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/752cb5c91c36afe8c84e8c1c57949a2929e94b8d32d0e04d1883aec87e86fc290d695c17e538d4be02c4d2c2b67dc15c4b4184e53351829845f9759ddaee6be9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0da44ab0791463c99f1c6283f3bc3da43c8f0a5bb2b58853238f93d4e8337be6e93289ff03aa14ef11280a99b392d6b80cc8f71cfaa39b30700913f0cde27c43"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-23 02:27:04.846844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 02:27:04.847169) ========= 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=745a4373a2a16df560f216e000000264-1461388602.98965-1891095536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-23 02:27:04.930065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 02:27:04.930396) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-23 02:27:04.930716) ========= ========= Total master_lag: 0.18 =========