builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1464432735.13 results: success (0) buildid: 20160528004028 builduid: da1abc8da55c4cd895a18af21495c016 revision: 138121c338c75865135a001fc51f7465e36f4740 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.127610) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.128109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.128384) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.140641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.140912) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-28 03:52:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.71M=0.001s 2016-05-28 03:52:15 (9.71 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.325422) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.325761) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019919 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:15.375630) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:52:15.375992) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 138121c338c75865135a001fc51f7465e36f4740 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 138121c338c75865135a001fc51f7465e36f4740 --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=652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-28 03:52:15,727 truncating revision to first 12 chars 2016-05-28 03:52:15,727 Setting DEBUG logging. 2016-05-28 03:52:15,727 attempt 1/10 2016-05-28 03:52:15,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/138121c338c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-28 03:52:16,481 unpacking tar archive at: mozilla-aurora-138121c338c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.072469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-28 03:52:16.461535) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:16.461881) ========= script_repo_revision: 138121c338c75865135a001fc51f7465e36f4740 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:16.462263) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:16.462528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-28 03:52:16.472926) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-28 03:52:16.473295) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:16 INFO - MultiFileLogger online at 20160528 03:52:16 in /builds/slave/test 03:52:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:52:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:16 INFO - {'append_to_log': False, 03:52:16 INFO - 'base_work_dir': '/builds/slave/test', 03:52:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:52:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:16 INFO - 'branch': 'Mozilla-Aurora', 03:52:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:16 INFO - 'config_files': ('talos/linux_config.py',), 03:52:16 INFO - 'default_actions': ('clobber', 03:52:16 INFO - 'read-buildbot-config', 03:52:16 INFO - 'download-and-extract', 03:52:16 INFO - 'populate-webroot', 03:52:16 INFO - 'create-virtualenv', 03:52:16 INFO - 'install', 03:52:16 INFO - 'run-tests'), 03:52:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:16 INFO - 'download_minidump_stackwalk': True, 03:52:16 INFO - 'download_symbols': 'ondemand', 03:52:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:16 INFO - 'installer_path': 'installer.exe', 03:52:16 INFO - 'log_level': 'info', 03:52:16 INFO - 'log_name': 'talos', 03:52:16 INFO - 'log_to_console': True, 03:52:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:16 INFO - 'opt_config_files': (), 03:52:16 INFO - 'pip_index': False, 03:52:16 INFO - 'sps_profile': False, 03:52:16 INFO - 'sps_profile_interval': 0, 03:52:16 INFO - 'suite': 'dromaeojs-e10s', 03:52:16 INFO - 'system_bits': '32', 03:52:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:16 INFO - 'title': 'talos-linux64-ix-046', 03:52:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:16 INFO - 'use_talos_json': True, 03:52:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:16 INFO - 'work_dir': 'build'} 03:52:16 INFO - ##### 03:52:16 INFO - ##### Running clobber step. 03:52:16 INFO - ##### 03:52:16 INFO - Running pre-action listener: _resource_record_pre_action 03:52:16 INFO - Running main action method: clobber 03:52:16 INFO - rmtree: /builds/slave/test/build 03:52:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:17 INFO - Running post-action listener: _resource_record_post_action 03:52:17 INFO - ##### 03:52:17 INFO - ##### Running read-buildbot-config step. 03:52:17 INFO - ##### 03:52:17 INFO - Running pre-action listener: _resource_record_pre_action 03:52:17 INFO - Running main action method: read_buildbot_config 03:52:17 INFO - Using buildbot properties: 03:52:17 INFO - { 03:52:17 INFO - "project": "", 03:52:17 INFO - "product": "firefox", 03:52:17 INFO - "script_repo_revision": "production", 03:52:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:52:17 INFO - "repository": "", 03:52:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:52:17 INFO - "buildid": "20160528004028", 03:52:17 INFO - "stage_platform": "linux64-pgo", 03:52:17 INFO - "basedir": "/builds/slave/test", 03:52:17 INFO - "nightly_build": "True", 03:52:17 INFO - "buildnumber": 378, 03:52:17 INFO - "slavename": "talos-linux64-ix-046", 03:52:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:52:17 INFO - "platform": "ubuntu64_hw", 03:52:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:52:17 INFO - "branch": "mozilla-aurora", 03:52:17 INFO - "repo_path": "releases/mozilla-aurora", 03:52:17 INFO - "revision": "138121c338c75865135a001fc51f7465e36f4740", 03:52:17 INFO - "pgo_build": "True", 03:52:17 INFO - "builduid": "da1abc8da55c4cd895a18af21495c016", 03:52:17 INFO - "slavebuilddir": "test" 03:52:17 INFO - } 03:52:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:52:17 INFO - Running post-action listener: _resource_record_post_action 03:52:17 INFO - ##### 03:52:17 INFO - ##### Running download-and-extract step. 03:52:17 INFO - ##### 03:52:17 INFO - Running pre-action listener: _resource_record_pre_action 03:52:17 INFO - Running main action method: download_and_extract 03:52:17 INFO - mkdir: /builds/slave/test/build/tests 03:52:17 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')]} 03:52:17 INFO - https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:52:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:52:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:52:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:52:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:52:18 INFO - Downloaded 1361 bytes. 03:52:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:52:18 INFO - Using the following test package requirements: 03:52:18 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:52:18 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:52:18 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:52:18 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'jsshell-linux-x86_64.zip'], 03:52:18 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:52:18 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:52:18 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:52:18 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:52:18 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:52:18 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:52:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:52:18 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:18 INFO - https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:52:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:52:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:52:19 INFO - Downloaded 24136542 bytes. 03:52:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:52:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:52:20 INFO - Return code: 0 03:52:20 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:52:20 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')]} 03:52:20 INFO - https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:52:21 INFO - Downloaded 24136542 bytes. 03:52:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:52:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:52:22 INFO - Return code: 0 03:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:22 INFO - https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:52:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:52:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:52:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:52:23 INFO - Downloaded 10840145 bytes. 03:52:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:52:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:52:24 INFO - Return code: 0 03:52:24 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')]} 03:52:24 INFO - https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:52:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:52:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:52:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:52:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:52:25 INFO - Downloaded 62737490 bytes. 03:52:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:52:25 INFO - mkdir: /builds/slave/test/properties 03:52:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:25 INFO - Contents: 03:52:25 INFO - build_url:https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:52:26 INFO - Running post-action listener: _resource_record_post_action 03:52:26 INFO - Running post-action listener: set_extra_try_arguments 03:52:26 INFO - ##### 03:52:26 INFO - ##### Running populate-webroot step. 03:52:26 INFO - ##### 03:52:26 INFO - Running pre-action listener: _resource_record_pre_action 03:52:26 INFO - Running main action method: populate_webroot 03:52:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:26 INFO - '--tppagecycles', 03:52:26 INFO - '7'], 03:52:26 INFO - 'tests': ['tsvgm']}}, 03:52:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['damp', 'tps']}, 03:52:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'tests': ['damp', 'tps']}, 03:52:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['dromaeo_dom']}, 03:52:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['a11yr', 03:52:26 INFO - 'ts_paint', 03:52:26 INFO - 'tpaint', 03:52:26 INFO - 'sessionrestore', 03:52:26 INFO - 'sessionrestore_no_auto_restore', 03:52:26 INFO - 'tabpaint']}, 03:52:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:26 INFO - 'ts_paint', 03:52:26 INFO - 'tpaint', 03:52:26 INFO - 'sessionrestore', 03:52:26 INFO - 'sessionrestore_no_auto_restore', 03:52:26 INFO - 'tabpaint']}, 03:52:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:26 INFO - 'ts_paint', 03:52:26 INFO - 'tpaint', 03:52:26 INFO - 'sessionrestore', 03:52:26 INFO - 'sessionrestore_no_auto_restore', 03:52:26 INFO - 'tabpaint']}, 03:52:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:26 INFO - 'ts_paint', 03:52:26 INFO - 'tpaint', 03:52:26 INFO - 'sessionrestore', 03:52:26 INFO - 'sessionrestore_no_auto_restore', 03:52:26 INFO - 'tabpaint']}, 03:52:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['a11yr', 03:52:26 INFO - 'ts_paint', 03:52:26 INFO - 'tpaint', 03:52:26 INFO - 'sessionrestore', 03:52:26 INFO - 'sessionrestore_no_auto_restore', 03:52:26 INFO - 'tabpaint']}, 03:52:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['a11yr', 03:52:26 INFO - 'ts_paint', 03:52:26 INFO - 'tpaint', 03:52:26 INFO - 'sessionrestore', 03:52:26 INFO - 'sessionrestore_no_auto_restore', 03:52:26 INFO - 'tabpaint']}, 03:52:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['tsvgx', 03:52:26 INFO - 'tsvgr_opacity', 03:52:26 INFO - 'tart', 03:52:26 INFO - 'tscrollx', 03:52:26 INFO - 'cart']}, 03:52:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:26 INFO - 'tsvgr_opacity', 03:52:26 INFO - 'tart', 03:52:26 INFO - 'tscrollx', 03:52:26 INFO - 'cart']}, 03:52:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'talos_options': ['--disable-e10s'], 03:52:26 INFO - 'tests': ['tp5o']}, 03:52:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'tests': ['tp5o']}, 03:52:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'talos_options': ['--disable-e10s', 03:52:26 INFO - '--xperf_path', 03:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:26 INFO - 'tests': ['tp5n']}, 03:52:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:52:26 INFO - 'talos_options': ['--xperf_path', 03:52:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:26 INFO - 'tests': ['tp5n']}}, 03:52:26 INFO - 'talos.zip': {'path': '', 03:52:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:26 INFO - Running post-action listener: _resource_record_post_action 03:52:26 INFO - ##### 03:52:26 INFO - ##### Running create-virtualenv step. 03:52:26 INFO - ##### 03:52:26 INFO - Running pre-action listener: _resource_record_pre_action 03:52:26 INFO - Running main action method: create_virtualenv 03:52:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:26 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 03:52:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:26 INFO - Using real prefix '/usr' 03:52:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:28 INFO - Installing pip.................done. 03:52:28 INFO - Return code: 0 03:52:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:52:28 INFO - Using env: {'DISPLAY': ':0', 03:52:28 INFO - 'HOME': '/home/cltbld', 03:52:28 INFO - 'LANG': 'en_US.UTF-8', 03:52:28 INFO - 'LANGUAGE': 'en_US:en', 03:52:28 INFO - 'LOGNAME': 'cltbld', 03:52:28 INFO - 'MAIL': '/var/mail/cltbld', 03:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:28 INFO - 'MOZ_NO_REMOTE': '1', 03:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:28 INFO - 'NO_EM_RESTART': '1', 03:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:28 INFO - 'PWD': '/builds/slave/test', 03:52:28 INFO - 'SHELL': '/bin/bash', 03:52:28 INFO - 'SHLVL': '1', 03:52:28 INFO - 'TERM': 'linux', 03:52:28 INFO - 'TMOUT': '86400', 03:52:28 INFO - 'USER': 'cltbld', 03:52:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:28 INFO - '_': '/tools/buildbot/bin/python'} 03:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:29 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 03:52:29 INFO - Cleaning up... 03:52:29 INFO - Return code: 0 03:52:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:52:29 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')]} 03:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:29 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')]} 03:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:29 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:29 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 03:52:29 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 03:52:29 INFO - Using env: {'DISPLAY': ':0', 03:52:29 INFO - 'HOME': '/home/cltbld', 03:52:29 INFO - 'LANG': 'en_US.UTF-8', 03:52:29 INFO - 'LANGUAGE': 'en_US:en', 03:52:29 INFO - 'LOGNAME': 'cltbld', 03:52:29 INFO - 'MAIL': '/var/mail/cltbld', 03:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:29 INFO - 'MOZ_NO_REMOTE': '1', 03:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:29 INFO - 'NO_EM_RESTART': '1', 03:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:29 INFO - 'PWD': '/builds/slave/test', 03:52:29 INFO - 'SHELL': '/bin/bash', 03:52:29 INFO - 'SHLVL': '1', 03:52:29 INFO - 'TERM': 'linux', 03:52:29 INFO - 'TMOUT': '86400', 03:52:29 INFO - 'USER': 'cltbld', 03:52:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:29 INFO - '_': '/tools/buildbot/bin/python'} 03:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:29 INFO - Downloading/unpacking psutil>=0.7.1 03:52:29 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 03:52:29 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 03:52:29 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 03:52:29 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 03:52:29 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 03:52:29 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 03:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:31 INFO - Installing collected packages: psutil 03:52:31 INFO - Running setup.py install for psutil 03:52:31 INFO - building 'psutil._psutil_linux' extension 03:52:31 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 03:52:31 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 03:52:31 INFO - building 'psutil._psutil_posix' extension 03:52:31 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 03:52:31 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 03:52:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:31 INFO - Successfully installed psutil 03:52:31 INFO - Cleaning up... 03:52:31 INFO - Return code: 0 03:52:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:52:31 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')]} 03:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:31 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')]} 03:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:31 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:31 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 03:52:31 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 03:52:31 INFO - Using env: {'DISPLAY': ':0', 03:52:31 INFO - 'HOME': '/home/cltbld', 03:52:31 INFO - 'LANG': 'en_US.UTF-8', 03:52:31 INFO - 'LANGUAGE': 'en_US:en', 03:52:31 INFO - 'LOGNAME': 'cltbld', 03:52:31 INFO - 'MAIL': '/var/mail/cltbld', 03:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:31 INFO - 'MOZ_NO_REMOTE': '1', 03:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:31 INFO - 'NO_EM_RESTART': '1', 03:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:31 INFO - 'PWD': '/builds/slave/test', 03:52:31 INFO - 'SHELL': '/bin/bash', 03:52:31 INFO - 'SHLVL': '1', 03:52:31 INFO - 'TERM': 'linux', 03:52:31 INFO - 'TMOUT': '86400', 03:52:31 INFO - 'USER': 'cltbld', 03:52:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:31 INFO - '_': '/tools/buildbot/bin/python'} 03:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:52:32 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 03:52:32 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 03:52:32 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 03:52:32 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 03:52:32 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 03:52:32 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 03:52:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:52:34 INFO - Installing collected packages: mozsystemmonitor 03:52:34 INFO - Running setup.py install for mozsystemmonitor 03:52:34 INFO - Successfully installed mozsystemmonitor 03:52:34 INFO - Cleaning up... 03:52:34 INFO - Return code: 0 03:52:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:34 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:34 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 03:52:34 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 03:52:34 INFO - Using env: {'DISPLAY': ':0', 03:52:34 INFO - 'HOME': '/home/cltbld', 03:52:34 INFO - 'LANG': 'en_US.UTF-8', 03:52:34 INFO - 'LANGUAGE': 'en_US:en', 03:52:34 INFO - 'LOGNAME': 'cltbld', 03:52:34 INFO - 'MAIL': '/var/mail/cltbld', 03:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:34 INFO - 'MOZ_NO_REMOTE': '1', 03:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:34 INFO - 'NO_EM_RESTART': '1', 03:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:34 INFO - 'PWD': '/builds/slave/test', 03:52:34 INFO - 'SHELL': '/bin/bash', 03:52:34 INFO - 'SHLVL': '1', 03:52:34 INFO - 'TERM': 'linux', 03:52:34 INFO - 'TMOUT': '86400', 03:52:34 INFO - 'USER': 'cltbld', 03:52:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:34 INFO - '_': '/tools/buildbot/bin/python'} 03:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:34 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 03:52:34 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 03:52:34 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 03:52:34 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 03:52:34 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 03:52:34 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 03:52:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:36 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 03:52:36 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 03:52:36 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 03:52:36 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 03:52:36 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 03:52:36 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 03:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:36 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 03:52:36 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 03:52:36 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 03:52:36 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 03:52:36 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 03:52:36 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 03:52:37 INFO - Downloading docopt-0.6.1.tar.gz 03:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:37 INFO - Running setup.py install for blobuploader 03:52:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:37 INFO - Running setup.py install for requests 03:52:37 INFO - Running setup.py install for docopt 03:52:37 INFO - Successfully installed blobuploader requests docopt 03:52:37 INFO - Cleaning up... 03:52:37 INFO - Return code: 0 03:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:37 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')]} 03:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:37 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')]} 03:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:37 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:37 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 03:52:37 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 03:52:37 INFO - Using env: {'DISPLAY': ':0', 03:52:37 INFO - 'HOME': '/home/cltbld', 03:52:37 INFO - 'LANG': 'en_US.UTF-8', 03:52:37 INFO - 'LANGUAGE': 'en_US:en', 03:52:37 INFO - 'LOGNAME': 'cltbld', 03:52:37 INFO - 'MAIL': '/var/mail/cltbld', 03:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:37 INFO - 'MOZ_NO_REMOTE': '1', 03:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:37 INFO - 'NO_EM_RESTART': '1', 03:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:37 INFO - 'PWD': '/builds/slave/test', 03:52:37 INFO - 'SHELL': '/bin/bash', 03:52:37 INFO - 'SHLVL': '1', 03:52:37 INFO - 'TERM': 'linux', 03:52:37 INFO - 'TMOUT': '86400', 03:52:37 INFO - 'USER': 'cltbld', 03:52:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:37 INFO - '_': '/tools/buildbot/bin/python'} 03:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:37 INFO - Running setup.py (path:/tmp/pip-y7xO5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:37 INFO - Running setup.py (path:/tmp/pip-VN6rjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:38 INFO - Running setup.py (path:/tmp/pip-v5iDGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:38 INFO - Running setup.py (path:/tmp/pip-WNNwBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:38 INFO - Running setup.py (path:/tmp/pip-9jotwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:38 INFO - Running setup.py (path:/tmp/pip-aYWGOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:38 INFO - Running setup.py (path:/tmp/pip-uOvZ8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:38 INFO - Running setup.py (path:/tmp/pip-NAbFK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:38 INFO - Running setup.py (path:/tmp/pip-Eaam93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:38 INFO - Running setup.py (path:/tmp/pip-ZP5_B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:38 INFO - Running setup.py (path:/tmp/pip-KuqntE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:38 INFO - Running setup.py (path:/tmp/pip-wT8Oky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:38 INFO - Running setup.py (path:/tmp/pip-P0CZoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:38 INFO - Running setup.py (path:/tmp/pip-p5hU_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:38 INFO - Running setup.py (path:/tmp/pip-aZId2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:38 INFO - Running setup.py (path:/tmp/pip-PPfED9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:39 INFO - Running setup.py (path:/tmp/pip-yQmEZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:39 INFO - Running setup.py install for manifestparser 03:52:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Running setup.py install for mozcrash 03:52:39 INFO - Running setup.py install for mozdebug 03:52:39 INFO - Running setup.py install for mozdevice 03:52:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Running setup.py install for mozfile 03:52:39 INFO - Running setup.py install for mozhttpd 03:52:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Running setup.py install for mozinfo 03:52:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Running setup.py install for mozInstall 03:52:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:39 INFO - Running setup.py install for mozleak 03:52:40 INFO - Running setup.py install for mozlog 03:52:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:40 INFO - Running setup.py install for moznetwork 03:52:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:40 INFO - Running setup.py install for mozprocess 03:52:40 INFO - Running setup.py install for mozprofile 03:52:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:40 INFO - Running setup.py install for mozrunner 03:52:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:40 INFO - Running setup.py install for mozscreenshot 03:52:40 INFO - Running setup.py install for moztest 03:52:40 INFO - Running setup.py install for mozversion 03:52:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:40 INFO - Cleaning up... 03:52:40 INFO - Return code: 0 03:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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')]} 03:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:40 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:40 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 03:52:40 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 03:52:40 INFO - Using env: {'DISPLAY': ':0', 03:52:40 INFO - 'HOME': '/home/cltbld', 03:52:40 INFO - 'LANG': 'en_US.UTF-8', 03:52:40 INFO - 'LANGUAGE': 'en_US:en', 03:52:40 INFO - 'LOGNAME': 'cltbld', 03:52:40 INFO - 'MAIL': '/var/mail/cltbld', 03:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:40 INFO - 'MOZ_NO_REMOTE': '1', 03:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:40 INFO - 'NO_EM_RESTART': '1', 03:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:40 INFO - 'PWD': '/builds/slave/test', 03:52:40 INFO - 'SHELL': '/bin/bash', 03:52:40 INFO - 'SHLVL': '1', 03:52:40 INFO - 'TERM': 'linux', 03:52:40 INFO - 'TMOUT': '86400', 03:52:40 INFO - 'USER': 'cltbld', 03:52:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:40 INFO - '_': '/tools/buildbot/bin/python'} 03:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:41 INFO - Running setup.py (path:/tmp/pip-JEFw2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:41 INFO - Running setup.py (path:/tmp/pip-7ptpUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:41 INFO - Running setup.py (path:/tmp/pip-OzWFGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:41 INFO - Running setup.py (path:/tmp/pip-R5OpgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:41 INFO - Running setup.py (path:/tmp/pip-NbzbgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:41 INFO - Running setup.py (path:/tmp/pip-2Bnx_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:41 INFO - Running setup.py (path:/tmp/pip-iz6oSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:41 INFO - Running setup.py (path:/tmp/pip-1X9eKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:41 INFO - Running setup.py (path:/tmp/pip-UYUdUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:41 INFO - Running setup.py (path:/tmp/pip-MQhUiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:41 INFO - Running setup.py (path:/tmp/pip-KIjiq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:41 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)) 03:52:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:41 INFO - Running setup.py (path:/tmp/pip-PoEjEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:42 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)) 03:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:42 INFO - Running setup.py (path:/tmp/pip-CngKH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:42 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)) 03:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:42 INFO - Running setup.py (path:/tmp/pip-pOvty1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:42 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)) 03:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:42 INFO - Running setup.py (path:/tmp/pip-1n9Syy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:42 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)) 03:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:42 INFO - Running setup.py (path:/tmp/pip-e4Z9PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:42 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)) 03:52:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:42 INFO - Running setup.py (path:/tmp/pip-mIPZbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:42 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)) 03:52:42 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)) 03:52:42 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)) 03:52:42 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)) 03:52:42 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)) 03:52:42 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)) 03:52:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:42 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 03:52:42 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 03:52:42 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 03:52:42 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 03:52:42 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 03:52:42 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 03:52:44 INFO - Downloading blessings-1.6.tar.gz 03:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:44 INFO - Installing collected packages: blessings 03:52:44 INFO - Running setup.py install for blessings 03:52:44 INFO - Successfully installed blessings 03:52:44 INFO - Cleaning up... 03:52:44 INFO - Return code: 0 03:52:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:44 INFO - Reading from file tmpfile_stdout 03:52:44 INFO - Current package versions: 03:52:44 INFO - argparse == 1.2.1 03:52:44 INFO - blessings == 1.6 03:52:44 INFO - blobuploader == 1.2.4 03:52:44 INFO - docopt == 0.6.1 03:52:44 INFO - manifestparser == 1.1 03:52:44 INFO - mozInstall == 1.12 03:52:44 INFO - mozcrash == 0.17 03:52:44 INFO - mozdebug == 0.1 03:52:44 INFO - mozdevice == 0.48 03:52:44 INFO - mozfile == 1.2 03:52:44 INFO - mozhttpd == 0.7 03:52:44 INFO - mozinfo == 0.9 03:52:44 INFO - mozleak == 0.1 03:52:44 INFO - mozlog == 3.1 03:52:44 INFO - moznetwork == 0.27 03:52:44 INFO - mozprocess == 0.22 03:52:44 INFO - mozprofile == 0.28 03:52:44 INFO - mozrunner == 6.11 03:52:44 INFO - mozscreenshot == 0.1 03:52:44 INFO - mozsystemmonitor == 0.0 03:52:44 INFO - moztest == 0.7 03:52:44 INFO - mozversion == 1.4 03:52:44 INFO - psutil == 3.1.1 03:52:44 INFO - requests == 1.2.3 03:52:44 INFO - wsgiref == 0.1.2 03:52:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:44 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:44 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 03:52:44 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 03:52:44 INFO - Using env: {'DISPLAY': ':0', 03:52:44 INFO - 'HOME': '/home/cltbld', 03:52:44 INFO - 'LANG': 'en_US.UTF-8', 03:52:44 INFO - 'LANGUAGE': 'en_US:en', 03:52:44 INFO - 'LOGNAME': 'cltbld', 03:52:44 INFO - 'MAIL': '/var/mail/cltbld', 03:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:44 INFO - 'MOZ_NO_REMOTE': '1', 03:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:44 INFO - 'NO_EM_RESTART': '1', 03:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:44 INFO - 'PWD': '/builds/slave/test', 03:52:44 INFO - 'SHELL': '/bin/bash', 03:52:44 INFO - 'SHLVL': '1', 03:52:44 INFO - 'TERM': 'linux', 03:52:44 INFO - 'TMOUT': '86400', 03:52:44 INFO - 'USER': 'cltbld', 03:52:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:44 INFO - '_': '/tools/buildbot/bin/python'} 03:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 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)) 03:52:44 INFO - Cleaning up... 03:52:44 INFO - Return code: 0 03:52:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:44 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:44 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 03:52:44 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 03:52:44 INFO - Using env: {'DISPLAY': ':0', 03:52:44 INFO - 'HOME': '/home/cltbld', 03:52:44 INFO - 'LANG': 'en_US.UTF-8', 03:52:44 INFO - 'LANGUAGE': 'en_US:en', 03:52:44 INFO - 'LOGNAME': 'cltbld', 03:52:44 INFO - 'MAIL': '/var/mail/cltbld', 03:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:44 INFO - 'MOZ_NO_REMOTE': '1', 03:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:44 INFO - 'NO_EM_RESTART': '1', 03:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:44 INFO - 'PWD': '/builds/slave/test', 03:52:44 INFO - 'SHELL': '/bin/bash', 03:52:44 INFO - 'SHLVL': '1', 03:52:44 INFO - 'TERM': 'linux', 03:52:44 INFO - 'TMOUT': '86400', 03:52:44 INFO - 'USER': 'cltbld', 03:52:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:44 INFO - '_': '/tools/buildbot/bin/python'} 03:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:45 INFO - Downloading/unpacking jsonschema 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 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 03:52:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:47 INFO - Downloading/unpacking functools32 (from jsonschema) 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:47 INFO - warning: no files found matching '*.txt' 03:52:47 INFO - no previously-included directories found matching 'build' 03:52:47 INFO - no previously-included directories found matching 'dist' 03:52:47 INFO - no previously-included directories found matching '.git*' 03:52:47 INFO - Installing collected packages: jsonschema, functools32 03:52:47 INFO - Running setup.py install for functools32 03:52:47 INFO - warning: no files found matching '*.txt' 03:52:47 INFO - no previously-included directories found matching 'build' 03:52:47 INFO - no previously-included directories found matching 'dist' 03:52:47 INFO - no previously-included directories found matching '.git*' 03:52:47 INFO - Successfully installed jsonschema functools32 03:52:47 INFO - Cleaning up... 03:52:47 INFO - Return code: 0 03:52:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:47 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 0x7f4a9b9e1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', '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 03:52:47 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 03:52:47 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 03:52:47 INFO - Using env: {'DISPLAY': ':0', 03:52:47 INFO - 'HOME': '/home/cltbld', 03:52:47 INFO - 'LANG': 'en_US.UTF-8', 03:52:47 INFO - 'LANGUAGE': 'en_US:en', 03:52:47 INFO - 'LOGNAME': 'cltbld', 03:52:47 INFO - 'MAIL': '/var/mail/cltbld', 03:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:47 INFO - 'MOZ_NO_REMOTE': '1', 03:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:47 INFO - 'NO_EM_RESTART': '1', 03:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:47 INFO - 'PWD': '/builds/slave/test', 03:52:47 INFO - 'SHELL': '/bin/bash', 03:52:47 INFO - 'SHLVL': '1', 03:52:47 INFO - 'TERM': 'linux', 03:52:47 INFO - 'TMOUT': '86400', 03:52:47 INFO - 'USER': 'cltbld', 03:52:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:47 INFO - '_': '/tools/buildbot/bin/python'} 03:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:47 INFO - Downloading/unpacking flake8 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 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 03:52:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:52:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:52:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:52:50 INFO - no previously-included directories found matching 'docs/_build' 03:52:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:52:50 INFO - Running setup.py install for pep8 03:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:52:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:52:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:52:50 INFO - no previously-included directories found matching 'docs/_build' 03:52:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:52:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:52:50 INFO - Cleaning up... 03:52:50 INFO - Return code: 0 03:52:50 INFO - Running post-action listener: _resource_record_post_action 03:52:50 INFO - Running post-action listener: _start_resource_monitoring 03:52:50 INFO - Starting resource monitoring. 03:52:50 INFO - ##### 03:52:50 INFO - ##### Running install step. 03:52:50 INFO - ##### 03:52:50 INFO - Running pre-action listener: _resource_record_pre_action 03:52:50 INFO - Running main action method: install 03:52:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:51 INFO - Reading from file tmpfile_stdout 03:52:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:51 INFO - Reading from file tmpfile_stdout 03:52:51 INFO - Output received: 03:52:51 INFO - Usage: mozinstall [options] installer 03:52:51 INFO - Options: 03:52:51 INFO - -h, --help show this help message and exit 03:52:51 INFO - -d DEST, --destination=DEST 03:52:51 INFO - Directory to install application into. [default: 03:52:51 INFO - "/builds/slave/test"] 03:52:51 INFO - --app=APP Application being installed. [default: firefox] 03:52:51 INFO - mkdir: /builds/slave/test/build/application 03:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:53:06 INFO - Reading from file tmpfile_stdout 03:53:06 INFO - Output received: 03:53:06 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:06 INFO - Running post-action listener: _resource_record_post_action 03:53:06 INFO - ##### 03:53:06 INFO - ##### Running run-tests step. 03:53:06 INFO - ##### 03:53:06 INFO - Running pre-action listener: _resource_record_pre_action 03:53:06 INFO - Running main action method: run_tests 03:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:06 INFO - Python 2.7.3 03:53:06 INFO - Return code: 0 03:53:06 INFO - grabbing minidump binary from tooltool 03:53: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')]} 03:53:06 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 0x1dc1410>, '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 0x1dc2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:06 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 03:53:06 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 03:53:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:06 INFO - Return code: 0 03:53:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:53:07 INFO - Return code: 0 03:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 03:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 03:53:07 INFO - Using env: {'DISPLAY': ':0', 03:53:07 INFO - 'HOME': '/home/cltbld', 03:53:07 INFO - 'LANG': 'en_US.UTF-8', 03:53:07 INFO - 'LANGUAGE': 'en_US:en', 03:53:07 INFO - 'LOGNAME': 'cltbld', 03:53:07 INFO - 'MAIL': '/var/mail/cltbld', 03:53:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:07 INFO - 'MOZ_NO_REMOTE': '1', 03:53:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:07 INFO - 'NO_EM_RESTART': '1', 03:53:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:07 INFO - 'PWD': '/builds/slave/test', 03:53:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:07 INFO - 'SHELL': '/bin/bash', 03:53:07 INFO - 'SHLVL': '1', 03:53:07 INFO - 'TERM': 'linux', 03:53:07 INFO - 'TMOUT': '86400', 03:53:07 INFO - 'USER': 'cltbld', 03:53:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975', 03:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:07 INFO - '_': '/tools/buildbot/bin/python'} 03:53:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 03:53:07 INFO - mozversion application_buildid: 20160528004028 03:53:07 INFO - mozversion application_changeset: 138121c338c75865135a001fc51f7465e36f4740 03:53:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:53:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:07 INFO - mozversion application_name: Firefox 03:53:07 INFO - mozversion application_remotingname: firefox-dev 03:53:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:53:07 INFO - mozversion application_vendor: Mozilla 03:53:07 INFO - mozversion application_version: 48.0a2 03:53:07 INFO - mozversion platform_buildid: 20160528004028 03:53:07 INFO - mozversion platform_changeset: 138121c338c75865135a001fc51f7465e36f4740 03:53:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:53:07 INFO - mozversion platform_version: 48.0a2 03:53:07 INFO - using testdate: 1464432787 03:53:07 INFO - actual date: 1464432787 03:53:07 INFO - starting webserver on 'localhost:40650' 03:53:07 INFO - SUITE-START | Running 2 tests 03:53:07 INFO - TEST-START | dromaeo_css 03:53:07 INFO - operating with platform_type : linux_ 03:53:07 INFO - Initialising browser for dromaeo_css test... 03:53:07 INFO - TEST-INFO | started process 8243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrlOIb/profile http://localhost:40650/getInfo.html) 03:53:11 INFO - PROCESS | 8243 | 03:53:11 INFO - PROCESS | 8243 | (process:8322): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:53:12 INFO - PROCESS | 8243 | __metrics Screen width/height:1600/1200 03:53:12 INFO - PROCESS | 8243 | colorDepth:24 03:53:12 INFO - PROCESS | 8243 | Browser inner width/height: 1024/697 03:53:12 INFO - PROCESS | 8243 | __metrics 03:53:13 ERROR - PROCESS | 8243 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:53:14 INFO - TEST-INFO | 8243: exit 0 03:53:14 INFO - Browser initialized. 03:53:14 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:14 INFO - TEST-INFO | started process 8374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrlOIb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:15 INFO - PROCESS | 8374 | 03:53:15 INFO - PROCESS | 8374 | (process:8445): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:53:25 INFO - PROCESS | 8374 | RSS: Main: 152313856 03:53:25 INFO - PROCESS | 8374 | 03:54:15 INFO - PROCESS | 8374 | 1464432855544 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] 03:56:23 INFO - PROCESS | 8374 | Cycle 1(1): loaded http://localhost:40650/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40650/tests/dromaeo/cssquery-ext.html) 03:56:24 INFO - PROCESS | 8374 | RSS: Main: 155799552 03:56:24 INFO - PROCESS | 8374 | 03:59:26 INFO - PROCESS | 8374 | Cycle 1(1): loaded http://localhost:40650/tests/dromaeo/cssquery-ext.html (next: http://localhost:40650/tests/dromaeo/cssquery-jquery.html) 03:59:26 INFO - PROCESS | 8374 | RSS: Main: 153657344 03:59:26 INFO - PROCESS | 8374 | 04:02:28 INFO - PROCESS | 8374 | Cycle 1(1): loaded http://localhost:40650/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40650/tests/dromaeo/cssquery-mootools.html) 04:02:28 INFO - PROCESS | 8374 | RSS: Main: 153124864 04:02:28 INFO - PROCESS | 8374 | 04:05:30 INFO - PROCESS | 8374 | Cycle 1(1): loaded http://localhost:40650/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40650/tests/dromaeo/cssquery-prototype.html) 04:05:31 INFO - PROCESS | 8374 | RSS: Main: 152764416 04:05:31 INFO - PROCESS | 8374 | 04:08:33 INFO - PROCESS | 8374 | Cycle 1(1): loaded http://localhost:40650/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40650/tests/dromaeo/cssquery-yui.html) 04:08:34 INFO - PROCESS | 8374 | RSS: Main: 154636288 04:08:34 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | Cycle 1(1): loaded http://localhost:40650/tests/dromaeo/cssquery-yui.html (next: http://localhost:40650/tests/dromaeo/cssquery-dojo.html) 04:11:36 INFO - PROCESS | 8374 | RSS: Main: 156127232 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | __start_tp_report 04:11:36 INFO - PROCESS | 8374 | _x_x_mozilla_page_load 04:11:36 INFO - PROCESS | 8374 | _x_x_mozilla_page_load_details 04:11:36 INFO - PROCESS | 8374 | |i|pagename|runs| 04:11:36 INFO - PROCESS | 8374 | |0;dojo.html;3356.5133055706924;3429.5198672185898;3463.428534291842;3467.601225859027;3467.6358982306856;5605.579581531386;5665.093585026397;5672.517835983941;5675.2622159119255;5684.772609095637;5692.402297758727;5703.7148142592805;5722.713864306778;5736.598438109324;5750.7699692012375;5119.027384796886;5146.073706732786;5175.560077393426;5193.298904647881;5227.398849132361;5098.056859480989;5275.551578115846;5321.840344789663;5322.121849894782;5334.546563542084;5175.197844334134;5193.1171700810955;5231.790728370861;5318.840434786963;5323.973380133094;5186.948130518685;5219.947800521984;5221.477852214786;5223.582113430916;5233.947660523403;5087.542121209109;5120.180771076647;5120.92318615221;5179.430262671103;5205.323307969939;5429;5534.695591742453;5544.334679838405;5552.167174923794;5636.2954630671165;6095.847603809896;6100.69496525172;6117;6118.204633397674;6162.568620196588;6139.846503837395;6160.414760597736;6162.599431036968;6172.84567885802;6186.9381306186815;5583;5715.628484148517;5719.170720245541;5753.88492230153;5792.333881603585;6156.168917196211;6209.410106039919;6232.750689972441;6239.78160764371;6246.562740608205;5956.374580669054;5981.581289309794;5988.04191329394;5991.760329586855;6026.487748541423;6107.419795119546;6132.066052994178;6132.540059495555;6138.878900475427;6184.072389141665;6107.48497487111;6123.008377646986;6124.625058545644;6147.538934579924;6165.290991535941;5983.880322393527;6034.426729460694;6102.908456373158;6110.938890611037;6121.96939015311;4621.930671039937;4636.095961287517;4637.86086417408;4650.465196502446;4655.464621568563;4142.627163555295;4143.150654115899;4165.229432554987;4167.249895018926;4190.8533201337805;5877.441643043904;5890.293164820249;5900.557458190567;5971.253593300838;5988.550858685616;5943.881122377528;6084.726187321581;6121.479674227651;6141.618135919472;6145.016797312409;5810.389909059572;5814.273215848019;5834.824955251349;5837.124431335249;5910.34986151523;4944.986277813112;5093.286939828427;5118.667286626432;5132.101882170605;5167.612429067835;6310.905336419957;6350.904736428957;6357;6370.203724534434;6389.680515974275;5977.970110149421;6107.358727333655;6118.47992920589;6181.412765787243;6183.628982261079;6103.511719062553;6136.274005701014;6191.380861913773;6196.47329976957;6198.907016394848;5934.258217722785;5937.851553711192;5942.168096466585;5988.910166347421;6068.7269072892705;5980.312264089685;6027.427394397525;6044.909326360196;6084.421979911901;6133.089845874549;5999.340072592098;6037.486813620892;6044.425779550936;6047.244094488189;6087.208662873975;5915.053591425351;5936.584439089395;6017.969910150421;6018.247719035121;6056;5660.320761508646;5845.2108965290845;5860.120981852756;5927.673977931255;5944.0489521678055;5976.491998180029;5989.2812862456785;6012.128241405059;6018.21763170785;6052.6973651316375;5899.085641725539;5904.645721256738;5910.881782364415;5912.704364781658;5919.260092488439 04:11:36 INFO - PROCESS | 8374 | |1;ext.html;664.3522565498639;679.3071067511141;689.9620520871351;712.6472396163899;745.7874505765856;40608;41554.58445415545;41604.79197604016;41693.37459938096;41711;44013;44123.338149927775;44215;44630;44680.3297950531;8709.520976346299;8939;8941.239994600466;8951.507667078307;8952.955235223848;8651.351148663844;8735;8751.299896008304;9011.459312441275;9022.548872556346;9036.638534458614;9085.818283634324;9100.499472529009;9105.226055785233;9143.54282285883;8998.460092394445;9070.77323066922;9095.090490950919;9104.135107164842;9116.270698344117;8890.422122562077;8941.910580894173;8957.6864809732;8990.775230619221;9004.27965762744;42925.57074429247;43455;43488;43580.782096089635;43679;3747.5128233329765;3872.806359682033;4012.8194231259663;4272.1028583997395;4530.728156310632;33795.662043379496;34041.82979085114;34194.14514637129;34338.14154646129;34742.65257347445;4536.228841096989;4551.271796512575;4593.885152871171;4612.146752850734;4654.278586819015;328265;329313;331014;331687;333947;63918;64577.354226458076;64584.35415645877;64598;64601.67699161474;71233;72050.27949720436;72558;72586.27413725901;72744.27255727375;17712;17809.109544522722;17932.731009034615;17940.730889036677;18016.639667206582;14360.210188439527;14512.709745805025;14515.564533064025;14516.056456330305;14547.199904005382;20610.175592976113;20945.37163885086;21112.683309750366;21138.471538211666;21806.672899906513;7552.773416797505;7563;7582.35549978247;7702.8844567331535;7788.766337009899;1117.0672488472055;1129.5651174297955;1141.4292853573213;1226.3255209634665;1253.8620751717303;32604.673953260637;34167.48748768771;34312.31375372478;34367.140821479166;34947.825260874044;1136.9994404923614;1206.831043653889;1241.0815996162955;1245.4582256718356;1351.439152751597;17936.282548698167;18010;18190.636187276446;18213.81786182121;18220.45338639843;466430;555026;940773;945276;954845;65824;66487.66756166285;66540.33459665439;66597.66701166463;66910;1526.9082605936808;1537.961550961235;1540.5763415060724;1547.9690406192037;1550.852668996466;34810.30379392449;34852.47721284132;35246;35397.82301088478;35488.822555887054;56233;56622.43377566172;56762.432375675715;57381;57407;438223;441329;443833;444836;446519;31504.527432088078;31855.681443185273;32010;50813.74593127159;52498.73750631222;50408;51195;51687.48312516827;52821.7358913203;52952.47047529475;38356;38612.80693596514;38632;39371.409428859166;39382.60617393904;36853.63146368609;38231.808840955615;38530.80734596309;38778;39121.804390977864;39767;40162.79918600505;40373.59626403816;40567.3914891271;40849.59150408458;36549;37197.25605487821;37710.43434348432;37901.620983789806;38015;30219.395612087195;30355;30486.237844054078;30614.234644134074;30798.84600576983 04:11:36 INFO - PROCESS | 8374 | |2;jquery.html;423.83258612847925;425.3449687481278;431.73016864459714;434.45042021842374;440.59245198191684;19039;19329.226830926764;19487.123079461424;19689;19971.700424493643;19034.809651903477;19296.71054934177;19394.806051939475;19447.902760486213;19484.318048868292;5694.259746232984;5728.885422291552;5855.736491857855;5886.735096920638;5897.616654917438;4210.136921931012;5779.768809247625;5872.7063646817705;6289.119523266746;6564.179477565304;6484;6488.708008139645;6503.837404064912;6505.837354066162;6510.446612037958;5432.185172224178;5643.238162848004;5645.915311270334;5698.8290351289525;6357.68211589421;5507.834764957058;5517.613767036309;5520.337559492847;5545.195946587763;5731.8567035824435;12652.051096167825;12807.551735689207;12810.80783788244;12900.677483062904;12958.287294198815;2493.0526399968076;2494.9376265593505;2523.4826860493554;2555.6933168019955;2586.0431640293023;10123.493825308706;11409.030232430254;14232.146071235758;14423.350949207312;14491.130532168103;2018.7678416982087;2057.825084867788;2071.533904871407;2099.254764558575;2111.292716939827;74065.99999999946;76607;81834;82749.58625206896;83620;10697.518611662494;11083.72290692739;11511.136664750176;11576.47905844239;11609.941950290364;14946.103233806007;15035.248237588077;15181.924090379478;15195;15228.923855380652;8395.202455766692;8658.653653853775;8672.306215502746;8677.479351238946;8680.262177714965;8200.507969521848;8298.751037468886;8452.450590711584;8466.365022623328;8614.526201058876;4986.127427700138;4996.850094497171;4999.700017998859;5115.87210319745;5156.581939966539;2071.6788897720876;2140.539783946459;3546.875859344962;3583;3879.4977239680247;970.4807927758616;1046.2362475393006;1111.7887601355717;1142.3260276436943;1157.0338767129374;18407.90796046011;18556.721649175273;19110;19151.425457236306;19329.80670193308;1062.7715041266165;1062.9681109566725;1113.4989254835357;1129.3901293301526;1151.988480115205;10855.240133190759;10958.452077396098;10981.670549883516;11012.39431831257;11031.338119712682;492851;502383.97616024106;524474;527806;531508;86708;87077.56461217653;88783.55608221918;91494.54252728693;92254;1088.3469918049266;1097.957798494815;1101.9944900275607;1103.6082190822303;1113.4432783608195;17012.234449449556;17153.485395438158;17305.30778768835;17327.653446930737;17486.73769893478;39420;39500.2099958005;40100.3984940232;40178.59821401865;41022.38466422947;56549.71725141348;56890.715546422005;56909.715451422475;57154.42845571491;57760;8329.583520824055;8611.095834937492;8646.610902509276;8732.65069397217;8794.60424280896;12475.438605262603;13565.321733913068;13584.79622805639;13585.32073396346;13973.301334933416;11310.94344528272;11727.648170554898;11740.295582265091;11805.645830625095;11956.521739130338;11172.720681983015;11192.720181995515;11279.266847654877;11509.884901150881;11562;10981.945090274497;11066.667999960015;11131.83302250483;11210;11279.943600281946;8223.342132629496;8678.566071696516;8710.346723995599;8743.912560874563;9118.40730352525;11035.282706624044;11979.460924258603;12009.219400738924;12064.75870482568;12141.392930353624 04:11:36 INFO - PROCESS | 8374 | |3;mootools.html;1549.3105568022227;1555.0902721907682;1806.6386722655473;1919.4145785535425;1923.249932526315;6874.415674667659;8094.392920530954;8114.472559283649;8288.502689838606;8368.665253389865;8035.236652518016;8036.075851277104;8062;8100.635471403786;8110.107888132316;2424.466617344186;2444.4377793107506;2449.081594402099;2465.8890349934204;2466.90132394704;2399.8574342118345;2450.473148273121;2460.889259983296;2461.237016524874;2465.3220364399845;2423.1882319422925;2424.418139646481;2437.85372877627;2453.914113006045;2469.6789417375717;2444.046821739523;2448.1309135256906;2450.1791899713617;2454;2487.676602041723;2440.633904914277;2451.6322551617222;2473.3445636906235;2475.220305603747;2497.950040999188;8269.338452923752;8288.21261980111;8298.958505207496;8327.458715183493;8338.166183381674;5095.719735414551;5163.690178589259;5170.121079416471;5176;5193.9740301298625;3425.7773244739014;3499.5275637788827;3518.5249991251367;3531.329047480996;3545.6099829018785;1105.3367979212408;1137.7212582917239;1170.9824352634716;1177.8939895409455;1195.8863907928733;11609;11637.592684256095;11671.424357711685;11708.824367634492;11712.941435292854;4736.786844592001;4776.498467660915;4779.569838714463;4782.545658162469;4896.1921282987905;9992;10021.29850910444;10046.14607758334;10059.899401005896;10101.242406819518;5312.73436328182;5340.279062326536;5358.490943360374;5360.946390536123;5364.4099149094345;4029.9798501007895;4685.109829132454;4771.594414474739;4777.808887644455;4793.832215872428;4101.138760860253;4137.81379837908;4186.916261674811;4230.175115852441;4232.555581663881;1365.9795103073461;1375;1375.532319011541;1376.1742954227384;1393.9163650181022;971.2521358554015;1091.1543553745753;1102.101787043557;1109.6449136276476;1114.9888501114885;6125.203723516003;6177.857096437174;6182.721777520022;6204.37956204385;6247.437730604177;504.10772931911043;506.399916099416;508.2046597075565;509.1471784760511;516.073647802196;4271.615554600101;4284.357346398003;4310.590493903074;4335.7181783184;4337.349397590387;9871.950640246752;10118.139958103644;10177.084062434416;10211.336263143021;10217.33587316822;9948.850767238497;9957.551910163915;10021.649242276631;10067.446290454096;10077.899221007696;7421.2207718190975;7822.865684475833;7936.4047696423;7948.761537153895;7975.481593696391;5895.64626122434;5910.320313163869;5925.111233315038;5968.253968253968;6022.307434644897;8983.640654374014;9067.27461803041;9071.591778369857;9097.727068187965;9142.588583513625;9150.908490915272;9436.103570160823;9686.85469717969;9721.270904682036;9730.221582273543;6606.339366063356;7250.9637451812405;7490.475666703279;7505.249475052451;7564;7856.7250146244605;7900.68397264126;7902.960485197537;7905.56519391439;7980.241877021674;7117.537360071578;7246.275372462712;7277.854442911006;7340.559566426032;7340.926590734024;7220.3140701633265;7255.818604534928;7274.30894065063;7278.67245973943;7289.744858929912;6866.759663411756;6913.343232392915;6970.756023539355;6985.441164706913;7002.929970700227;4997.475265097112;5070.41690205631;5078.492150784892;5143.665661731976;5185.637005409585;5123.487651234846;5186.481351864783;5223.4515375884985;5223.895522089613;5301.469853014668 04:11:36 INFO - PROCESS | 8374 | |4;prototype.html;347.8539013614282;359.8686479435006;364.7957143999359;365.16195331713715;365.2803976166952;6595.944648856184;6707.094542236802;6718.7984360469145;6808.8978665320055;6809.931900680992;6670.833229169261;6678.866422671544;6719.0593316935665;6721.932780672192;6736.326367363261;5131.512506311904;5134.845954621367;5136.460671629481;5140.074786538422;5146.150885103953;5155.329807125068;5155.40712818027;5160.896782064357;5164.457731938149;5171.146760784466;5089.211172268286;5098.056859481007;5104.412992505872;5110.105731496992;5111.437741848394;5000.374953130859;5065.569426598743;5082.390113186404;5089.6691715038405;5106.055379754739;4447.266201076818;4452.087322098994;4463.152001119809;4467.888302792424;4486.394336764561;6360.9045864312075;6391.488680905516;6404.327545607737;6407.967960160216;6408.58344207625;5887.1463637772285;5895.764169433218;5930.703464826742;5943.3165186003735;5944.791932282349;6969.7909062727695;7022.508424410242;7025.718971241145;7031.171895307206;7045.9350182670705;4515.887102822423;4632.490426053131;4663.813447462097;4944.258361245842;4949.109160351135;7197.100362454693;7221.42228621709;7270.127584689765;7309.305615966475;7312.561246325185;4890.584300334512;4891.584215341736;4896.167651499253;4897.069556784199;4897.534734200245;4958.504149585013;4960.429550601655;4962.776675049631;4964.67729597575;4975.751212439436;5775.48020678141;5777.277840269966;5777.422257774189;5781.653100813965;5784.797532086357;6879.346462086094;6992.1958974717545;7041.295870413021;7056.6118863463;7068.787936361918;1701.6086300151035;1708.9829101709072;1717.9742303865453;1723.758673785671;1728.110023337982;1066.5147357952112;1115.9553617855356;1118.3513562134106;1133.7789131119353;1134.0813940708053;6711.496637752188;6975.651217439107;6985.511014228955;6986.266442023616;6993.230744618189;7304.452166087564;7349.191588925214;7350.044494215717;7365.079365079365;7371.447141464411;6828;6828.6927088281145;6864.073350097773;6876.277990810893;6886.414654754301;3914.530256369197;3939.783311917815;3958.2281455116554;3971.602839716063;3982.980085099556;7600;7602.847943041219;7607.847843043108;7614.619269036526;7617.047869016373;7352.77941661751;7376.114866216089;7400.407967362598;7409.592472413961;7451;7554.471187016966;7557.773266802004;7560.962195189099;7568.243175682498;7573.318401343906;7166.355028047501;7317.414606831334;7329.377002954595;7330.926690733025;7350.52221605594;7221.0251616033265;7227.674754635948;7238.963805180941;7255.854882902418;7260.201377848327;7525.623718814147;7578.166401695698;7580.090389153337;7583.9620801895635;7591.4685971983645;4796.928046079382;4826.251930950708;4827.8551643450755;4831.830885918976;4836.46798852119;7136.357727804522;7243.348098670934;7279.381252593589;7314.049173607397;7324.19433862264;7060.682269297997;7063.187733410724;7111.893321600077;7114.466415018791;7123.112375220674;6998.860022799618;7025.613591252531;7033.964830175816;7041.225465198721;7056.647167641495;6861.176658800976;6902.378785909293;6922.58464492132;6942.097527321416;6949.583025018515;6960.860782784417;7105.396041336544;7112.466565007541;7116.683413568507;7118.644067796693;6681.164854393201;6812.523123381316;6931.653417329214;6985.930140698528;6990.09128813251 04:11:36 INFO - PROCESS | 8374 | |5;yui.html;710.5310495073253;779.7855589712829;820.2453742556847;833.8374017066673;864.8140649760302;14612.269386530657;14743.631409214762;14945.775813362809;14975.925120374397;15009.249537523121;14221.928890355559;14386.568402947902;14401.63995900103;14422.567322980301;14425.42298308069;738.1732459645204;918.912703293186;927.0682963621551;933.4539294512718;936.0405584276103;915.5330781301551;916.9449833010008;917.7017469322464;922.6355589542127;927.0266220468515;979.9853002204973;986.5461887531744;986.960521579136;988.7280997725611;988.79235360574;979.8481235408523;980.6028558433845;981.7251169672468;981.7692842182117;981.9509024548744;718.5868125827618;723.2550473012806;723.3345322303494;723.5622448418684;726.1685370251085;14128.646783830383;14144.787828182585;14159.292035398292;14192.716145677132;14197.929010354985;14706.485273015393;14757.114573125647;14767.92616036913;14861.108333500024;14906.850931490762;11934.522619095225;12089.214201076902;12182.695432614168;12205.938970305091;12335.876641233563;4036.9596304036877;4060.553339132693;4111.239420707178;4135.710500264982;4136.544980052192;57438.71280643612;57738.42261577372;58083.41916580865;58210.417895821345;58651.12023319654;11886.40567971598;11942.940285298519;12151.939240303742;12169.148159628918;12225.510979560895;20375.18499260013;20432;20461.795382046286;20463.38609841707;20554.17783288652;8458.74623761288;8729.869051964226;8872.689455869013;8918.910810891808;9086.636534538544;4970.353853998957;4983;5048.495150484996;5081.491850814963;5084.186530155157;3649.7810131392202;3656.0859785053735;3659.7255205859665;3688.63113688629;3699.9815000924823;595.3153873046032;607.7690477618565;610.7251736718495;638.8211300835774;647.5467172978933;811.5860910935347;823.275517544569;847.4618617178136;849.2993280543453;856.9271611913057;9532.666356677622;9898.505074746234;9948.204143668489;9988.900110998942;10195.949020254851;766.2375935943771;779.2324560308092;814.861473549498;854.0477367735054;859.9871001934976;4562.315652652129;4677.4854765975715;4720.291956206596;4764.690295130806;4779.814377102859;67023.66488167529;69154;69179.65410173018;69305.3069469309;69502.65248673825;54340.18489722657;55709;57319.42680573141;57400.71299643475;61612.38387616067;53908.730456348254;54370.45629543733;54700.179497307574;54740.45259547433;54866.725666370614;9085.818283634422;9322.207612353026;9419.387739796892;9454.527273636428;9502.47736374506;38094.809525952194;38322.233555329294;38693.613063869;39623.40564891471;39683.80158099191;46002.53997459982;46412.76793616146;49957.00085998187;50876.49123508866;51256.48743512517;11785.823212651645;12173.573924912585;12236.571719989757;12371.453568303961;12609.621711348675;12829.42267597979;12917.677058073623;12922;12985.805212921625;13370.264635444755;12046.75906481848;12286.447109880255;12501.624951251477;12575.87424125747;12596.307203103917;11864.703382415508;12041.638750837488;12231.082668800054;12645.557405490763;12712.237265764084;11764.176507644383;11899.524019039141;12004.879951200377;12099.395030248277;12413.689657758629;10329.12202462799;10469.790604188025;10581;10690.41202733857;11065;10388.22674273882;10427.739306517095;10466.947665261625;10472.895271047497;10520.526576304237 04:11:36 INFO - PROCESS | 8374 | __end_tp_report 04:11:36 INFO - PROCESS | 8374 | __start_cc_report 04:11:36 INFO - PROCESS | 8374 | _x_x_mozilla_cycle_collect,344 04:11:36 INFO - PROCESS | 8374 | __end_cc_report 04:11:36 INFO - PROCESS | 8374 | __startTimestamp1464433896470__endTimestamp 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | ------- Summary: start ------- 04:11:36 INFO - PROCESS | 8374 | Number of tests: 6 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | [#0] dojo.html Cycles:165 Average:5671.64 Median:5927.67 stddev:632.74 (10.7%) stddev-sans-first:608.05 04:11:36 INFO - PROCESS | 8374 | Values: 3356.5 3429.5 3463.4 3467.6 3467.6 5605.6 5665.1 5672.5 5675.3 5684.8 5692.4 5703.7 5722.7 5736.6 5750.8 5119.0 5146.1 5175.6 5193.3 5227.4 5098.1 5275.6 5321.8 5322.1 5334.5 5175.2 5193.1 5231.8 5318.8 5324.0 5186.9 5219.9 5221.5 5223.6 5233.9 5087.5 5120.2 5120.9 5179.4 5205.3 5429.0 5534.7 5544.3 5552.2 5636.3 6095.8 6100.7 6117.0 6118.2 6162.6 6139.8 6160.4 6162.6 6172.8 6186.9 5583.0 5715.6 5719.2 5753.9 5792.3 6156.2 6209.4 6232.8 6239.8 6246.6 5956.4 5981.6 5988.0 5991.8 6026.5 6107.4 6132.1 6132.5 6138.9 6184.1 6107.5 6123.0 6124.6 6147.5 6165.3 5983.9 6034.4 6102.9 6110.9 6122.0 4621.9 4636.1 4637.9 4650.5 4655.5 4142.6 4143.2 4165.2 4167.2 4190.9 5877.4 5890.3 5900.6 5971.3 5988.6 5943.9 6084.7 6121.5 6141.6 6145.0 5810.4 5814.3 5834.8 5837.1 5910.3 4945.0 5093.3 5118.7 5132.1 5167.6 6310.9 6350.9 6357.0 6370.2 6389.7 5978.0 6107.4 6118.5 6181.4 6183.6 6103.5 6136.3 6191.4 6196.5 6198.9 5934.3 5937.9 5942.2 5988.9 6068.7 5980.3 6027.4 6044.9 6084.4 6133.1 5999.3 6037.5 6044.4 6047.2 6087.2 5915.1 5936.6 6018.0 6018.2 6056.0 5660.3 5845.2 5860.1 5927.7 5944.0 5976.5 5989.3 6012.1 6018.2 6052.7 5899.1 5904.6 5910.9 5912.7 5919.3 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | [#1] ext.html Cycles:180 Average:68150.90 Median:22991.55 stddev:151430.12 (658.6%) stddev-sans-first:151770.15 04:11:36 INFO - PROCESS | 8374 | Values: 664.4 679.3 690.0 712.6 745.8 40608.0 41554.6 41604.8 41693.4 41711.0 44013.0 44123.3 44215.0 44630.0 44680.3 8709.5 8939.0 8941.2 8951.5 8953.0 8651.4 8735.0 8751.3 9011.5 9022.5 9036.6 9085.8 9100.5 9105.2 9143.5 8998.5 9070.8 9095.1 9104.1 9116.3 8890.4 8941.9 8957.7 8990.8 9004.3 42925.6 43455.0 43488.0 43580.8 43679.0 3747.5 3872.8 4012.8 4272.1 4530.7 33795.7 34041.8 34194.1 34338.1 34742.7 4536.2 4551.3 4593.9 4612.1 4654.3 328265.0 329313.0 331014.0 331687.0 333947.0 63918.0 64577.4 64584.4 64598.0 64601.7 71233.0 72050.3 72558.0 72586.3 72744.3 17712.0 17809.1 17932.7 17940.7 18016.6 14360.2 14512.7 14515.6 14516.1 14547.2 20610.2 20945.4 21112.7 21138.5 21806.7 7552.8 7563.0 7582.4 7702.9 7788.8 1117.1 1129.6 1141.4 1226.3 1253.9 32604.7 34167.5 34312.3 34367.1 34947.8 1137.0 1206.8 1241.1 1245.5 1351.4 17936.3 18010.0 18190.6 18213.8 18220.5 466430.0 555026.0 940773.0 945276.0 954845.0 65824.0 66487.7 66540.3 66597.7 66910.0 1526.9 1538.0 1540.6 1548.0 1550.9 34810.3 34852.5 35246.0 35397.8 35488.8 56233.0 56622.4 56762.4 57381.0 57407.0 438223.0 441329.0 443833.0 444836.0 446519.0 31504.5 31855.7 32010.0 50813.7 52498.7 50408.0 51195.0 51687.5 52821.7 52952.5 38356.0 38612.8 38632.0 39371.4 39382.6 36853.6 38231.8 38530.8 38778.0 39121.8 39767.0 40162.8 40373.6 40567.4 40849.6 36549.0 37197.3 37710.4 37901.6 38015.0 30219.4 30355.0 30486.2 30614.2 30798.8 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | [#2] jquery.html Cycles:180 Average:29435.84 Median:2316.80 stddev:84852.45 (3662.5%) stddev-sans-first:85062.52 04:11:36 INFO - PROCESS | 8374 | Values: 423.8 425.3 431.7 434.5 440.6 19039.0 19329.2 19487.1 19689.0 19971.7 19034.8 19296.7 19394.8 19447.9 19484.3 5694.3 5728.9 5855.7 5886.7 5897.6 4210.1 5779.8 5872.7 6289.1 6564.2 6484.0 6488.7 6503.8 6505.8 6510.4 5432.2 5643.2 5645.9 5698.8 6357.7 5507.8 5517.6 5520.3 5545.2 5731.9 12652.1 12807.6 12810.8 12900.7 12958.3 2493.1 2494.9 2523.5 2555.7 2586.0 10123.5 11409.0 14232.1 14423.4 14491.1 2018.8 2057.8 2071.5 2099.3 2111.3 74066.0 76607.0 81834.0 82749.6 83620.0 10697.5 11083.7 11511.1 11576.5 11609.9 14946.1 15035.2 15181.9 15195.0 15228.9 8395.2 8658.7 8672.3 8677.5 8680.3 8200.5 8298.8 8452.5 8466.4 8614.5 4986.1 4996.9 4999.7 5115.9 5156.6 2071.7 2140.5 3546.9 3583.0 3879.5 970.5 1046.2 1111.8 1142.3 1157.0 18407.9 18556.7 19110.0 19151.4 19329.8 1062.8 1063.0 1113.5 1129.4 1152.0 10855.2 10958.5 10981.7 11012.4 11031.3 492851.0 502384.0 524474.0 527806.0 531508.0 86708.0 87077.6 88783.6 91494.5 92254.0 1088.3 1098.0 1102.0 1103.6 1113.4 17012.2 17153.5 17305.3 17327.7 17486.7 39420.0 39500.2 40100.4 40178.6 41022.4 56549.7 56890.7 56909.7 57154.4 57760.0 8329.6 8611.1 8646.6 8732.7 8794.6 12475.4 13565.3 13584.8 13585.3 13973.3 11310.9 11727.6 11740.3 11805.6 11956.5 11172.7 11192.7 11279.3 11509.9 11562.0 10981.9 11066.7 11131.8 11210.0 11279.9 8223.3 8678.6 8710.3 8743.9 9118.4 11035.3 11979.5 12009.2 12064.8 12141.4 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | [#3] mootools.html Cycles:180 Average:5604.25 Median:508.68 stddev:3005.09 (590.8%) stddev-sans-first:2998.07 04:11:36 INFO - PROCESS | 8374 | Values: 1549.3 1555.1 1806.6 1919.4 1923.2 6874.4 8094.4 8114.5 8288.5 8368.7 8035.2 8036.1 8062.0 8100.6 8110.1 2424.5 2444.4 2449.1 2465.9 2466.9 2399.9 2450.5 2460.9 2461.2 2465.3 2423.2 2424.4 2437.9 2453.9 2469.7 2444.0 2448.1 2450.2 2454.0 2487.7 2440.6 2451.6 2473.3 2475.2 2498.0 8269.3 8288.2 8299.0 8327.5 8338.2 5095.7 5163.7 5170.1 5176.0 5194.0 3425.8 3499.5 3518.5 3531.3 3545.6 1105.3 1137.7 1171.0 1177.9 1195.9 11609.0 11637.6 11671.4 11708.8 11712.9 4736.8 4776.5 4779.6 4782.5 4896.2 9992.0 10021.3 10046.1 10059.9 10101.2 5312.7 5340.3 5358.5 5360.9 5364.4 4030.0 4685.1 4771.6 4777.8 4793.8 4101.1 4137.8 4186.9 4230.2 4232.6 1366.0 1375.0 1375.5 1376.2 1393.9 971.3 1091.2 1102.1 1109.6 1115.0 6125.2 6177.9 6182.7 6204.4 6247.4 504.1 506.4 508.2 509.1 516.1 4271.6 4284.4 4310.6 4335.7 4337.3 9872.0 10118.1 10177.1 10211.3 10217.3 9948.9 9957.6 10021.6 10067.4 10077.9 7421.2 7822.9 7936.4 7948.8 7975.5 5895.6 5910.3 5925.1 5968.3 6022.3 8983.6 9067.3 9071.6 9097.7 9142.6 9150.9 9436.1 9686.9 9721.3 9730.2 6606.3 7251.0 7490.5 7505.2 7564.0 7856.7 7900.7 7903.0 7905.6 7980.2 7117.5 7246.3 7277.9 7340.6 7340.9 7220.3 7255.8 7274.3 7278.7 7289.7 6866.8 6913.3 6970.8 6985.4 7002.9 4997.5 5070.4 5078.5 5143.7 5185.6 5123.5 5186.5 5223.5 5223.9 5301.5 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | [#4] prototype.html Cycles:180 Average:5899.96 Median:6809.41 stddev:1802.48 (26.5%) stddev-sans-first:1758.71 04:11:36 INFO - PROCESS | 8374 | Values: 347.9 359.9 364.8 365.2 365.3 6595.9 6707.1 6718.8 6808.9 6809.9 6670.8 6678.9 6719.1 6721.9 6736.3 5131.5 5134.8 5136.5 5140.1 5146.2 5155.3 5155.4 5160.9 5164.5 5171.1 5089.2 5098.1 5104.4 5110.1 5111.4 5000.4 5065.6 5082.4 5089.7 5106.1 4447.3 4452.1 4463.2 4467.9 4486.4 6360.9 6391.5 6404.3 6408.0 6408.6 5887.1 5895.8 5930.7 5943.3 5944.8 6969.8 7022.5 7025.7 7031.2 7045.9 4515.9 4632.5 4663.8 4944.3 4949.1 7197.1 7221.4 7270.1 7309.3 7312.6 4890.6 4891.6 4896.2 4897.1 4897.5 4958.5 4960.4 4962.8 4964.7 4975.8 5775.5 5777.3 5777.4 5781.7 5784.8 6879.3 6992.2 7041.3 7056.6 7068.8 1701.6 1709.0 1718.0 1723.8 1728.1 1066.5 1116.0 1118.4 1133.8 1134.1 6711.5 6975.7 6985.5 6986.3 6993.2 7304.5 7349.2 7350.0 7365.1 7371.4 6828.0 6828.7 6864.1 6876.3 6886.4 3914.5 3939.8 3958.2 3971.6 3983.0 7600.0 7602.8 7607.8 7614.6 7617.0 7352.8 7376.1 7400.4 7409.6 7451.0 7554.5 7557.8 7561.0 7568.2 7573.3 7166.4 7317.4 7329.4 7330.9 7350.5 7221.0 7227.7 7239.0 7255.9 7260.2 7525.6 7578.2 7580.1 7584.0 7591.5 4796.9 4826.3 4827.9 4831.8 4836.5 7136.4 7243.3 7279.4 7314.0 7324.2 7060.7 7063.2 7111.9 7114.5 7123.1 6998.9 7025.6 7034.0 7041.2 7056.6 6861.2 6902.4 6922.6 6942.1 6949.6 6960.9 7105.4 7112.5 7116.7 7118.6 6681.2 6812.5 6931.7 6985.9 6990.1 04:11:36 INFO - PROCESS | 8374 | 04:11:36 INFO - PROCESS | 8374 | [#5] yui.html Cycles:180 Average:15709.20 Median:4742.49 stddev:18526.34 (390.6%) stddev-sans-first:18544.08 04:11:36 INFO - PROCESS | 8374 | Values: 710.5 779.8 820.2 833.8 864.8 14612.3 14743.6 14945.8 14975.9 15009.2 14221.9 14386.6 14401.6 14422.6 14425.4 738.2 918.9 927.1 933.5 936.0 915.5 916.9 917.7 922.6 927.0 980.0 986.5 987.0 988.7 988.8 979.8 980.6 981.7 981.8 982.0 718.6 723.3 723.3 723.6 726.2 14128.6 14144.8 14159.3 14192.7 14197.9 14706.5 14757.1 14767.9 14861.1 14906.9 11934.5 12089.2 12182.7 12205.9 12335.9 4037.0 4060.6 4111.2 4135.7 4136.5 57438.7 57738.4 58083.4 58210.4 58651.1 11886.4 11942.9 12151.9 12169.1 12225.5 20375.2 20432.0 20461.8 20463.4 20554.2 8458.7 8729.9 8872.7 8918.9 9086.6 4970.4 4983.0 5048.5 5081.5 5084.2 3649.8 3656.1 3659.7 3688.6 3700.0 595.3 607.8 610.7 638.8 647.5 811.6 823.3 847.5 849.3 856.9 9532.7 9898.5 9948.2 9988.9 10195.9 766.2 779.2 814.9 854.0 860.0 4562.3 4677.5 4720.3 4764.7 4779.8 67023.7 69154.0 69179.7 69305.3 69502.7 54340.2 55709.0 57319.4 57400.7 61612.4 53908.7 54370.5 54700.2 54740.5 54866.7 9085.8 9322.2 9419.4 9454.5 9502.5 38094.8 38322.2 38693.6 39623.4 39683.8 46002.5 46412.8 49957.0 50876.5 51256.5 11785.8 12173.6 12236.6 12371.5 12609.6 12829.4 12917.7 12922.0 12985.8 13370.3 12046.8 12286.4 12501.6 12575.9 12596.3 11864.7 12041.6 12231.1 12645.6 12712.2 11764.2 11899.5 12004.9 12099.4 12413.7 10329.1 10469.8 10581.0 10690.4 11065.0 10388.2 10427.7 10466.9 10472.9 10520.5 04:11:36 INFO - PROCESS | 8374 | -------- Summary: end -------- 04:11:36 INFO - PROCESS | 8374 | 04:11:37 INFO - TEST-INFO | 8374: exit 0 04:11:37 INFO - TEST-OK | dromaeo_css | took 1109133ms 04:11:37 INFO - TEST-START | kraken 04:11:37 INFO - operating with platform_type : linux_ 04:11:37 INFO - Initialising browser for kraken test... 04:11:37 INFO - TEST-INFO | started process 8609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFxwXsW/profile http://localhost:40650/getInfo.html) 04:11:40 INFO - PROCESS | 8609 | 04:11:40 INFO - PROCESS | 8609 | (process:8690): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:11:41 INFO - PROCESS | 8609 | __metrics Screen width/height:1600/1200 04:11:41 INFO - PROCESS | 8609 | colorDepth:24 04:11:41 INFO - PROCESS | 8609 | Browser inner width/height: 1024/697 04:11:41 INFO - PROCESS | 8609 | __metrics 04:11:42 ERROR - PROCESS | 8609 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:11:42 INFO - TEST-INFO | 8609: exit 0 04:11:42 INFO - Browser initialized. 04:11:42 INFO - Running cycle 1/1 for kraken test... 04:11:42 INFO - TEST-INFO | started process 8741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFxwXsW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:44 INFO - PROCESS | 8741 | 04:11:44 INFO - PROCESS | 8741 | (process:8813): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:11:54 INFO - PROCESS | 8741 | RSS: Main: 152055808 04:11:54 INFO - PROCESS | 8741 | 04:11:57 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40650/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:58 INFO - PROCESS | 8741 | RSS: Main: 156712960 04:11:58 INFO - PROCESS | 8741 | 04:12:00 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40650/tests/kraken/driver.html?testName=audio-dft) 04:12:01 INFO - PROCESS | 8741 | RSS: Main: 156831744 04:12:01 INFO - PROCESS | 8741 | 04:12:04 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40650/tests/kraken/driver.html?testName=audio-fft) 04:12:04 INFO - PROCESS | 8741 | RSS: Main: 157847552 04:12:04 INFO - PROCESS | 8741 | 04:12:06 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40650/tests/kraken/driver.html?testName=audio-oscillator) 04:12:07 INFO - PROCESS | 8741 | RSS: Main: 156991488 04:12:07 INFO - PROCESS | 8741 | 04:12:09 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40650/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:10 INFO - PROCESS | 8741 | RSS: Main: 156938240 04:12:10 INFO - PROCESS | 8741 | 04:12:13 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40650/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:13 INFO - PROCESS | 8741 | RSS: Main: 157138944 04:12:13 INFO - PROCESS | 8741 | 04:12:17 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40650/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:17 INFO - PROCESS | 8741 | RSS: Main: 157044736 04:12:17 INFO - PROCESS | 8741 | 04:12:20 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40650/tests/kraken/driver.html?testName=json-parse-financial) 04:12:21 INFO - PROCESS | 8741 | RSS: Main: 157806592 04:12:21 INFO - PROCESS | 8741 | 04:12:22 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40650/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:23 INFO - PROCESS | 8741 | RSS: Main: 157106176 04:12:23 INFO - PROCESS | 8741 | 04:12:25 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:25 INFO - PROCESS | 8741 | RSS: Main: 157581312 04:12:25 INFO - PROCESS | 8741 | 04:12:27 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:28 INFO - PROCESS | 8741 | RSS: Main: 157642752 04:12:28 INFO - PROCESS | 8741 | 04:12:30 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:31 INFO - PROCESS | 8741 | RSS: Main: 158310400 04:12:31 INFO - PROCESS | 8741 | 04:12:34 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:35 INFO - PROCESS | 8741 | RSS: Main: 157999104 04:12:35 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | Cycle 1(1): loaded http://localhost:40650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40650/tests/kraken/driver.html?testName=ai-astar) 04:12:36 INFO - PROCESS | 8741 | RSS: Main: 159084544 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | __start_tp_report 04:12:36 INFO - PROCESS | 8741 | _x_x_mozilla_page_load 04:12:36 INFO - PROCESS | 8741 | _x_x_mozilla_page_load_details 04:12:36 INFO - PROCESS | 8741 | |i|pagename|runs| 04:12:36 INFO - PROCESS | 8741 | |0;ai-astar;111;111;103;108;110;112;104;110;112;110 04:12:36 INFO - PROCESS | 8741 | |1;audio-beat-detection;159;127;159;179;146;154;152;130;195;134 04:12:36 INFO - PROCESS | 8741 | |2;audio-dft;164;165;164;162;163;163;161;164;165;163 04:12:36 INFO - PROCESS | 8741 | |3;audio-fft;74;74;76;174;75;73;75;76;165;75 04:12:36 INFO - PROCESS | 8741 | |4;audio-oscillator;92;94;149;94;92;92;137;91;93;140 04:12:36 INFO - PROCESS | 8741 | |5;imaging-gaussian-blur;117;117;117;118;118;118;118;117;117;117 04:12:36 INFO - PROCESS | 8741 | |6;imaging-darkroom;146;146;146;149;147;146;145;146;147;147 04:12:36 INFO - PROCESS | 8741 | |7;imaging-desaturate;96;95;95;97;95;95;95;95;98;95 04:12:36 INFO - PROCESS | 8741 | |8;json-parse-financial;57;57;58;59;59;58;58;80;56;56 04:12:36 INFO - PROCESS | 8741 | |9;json-stringify-tinderbox;59;59;59;59;59;59;59;59;58;59 04:12:36 INFO - PROCESS | 8741 | |10;stanford-crypto-aes;74;74;74;75;75;75;76;75;74;74 04:12:36 INFO - PROCESS | 8741 | |11;stanford-crypto-ccm;123;113;117;127;115;122;114;120;128;143 04:12:36 INFO - PROCESS | 8741 | |12;stanford-crypto-pbkdf2;168;161;175;163;164;169;163;160;165;157 04:12:36 INFO - PROCESS | 8741 | |13;stanford-crypto-sha256-iterative;69;68;67;66;68;67;66;66;67;70 04:12:36 INFO - PROCESS | 8741 | __end_tp_report 04:12:36 INFO - PROCESS | 8741 | __start_cc_report 04:12:36 INFO - PROCESS | 8741 | _x_x_mozilla_cycle_collect,834 04:12:36 INFO - PROCESS | 8741 | __end_cc_report 04:12:36 INFO - PROCESS | 8741 | __startTimestamp1464433956932__endTimestamp 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | ------- Summary: start ------- 04:12:36 INFO - PROCESS | 8741 | Number of tests: 14 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.18 (2.9%) stddev-sans-first:3.30 04:12:36 INFO - PROCESS | 8741 | Values: 111.0 111.0 103.0 108.0 110.0 112.0 104.0 110.0 112.0 110.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#1] audio-beat-detection Cycles:10 Average:153.50 Median:156.50 stddev:21.41 (13.7%) stddev-sans-first:22.62 04:12:36 INFO - PROCESS | 8741 | Values: 159.0 127.0 159.0 179.0 146.0 154.0 152.0 130.0 195.0 134.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 04:12:36 INFO - PROCESS | 8741 | Values: 164.0 165.0 164.0 162.0 163.0 163.0 161.0 164.0 165.0 163.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:40.02 (53.4%) stddev-sans-first:41.80 04:12:36 INFO - PROCESS | 8741 | Values: 74.0 74.0 76.0 174.0 75.0 73.0 75.0 76.0 165.0 75.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:92.00 stddev:24.07 (26.2%) stddev-sans-first:24.88 04:12:36 INFO - PROCESS | 8741 | Values: 92.0 94.0 149.0 94.0 92.0 92.0 137.0 91.0 93.0 140.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:12:36 INFO - PROCESS | 8741 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 117.0 117.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 04:12:36 INFO - PROCESS | 8741 | Values: 146.0 146.0 146.0 149.0 147.0 146.0 145.0 146.0 147.0 147.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.07 (1.1%) stddev-sans-first:1.13 04:12:36 INFO - PROCESS | 8741 | Values: 96.0 95.0 95.0 97.0 95.0 95.0 95.0 95.0 98.0 95.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:58.00 stddev:7.18 (12.4%) stddev-sans-first:7.54 04:12:36 INFO - PROCESS | 8741 | Values: 57.0 57.0 58.0 59.0 59.0 58.0 58.0 80.0 56.0 56.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:12:36 INFO - PROCESS | 8741 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:75.00 stddev:0.70 (0.9%) stddev-sans-first:0.71 04:12:36 INFO - PROCESS | 8741 | Values: 74.0 74.0 74.0 75.0 75.0 75.0 76.0 75.0 74.0 74.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:122.50 stddev:8.98 (7.3%) stddev-sans-first:9.52 04:12:36 INFO - PROCESS | 8741 | Values: 123.0 113.0 117.0 127.0 115.0 122.0 114.0 120.0 128.0 143.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:5.13 (3.1%) stddev-sans-first:5.28 04:12:36 INFO - PROCESS | 8741 | Values: 168.0 161.0 175.0 163.0 164.0 169.0 163.0 160.0 165.0 157.0 04:12:36 INFO - PROCESS | 8741 | 04:12:36 INFO - PROCESS | 8741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.30 04:12:36 INFO - PROCESS | 8741 | Values: 69.0 68.0 67.0 66.0 68.0 67.0 66.0 66.0 67.0 70.0 04:12:36 INFO - PROCESS | 8741 | -------- Summary: end -------- 04:12:36 INFO - PROCESS | 8741 | 04:12:37 INFO - TEST-INFO | 8741: exit 0 04:12:37 INFO - TEST-OK | kraken | took 60774ms 04:12:37 INFO - SUITE-END | took 1169s 04:12:38 INFO - Completed test suite (00:19:30) 04:12:38 INFO - javascript benchmark 04:12:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.5133055706924, 3429.5198672185898, 3463.428534291842, 3467.601225859027, 3467.6358982306856, 5605.579581531386, 5665.093585026397, 5672.517835983941, 5675.2622159119255, 5684.772609095637, 5692.402297758727, 5703.7148142592805, 5722.713864306778, 5736.598438109324, 5750.7699692012375, 5119.027384796886, 5146.073706732786, 5175.560077393426, 5193.298904647881, 5227.398849132361, 5098.056859480989, 5275.551578115846, 5321.840344789663, 5322.121849894782, 5334.546563542084, 5175.197844334134, 5193.1171700810955, 5231.790728370861, 5318.840434786963, 5323.973380133094, 5186.948130518685, 5219.947800521984, 5221.477852214786, 5223.582113430916, 5233.947660523403, 5087.542121209109, 5120.180771076647, 5120.92318615221, 5179.430262671103, 5205.323307969939, 5429.0, 5534.695591742453, 5544.334679838405, 5552.167174923794, 5636.2954630671165, 6095.847603809896, 6100.69496525172, 6117.0, 6118.204633397674, 6162.568620196588, 6139.846503837395, 6160.414760597736, 6162.599431036968, 6172.84567885802, 6186.9381306186815, 5583.0, 5715.628484148517, 5719.170720245541, 5753.88492230153, 5792.333881603585, 6156.168917196211, 6209.410106039919, 6232.750689972441, 6239.78160764371, 6246.562740608205, 5956.374580669054, 5981.581289309794, 5988.04191329394, 5991.760329586855, 6026.487748541423, 6107.419795119546, 6132.066052994178, 6132.540059495555, 6138.878900475427, 6184.072389141665, 6107.48497487111, 6123.008377646986, 6124.625058545644, 6147.538934579924, 6165.290991535941, 5983.880322393527, 6034.426729460694, 6102.908456373158, 6110.938890611037, 6121.96939015311, 4621.930671039937, 4636.095961287517, 4637.86086417408, 4650.465196502446, 4655.464621568563, 4142.627163555295, 4143.150654115899, 4165.229432554987, 4167.249895018926, 4190.8533201337805, 5877.441643043904, 5890.293164820249, 5900.557458190567, 5971.253593300838, 5988.550858685616, 5943.881122377528, 6084.726187321581, 6121.479674227651, 6141.618135919472, 6145.016797312409, 5810.389909059572, 5814.273215848019, 5834.824955251349, 5837.124431335249, 5910.34986151523, 4944.986277813112, 5093.286939828427, 5118.667286626432, 5132.101882170605, 5167.612429067835, 6310.905336419957, 6350.904736428957, 6357.0, 6370.203724534434, 6389.680515974275, 5977.970110149421, 6107.358727333655, 6118.47992920589, 6181.412765787243, 6183.628982261079, 6103.511719062553, 6136.274005701014, 6191.380861913773, 6196.47329976957, 6198.907016394848, 5934.258217722785, 5937.851553711192, 5942.168096466585, 5988.910166347421, 6068.7269072892705, 5980.312264089685, 6027.427394397525, 6044.909326360196, 6084.421979911901, 6133.089845874549, 5999.340072592098, 6037.486813620892, 6044.425779550936, 6047.244094488189, 6087.208662873975, 5915.053591425351, 5936.584439089395, 6017.969910150421, 6018.247719035121, 6056.0, 5660.320761508646, 5845.2108965290845, 5860.120981852756, 5927.673977931255, 5944.0489521678055, 5976.491998180029, 5989.2812862456785, 6012.128241405059, 6018.21763170785, 6052.6973651316375, 5899.085641725539, 5904.645721256738, 5910.881782364415, 5912.704364781658, 5919.260092488439], "value": 5630.352790980308, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.3522565498639, 679.3071067511141, 689.9620520871351, 712.6472396163899, 745.7874505765856, 40608.0, 41554.58445415545, 41604.79197604016, 41693.37459938096, 41711.0, 44013.0, 44123.338149927775, 44215.0, 44630.0, 44680.3297950531, 8709.520976346299, 8939.0, 8941.239994600466, 8951.507667078307, 8952.955235223848, 8651.351148663844, 8735.0, 8751.299896008304, 9011.459312441275, 9022.548872556346, 9036.638534458614, 9085.818283634324, 9100.499472529009, 9105.226055785233, 9143.54282285883, 8998.460092394445, 9070.77323066922, 9095.090490950919, 9104.135107164842, 9116.270698344117, 8890.422122562077, 8941.910580894173, 8957.6864809732, 8990.775230619221, 9004.27965762744, 42925.57074429247, 43455.0, 43488.0, 43580.782096089635, 43679.0, 3747.5128233329765, 3872.806359682033, 4012.8194231259663, 4272.1028583997395, 4530.728156310632, 33795.662043379496, 34041.82979085114, 34194.14514637129, 34338.14154646129, 34742.65257347445, 4536.228841096989, 4551.271796512575, 4593.885152871171, 4612.146752850734, 4654.278586819015, 328265.0, 329313.0, 331014.0, 331687.0, 333947.0, 63918.0, 64577.354226458076, 64584.35415645877, 64598.0, 64601.67699161474, 71233.0, 72050.27949720436, 72558.0, 72586.27413725901, 72744.27255727375, 17712.0, 17809.109544522722, 17932.731009034615, 17940.730889036677, 18016.639667206582, 14360.210188439527, 14512.709745805025, 14515.564533064025, 14516.056456330305, 14547.199904005382, 20610.175592976113, 20945.37163885086, 21112.683309750366, 21138.471538211666, 21806.672899906513, 7552.773416797505, 7563.0, 7582.35549978247, 7702.8844567331535, 7788.766337009899, 1117.0672488472055, 1129.5651174297955, 1141.4292853573213, 1226.3255209634665, 1253.8620751717303, 32604.673953260637, 34167.48748768771, 34312.31375372478, 34367.140821479166, 34947.825260874044, 1136.9994404923614, 1206.831043653889, 1241.0815996162955, 1245.4582256718356, 1351.439152751597, 17936.282548698167, 18010.0, 18190.636187276446, 18213.81786182121, 18220.45338639843, 466430.0, 555026.0, 940773.0, 945276.0, 954845.0, 65824.0, 66487.66756166285, 66540.33459665439, 66597.66701166463, 66910.0, 1526.9082605936808, 1537.961550961235, 1540.5763415060724, 1547.9690406192037, 1550.852668996466, 34810.30379392449, 34852.47721284132, 35246.0, 35397.82301088478, 35488.822555887054, 56233.0, 56622.43377566172, 56762.432375675715, 57381.0, 57407.0, 438223.0, 441329.0, 443833.0, 444836.0, 446519.0, 31504.527432088078, 31855.681443185273, 32010.0, 50813.74593127159, 52498.73750631222, 50408.0, 51195.0, 51687.48312516827, 52821.7358913203, 52952.47047529475, 38356.0, 38612.80693596514, 38632.0, 39371.409428859166, 39382.60617393904, 36853.63146368609, 38231.808840955615, 38530.80734596309, 38778.0, 39121.804390977864, 39767.0, 40162.79918600505, 40373.59626403816, 40567.3914891271, 40849.59150408458, 36549.0, 37197.25605487821, 37710.43434348432, 37901.620983789806, 38015.0, 30219.395612087195, 30355.0, 30486.237844054078, 30614.234644134074, 30798.84600576983], "value": 21649.93488933849, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.83258612847925, 425.3449687481278, 431.73016864459714, 434.45042021842374, 440.59245198191684, 19039.0, 19329.226830926764, 19487.123079461424, 19689.0, 19971.700424493643, 19034.809651903477, 19296.71054934177, 19394.806051939475, 19447.902760486213, 19484.318048868292, 5694.259746232984, 5728.885422291552, 5855.736491857855, 5886.735096920638, 5897.616654917438, 4210.136921931012, 5779.768809247625, 5872.7063646817705, 6289.119523266746, 6564.179477565304, 6484.0, 6488.708008139645, 6503.837404064912, 6505.837354066162, 6510.446612037958, 5432.185172224178, 5643.238162848004, 5645.915311270334, 5698.8290351289525, 6357.68211589421, 5507.834764957058, 5517.613767036309, 5520.337559492847, 5545.195946587763, 5731.8567035824435, 12652.051096167825, 12807.551735689207, 12810.80783788244, 12900.677483062904, 12958.287294198815, 2493.0526399968076, 2494.9376265593505, 2523.4826860493554, 2555.6933168019955, 2586.0431640293023, 10123.493825308706, 11409.030232430254, 14232.146071235758, 14423.350949207312, 14491.130532168103, 2018.7678416982087, 2057.825084867788, 2071.533904871407, 2099.254764558575, 2111.292716939827, 74065.99999999946, 76607.0, 81834.0, 82749.58625206896, 83620.0, 10697.518611662494, 11083.72290692739, 11511.136664750176, 11576.47905844239, 11609.941950290364, 14946.103233806007, 15035.248237588077, 15181.924090379478, 15195.0, 15228.923855380652, 8395.202455766692, 8658.653653853775, 8672.306215502746, 8677.479351238946, 8680.262177714965, 8200.507969521848, 8298.751037468886, 8452.450590711584, 8466.365022623328, 8614.526201058876, 4986.127427700138, 4996.850094497171, 4999.700017998859, 5115.87210319745, 5156.581939966539, 2071.6788897720876, 2140.539783946459, 3546.875859344962, 3583.0, 3879.4977239680247, 970.4807927758616, 1046.2362475393006, 1111.7887601355717, 1142.3260276436943, 1157.0338767129374, 18407.90796046011, 18556.721649175273, 19110.0, 19151.425457236306, 19329.80670193308, 1062.7715041266165, 1062.9681109566725, 1113.4989254835357, 1129.3901293301526, 1151.988480115205, 10855.240133190759, 10958.452077396098, 10981.670549883516, 11012.39431831257, 11031.338119712682, 492851.0, 502383.97616024106, 524474.0, 527806.0, 531508.0, 86708.0, 87077.56461217653, 88783.55608221918, 91494.54252728693, 92254.0, 1088.3469918049266, 1097.957798494815, 1101.9944900275607, 1103.6082190822303, 1113.4432783608195, 17012.234449449556, 17153.485395438158, 17305.30778768835, 17327.653446930737, 17486.73769893478, 39420.0, 39500.2099958005, 40100.3984940232, 40178.59821401865, 41022.38466422947, 56549.71725141348, 56890.715546422005, 56909.715451422475, 57154.42845571491, 57760.0, 8329.583520824055, 8611.095834937492, 8646.610902509276, 8732.65069397217, 8794.60424280896, 12475.438605262603, 13565.321733913068, 13584.79622805639, 13585.32073396346, 13973.301334933416, 11310.94344528272, 11727.648170554898, 11740.295582265091, 11805.645830625095, 11956.521739130338, 11172.720681983015, 11192.720181995515, 11279.266847654877, 11509.884901150881, 11562.0, 10981.945090274497, 11066.667999960015, 11131.83302250483, 11210.0, 11279.943600281946, 8223.342132629496, 8678.566071696516, 8710.346723995599, 8743.912560874563, 9118.40730352525, 11035.282706624044, 11979.460924258603, 12009.219400738924, 12064.75870482568, 12141.392930353624], "value": 9451.846640956452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.3105568022227, 1555.0902721907682, 1806.6386722655473, 1919.4145785535425, 1923.249932526315, 6874.415674667659, 8094.392920530954, 8114.472559283649, 8288.502689838606, 8368.665253389865, 8035.236652518016, 8036.075851277104, 8062.0, 8100.635471403786, 8110.107888132316, 2424.466617344186, 2444.4377793107506, 2449.081594402099, 2465.8890349934204, 2466.90132394704, 2399.8574342118345, 2450.473148273121, 2460.889259983296, 2461.237016524874, 2465.3220364399845, 2423.1882319422925, 2424.418139646481, 2437.85372877627, 2453.914113006045, 2469.6789417375717, 2444.046821739523, 2448.1309135256906, 2450.1791899713617, 2454.0, 2487.676602041723, 2440.633904914277, 2451.6322551617222, 2473.3445636906235, 2475.220305603747, 2497.950040999188, 8269.338452923752, 8288.21261980111, 8298.958505207496, 8327.458715183493, 8338.166183381674, 5095.719735414551, 5163.690178589259, 5170.121079416471, 5176.0, 5193.9740301298625, 3425.7773244739014, 3499.5275637788827, 3518.5249991251367, 3531.329047480996, 3545.6099829018785, 1105.3367979212408, 1137.7212582917239, 1170.9824352634716, 1177.8939895409455, 1195.8863907928733, 11609.0, 11637.592684256095, 11671.424357711685, 11708.824367634492, 11712.941435292854, 4736.786844592001, 4776.498467660915, 4779.569838714463, 4782.545658162469, 4896.1921282987905, 9992.0, 10021.29850910444, 10046.14607758334, 10059.899401005896, 10101.242406819518, 5312.73436328182, 5340.279062326536, 5358.490943360374, 5360.946390536123, 5364.4099149094345, 4029.9798501007895, 4685.109829132454, 4771.594414474739, 4777.808887644455, 4793.832215872428, 4101.138760860253, 4137.81379837908, 4186.916261674811, 4230.175115852441, 4232.555581663881, 1365.9795103073461, 1375.0, 1375.532319011541, 1376.1742954227384, 1393.9163650181022, 971.2521358554015, 1091.1543553745753, 1102.101787043557, 1109.6449136276476, 1114.9888501114885, 6125.203723516003, 6177.857096437174, 6182.721777520022, 6204.37956204385, 6247.437730604177, 504.10772931911043, 506.399916099416, 508.2046597075565, 509.1471784760511, 516.073647802196, 4271.615554600101, 4284.357346398003, 4310.590493903074, 4335.7181783184, 4337.349397590387, 9871.950640246752, 10118.139958103644, 10177.084062434416, 10211.336263143021, 10217.33587316822, 9948.850767238497, 9957.551910163915, 10021.649242276631, 10067.446290454096, 10077.899221007696, 7421.2207718190975, 7822.865684475833, 7936.4047696423, 7948.761537153895, 7975.481593696391, 5895.64626122434, 5910.320313163869, 5925.111233315038, 5968.253968253968, 6022.307434644897, 8983.640654374014, 9067.27461803041, 9071.591778369857, 9097.727068187965, 9142.588583513625, 9150.908490915272, 9436.103570160823, 9686.85469717969, 9721.270904682036, 9730.221582273543, 6606.339366063356, 7250.9637451812405, 7490.475666703279, 7505.249475052451, 7564.0, 7856.7250146244605, 7900.68397264126, 7902.960485197537, 7905.56519391439, 7980.241877021674, 7117.537360071578, 7246.275372462712, 7277.854442911006, 7340.559566426032, 7340.926590734024, 7220.3140701633265, 7255.818604534928, 7274.30894065063, 7278.67245973943, 7289.744858929912, 6866.759663411756, 6913.343232392915, 6970.756023539355, 6985.441164706913, 7002.929970700227, 4997.475265097112, 5070.41690205631, 5078.492150784892, 5143.665661731976, 5185.637005409585, 5123.487651234846, 5186.481351864783, 5223.4515375884985, 5223.895522089613, 5301.469853014668], "value": 4543.497607438938, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.8539013614282, 359.8686479435006, 364.7957143999359, 365.16195331713715, 365.2803976166952, 6595.944648856184, 6707.094542236802, 6718.7984360469145, 6808.8978665320055, 6809.931900680992, 6670.833229169261, 6678.866422671544, 6719.0593316935665, 6721.932780672192, 6736.326367363261, 5131.512506311904, 5134.845954621367, 5136.460671629481, 5140.074786538422, 5146.150885103953, 5155.329807125068, 5155.40712818027, 5160.896782064357, 5164.457731938149, 5171.146760784466, 5089.211172268286, 5098.056859481007, 5104.412992505872, 5110.105731496992, 5111.437741848394, 5000.374953130859, 5065.569426598743, 5082.390113186404, 5089.6691715038405, 5106.055379754739, 4447.266201076818, 4452.087322098994, 4463.152001119809, 4467.888302792424, 4486.394336764561, 6360.9045864312075, 6391.488680905516, 6404.327545607737, 6407.967960160216, 6408.58344207625, 5887.1463637772285, 5895.764169433218, 5930.703464826742, 5943.3165186003735, 5944.791932282349, 6969.7909062727695, 7022.508424410242, 7025.718971241145, 7031.171895307206, 7045.9350182670705, 4515.887102822423, 4632.490426053131, 4663.813447462097, 4944.258361245842, 4949.109160351135, 7197.100362454693, 7221.42228621709, 7270.127584689765, 7309.305615966475, 7312.561246325185, 4890.584300334512, 4891.584215341736, 4896.167651499253, 4897.069556784199, 4897.534734200245, 4958.504149585013, 4960.429550601655, 4962.776675049631, 4964.67729597575, 4975.751212439436, 5775.48020678141, 5777.277840269966, 5777.422257774189, 5781.653100813965, 5784.797532086357, 6879.346462086094, 6992.1958974717545, 7041.295870413021, 7056.6118863463, 7068.787936361918, 1701.6086300151035, 1708.9829101709072, 1717.9742303865453, 1723.758673785671, 1728.110023337982, 1066.5147357952112, 1115.9553617855356, 1118.3513562134106, 1133.7789131119353, 1134.0813940708053, 6711.496637752188, 6975.651217439107, 6985.511014228955, 6986.266442023616, 6993.230744618189, 7304.452166087564, 7349.191588925214, 7350.044494215717, 7365.079365079365, 7371.447141464411, 6828.0, 6828.6927088281145, 6864.073350097773, 6876.277990810893, 6886.414654754301, 3914.530256369197, 3939.783311917815, 3958.2281455116554, 3971.602839716063, 3982.980085099556, 7600.0, 7602.847943041219, 7607.847843043108, 7614.619269036526, 7617.047869016373, 7352.77941661751, 7376.114866216089, 7400.407967362598, 7409.592472413961, 7451.0, 7554.471187016966, 7557.773266802004, 7560.962195189099, 7568.243175682498, 7573.318401343906, 7166.355028047501, 7317.414606831334, 7329.377002954595, 7330.926690733025, 7350.52221605594, 7221.0251616033265, 7227.674754635948, 7238.963805180941, 7255.854882902418, 7260.201377848327, 7525.623718814147, 7578.166401695698, 7580.090389153337, 7583.9620801895635, 7591.4685971983645, 4796.928046079382, 4826.251930950708, 4827.8551643450755, 4831.830885918976, 4836.46798852119, 7136.357727804522, 7243.348098670934, 7279.381252593589, 7314.049173607397, 7324.19433862264, 7060.682269297997, 7063.187733410724, 7111.893321600077, 7114.466415018791, 7123.112375220674, 6998.860022799618, 7025.613591252531, 7033.964830175816, 7041.225465198721, 7056.647167641495, 6861.176658800976, 6902.378785909293, 6922.58464492132, 6942.097527321416, 6949.583025018515, 6960.860782784417, 7105.396041336544, 7112.466565007541, 7116.683413568507, 7118.644067796693, 6681.164854393201, 6812.523123381316, 6931.653417329214, 6985.930140698528, 6990.09128813251], "value": 5300.529812656184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.5310495073253, 779.7855589712829, 820.2453742556847, 833.8374017066673, 864.8140649760302, 14612.269386530657, 14743.631409214762, 14945.775813362809, 14975.925120374397, 15009.249537523121, 14221.928890355559, 14386.568402947902, 14401.63995900103, 14422.567322980301, 14425.42298308069, 738.1732459645204, 918.912703293186, 927.0682963621551, 933.4539294512718, 936.0405584276103, 915.5330781301551, 916.9449833010008, 917.7017469322464, 922.6355589542127, 927.0266220468515, 979.9853002204973, 986.5461887531744, 986.960521579136, 988.7280997725611, 988.79235360574, 979.8481235408523, 980.6028558433845, 981.7251169672468, 981.7692842182117, 981.9509024548744, 718.5868125827618, 723.2550473012806, 723.3345322303494, 723.5622448418684, 726.1685370251085, 14128.646783830383, 14144.787828182585, 14159.292035398292, 14192.716145677132, 14197.929010354985, 14706.485273015393, 14757.114573125647, 14767.92616036913, 14861.108333500024, 14906.850931490762, 11934.522619095225, 12089.214201076902, 12182.695432614168, 12205.938970305091, 12335.876641233563, 4036.9596304036877, 4060.553339132693, 4111.239420707178, 4135.710500264982, 4136.544980052192, 57438.71280643612, 57738.42261577372, 58083.41916580865, 58210.417895821345, 58651.12023319654, 11886.40567971598, 11942.940285298519, 12151.939240303742, 12169.148159628918, 12225.510979560895, 20375.18499260013, 20432.0, 20461.795382046286, 20463.38609841707, 20554.17783288652, 8458.74623761288, 8729.869051964226, 8872.689455869013, 8918.910810891808, 9086.636534538544, 4970.353853998957, 4983.0, 5048.495150484996, 5081.491850814963, 5084.186530155157, 3649.7810131392202, 3656.0859785053735, 3659.7255205859665, 3688.63113688629, 3699.9815000924823, 595.3153873046032, 607.7690477618565, 610.7251736718495, 638.8211300835774, 647.5467172978933, 811.5860910935347, 823.275517544569, 847.4618617178136, 849.2993280543453, 856.9271611913057, 9532.666356677622, 9898.505074746234, 9948.204143668489, 9988.900110998942, 10195.949020254851, 766.2375935943771, 779.2324560308092, 814.861473549498, 854.0477367735054, 859.9871001934976, 4562.315652652129, 4677.4854765975715, 4720.291956206596, 4764.690295130806, 4779.814377102859, 67023.66488167529, 69154.0, 69179.65410173018, 69305.3069469309, 69502.65248673825, 54340.18489722657, 55709.0, 57319.42680573141, 57400.71299643475, 61612.38387616067, 53908.730456348254, 54370.45629543733, 54700.179497307574, 54740.45259547433, 54866.725666370614, 9085.818283634422, 9322.207612353026, 9419.387739796892, 9454.527273636428, 9502.47736374506, 38094.809525952194, 38322.233555329294, 38693.613063869, 39623.40564891471, 39683.80158099191, 46002.53997459982, 46412.76793616146, 49957.00085998187, 50876.49123508866, 51256.48743512517, 11785.823212651645, 12173.573924912585, 12236.571719989757, 12371.453568303961, 12609.621711348675, 12829.42267597979, 12917.677058073623, 12922.0, 12985.805212921625, 13370.264635444755, 12046.75906481848, 12286.447109880255, 12501.624951251477, 12575.87424125747, 12596.307203103917, 11864.703382415508, 12041.638750837488, 12231.082668800054, 12645.557405490763, 12712.237265764084, 11764.176507644383, 11899.524019039141, 12004.879951200377, 12099.395030248277, 12413.689657758629, 10329.12202462799, 10469.790604188025, 10581.0, 10690.41202733857, 11065.0, 10388.22674273882, 10427.739306517095, 10466.947665261625, 10472.895271047497, 10520.526576304237], "value": 7157.253012915702, "unit": "score"}], "name": "dromaeo_css", "value": 7638.372534450185, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 103.0, 108.0, 110.0, 112.0, 104.0, 110.0, 112.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 159.0, 179.0, 146.0, 154.0, 152.0, 130.0, 195.0, 134.0], "value": 153.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 162.0, 163.0, 163.0, 161.0, 164.0, 165.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 174.0, 75.0, 73.0, 75.0, 76.0, 165.0, 75.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 149.0, 94.0, 92.0, 92.0, 137.0, 91.0, 93.0, 140.0], "value": 107.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 149.0, 147.0, 146.0, 145.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 98.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 59.0, 59.0, 58.0, 58.0, 80.0, 56.0, 56.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 75.0, 75.0, 75.0, 76.0, 75.0, 74.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 113.0, 117.0, 127.0, 115.0, 122.0, 114.0, 120.0, 128.0, 143.0], "value": 122.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 175.0, 163.0, 164.0, 169.0, 163.0, 160.0, 165.0, 157.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0, 67.0, 70.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1534.0000000000002, "alertThreshold": 2.0}]} 04:12:38 INFO - Return code: 0 04:12:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:12:38 ERROR - # TBPL SUCCESS # 04:12:38 INFO - Running post-action listener: _resource_record_post_action 04:12:38 INFO - Running post-run listener: _resource_record_post_run 04:12:39 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505835520; Read time: 12; Write time: 471756 04:12:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 260571136; Read time: 0; Write time: 286692 04:12:39 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245264384; Read time: 12; Write time: 185064 04:12:39 INFO - Running post-run listener: _upload_blobber_files 04:12:39 INFO - Blob upload gear active. 04:12:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:39 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 04:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:12:39 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:12:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:40 INFO - (blobuploader) - INFO - Done attempting. 04:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:41 INFO - (blobuploader) - INFO - Done attempting. 04:12:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:41 INFO - Return code: 0 04:12:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/698ab89f9baab7dff7e7c3ac07bbc75743e2e161761210e47ad54a04e91122fcb246c45b19336a5c5cb353b15fa685040ad6ffbffb0c3f571a009e8c9845c501", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b473e0e7adbb435f62191205453225b1ec02ae5eea3dcd6cf5ae8b2bb6df1d6191d46629512b1d800aeffef8f9103eec89d3645f51b1b9cefb505c5e4fba820"} 04:12:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:41 INFO - Contents: 04:12:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/698ab89f9baab7dff7e7c3ac07bbc75743e2e161761210e47ad54a04e91122fcb246c45b19336a5c5cb353b15fa685040ad6ffbffb0c3f571a009e8c9845c501", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b473e0e7adbb435f62191205453225b1ec02ae5eea3dcd6cf5ae8b2bb6df1d6191d46629512b1d800aeffef8f9103eec89d3645f51b1b9cefb505c5e4fba820"} 04:12:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:41 INFO - Copying logs to upload dir... 04:12:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.665094 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-28 04:12:41.157382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 04:12:41.161044) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/698ab89f9baab7dff7e7c3ac07bbc75743e2e161761210e47ad54a04e91122fcb246c45b19336a5c5cb353b15fa685040ad6ffbffb0c3f571a009e8c9845c501", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b473e0e7adbb435f62191205453225b1ec02ae5eea3dcd6cf5ae8b2bb6df1d6191d46629512b1d800aeffef8f9103eec89d3645f51b1b9cefb505c5e4fba820"} build_url:https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/I9gsXL2gREe8WoOEz7hS-A/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/698ab89f9baab7dff7e7c3ac07bbc75743e2e161761210e47ad54a04e91122fcb246c45b19336a5c5cb353b15fa685040ad6ffbffb0c3f571a009e8c9845c501", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b473e0e7adbb435f62191205453225b1ec02ae5eea3dcd6cf5ae8b2bb6df1d6191d46629512b1d800aeffef8f9103eec89d3645f51b1b9cefb505c5e4fba820"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-28 04:12:41.185959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 04:12:41.186243) ========= 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=652eb03db935cfc1c15ebda0000001ad-1464432734.543996-1032253975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-28 04:12:41.270305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 04:12:41.270605) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-28 04:12:41.270892) ========= ========= Total master_lag: 0.17 =========