builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1461282133.47 results: success (0) buildid: 20160421141100 builduid: c970c10165c0467697abb918a450c7f4 revision: 90fef35d3694ae38eb7aa268c4fd9f1d6b1e514e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.471239) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.471916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.472249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.495327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.495692) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 16:42:14-- 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% 224M=0s 2016-04-21 16:42:14 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.610618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.610984) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019141 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:13.664161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 16:42:13.664574) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 90fef35d3694ae38eb7aa268c4fd9f1d6b1e514e --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 90fef35d3694ae38eb7aa268c4fd9f1d6b1e514e --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=fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 16:42:14,284 truncating revision to first 12 chars 2016-04-21 16:42:14,284 Setting DEBUG logging. 2016-04-21 16:42:14,284 attempt 1/10 2016-04-21 16:42:14,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/90fef35d3694?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 16:42:15,418 unpacking tar archive at: mozilla-aurora-90fef35d3694/testing/mozharness/ program finished with exit code 0 elapsedTime=1.429777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 16:42:15.107896) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:15.108258) ========= script_repo_revision: 90fef35d3694ae38eb7aa268c4fd9f1d6b1e514e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:15.108746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:15.109048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 16:42:15.117673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-04-21 16:42:15.118100) ========= /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=fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:42:15 INFO - MultiFileLogger online at 20160421 16:42:15 in /builds/slave/test 16:42:15 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 16:42:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:42:15 INFO - {'append_to_log': False, 16:42:15 INFO - 'base_work_dir': '/builds/slave/test', 16:42:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:42:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:42:15 INFO - 'branch': 'Mozilla-Aurora', 16:42:15 INFO - 'buildbot_json_path': 'buildprops.json', 16:42:15 INFO - 'config_files': ('talos/linux_config.py',), 16:42:15 INFO - 'default_actions': ('clobber', 16:42:15 INFO - 'read-buildbot-config', 16:42:15 INFO - 'download-and-extract', 16:42:15 INFO - 'populate-webroot', 16:42:15 INFO - 'create-virtualenv', 16:42:15 INFO - 'install', 16:42:15 INFO - 'run-tests'), 16:42:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:42:15 INFO - 'download_minidump_stackwalk': True, 16:42:15 INFO - 'download_symbols': 'ondemand', 16:42:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:42:15 INFO - 'tooltool.py': '/tools/tooltool.py', 16:42:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:42:15 INFO - '/tools/misc-python/virtualenv.py')}, 16:42:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:42:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:42:15 INFO - 'installer_path': 'installer.exe', 16:42:15 INFO - 'log_level': 'info', 16:42:15 INFO - 'log_name': 'talos', 16:42:15 INFO - 'log_to_console': True, 16:42:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:42:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:42:15 INFO - 'opt_config_files': (), 16:42:15 INFO - 'pip_index': False, 16:42:15 INFO - 'sps_profile': False, 16:42:15 INFO - 'sps_profile_interval': 0, 16:42:15 INFO - 'suite': 'dromaeojs-e10s', 16:42:15 INFO - 'system_bits': '32', 16:42:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:42:15 INFO - 'title': 'talos-linux64-ix-014', 16:42:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:42:15 INFO - 'use_talos_json': True, 16:42:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:42:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:42:15 INFO - 'work_dir': 'build'} 16:42:15 INFO - ##### 16:42:15 INFO - ##### Running clobber step. 16:42:15 INFO - ##### 16:42:15 INFO - Running pre-action listener: _resource_record_pre_action 16:42:15 INFO - Running main action method: clobber 16:42:15 INFO - rmtree: /builds/slave/test/build 16:42:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:42:16 INFO - Running post-action listener: _resource_record_post_action 16:42:16 INFO - ##### 16:42:16 INFO - ##### Running read-buildbot-config step. 16:42:16 INFO - ##### 16:42:16 INFO - Running pre-action listener: _resource_record_pre_action 16:42:16 INFO - Running main action method: read_buildbot_config 16:42:16 INFO - Using buildbot properties: 16:42:16 INFO - { 16:42:16 INFO - "project": "", 16:42:16 INFO - "product": "firefox", 16:42:16 INFO - "script_repo_revision": "production", 16:42:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:42:16 INFO - "repository": "", 16:42:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:42:16 INFO - "buildid": "20160421141100", 16:42:16 INFO - "pgo_build": "True", 16:42:16 INFO - "basedir": "/builds/slave/test", 16:42:16 INFO - "buildnumber": 226, 16:42:16 INFO - "slavename": "talos-linux64-ix-014", 16:42:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:42:16 INFO - "platform": "ubuntu64_hw", 16:42:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:42:16 INFO - "branch": "mozilla-aurora", 16:42:16 INFO - "repo_path": "releases/mozilla-aurora", 16:42:16 INFO - "revision": "90fef35d3694ae38eb7aa268c4fd9f1d6b1e514e", 16:42:16 INFO - "stage_platform": "linux64-pgo", 16:42:16 INFO - "builduid": "c970c10165c0467697abb918a450c7f4", 16:42:16 INFO - "slavebuilddir": "test" 16:42:16 INFO - } 16:42:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 16:42:16 INFO - Running post-action listener: _resource_record_post_action 16:42:16 INFO - ##### 16:42:16 INFO - ##### Running download-and-extract step. 16:42:16 INFO - ##### 16:42:16 INFO - Running pre-action listener: _resource_record_pre_action 16:42:16 INFO - Running main action method: download_and_extract 16:42:16 INFO - mkdir: /builds/slave/test/build/tests 16:42:16 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')]} 16:42:16 INFO - https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:42:17 INFO - Downloaded 1448 bytes. 16:42:17 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 16:42:17 INFO - Using the following test package requirements: 16:42:17 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:42:17 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:42:17 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:42:17 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'jsshell-linux-x86_64.zip'], 16:42:17 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:42:17 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:42:17 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:42:17 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:42:17 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:42:17 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 16:42:17 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 16:42:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:42:17 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:42: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')]} 16:42:17 INFO - https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:42:19 INFO - Downloaded 23354639 bytes. 16:42:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:42:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:42:21 INFO - Return code: 0 16:42:21 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:42:21 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')]} 16:42:21 INFO - https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 16:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:42:33 INFO - Downloaded 23354639 bytes. 16:42:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:42:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:42:35 INFO - Return code: 0 16:42:35 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')]} 16:42:35 INFO - https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:42:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:42:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:42:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 16:42:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:42:37 INFO - Downloaded 10845198 bytes. 16:42:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:42:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:42:37 INFO - Return code: 0 16:42: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')]} 16:42:37 INFO - https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:42:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:42:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:42:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:42:39 INFO - Downloaded 60614044 bytes. 16:42:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:42:39 INFO - mkdir: /builds/slave/test/properties 16:42:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:42:39 INFO - Writing to file /builds/slave/test/properties/build_url 16:42:39 INFO - Contents: 16:42:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 16:42:40 INFO - Running post-action listener: _resource_record_post_action 16:42:40 INFO - Running post-action listener: set_extra_try_arguments 16:42:40 INFO - ##### 16:42:40 INFO - ##### Running populate-webroot step. 16:42:40 INFO - ##### 16:42:40 INFO - Running pre-action listener: _resource_record_pre_action 16:42:40 INFO - Running main action method: populate_webroot 16:42:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:42:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:42:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:42:40 INFO - '--tppagecycles', 16:42:40 INFO - '7'], 16:42:40 INFO - 'tests': ['tsvgm']}}, 16:42:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:42:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:42:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:42:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:42:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'tests': ['damp', 'tps']}, 16:42:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['damp', 'tps']}, 16:42:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:42:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:42:40 INFO - 'other': {'tests': ['a11yr', 16:42:40 INFO - 'ts_paint', 16:42:40 INFO - 'tpaint', 16:42:40 INFO - 'sessionrestore', 16:42:40 INFO - 'sessionrestore_no_auto_restore', 16:42:40 INFO - 'tabpaint']}, 16:42:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['a11yr', 16:42:40 INFO - 'ts_paint', 16:42:40 INFO - 'tpaint', 16:42:40 INFO - 'sessionrestore', 16:42:40 INFO - 'sessionrestore_no_auto_restore', 16:42:40 INFO - 'tabpaint']}, 16:42:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['a11yr', 16:42:40 INFO - 'ts_paint', 16:42:40 INFO - 'tpaint', 16:42:40 INFO - 'sessionrestore', 16:42:40 INFO - 'sessionrestore_no_auto_restore', 16:42:40 INFO - 'tabpaint']}, 16:42:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['a11yr', 16:42:40 INFO - 'ts_paint', 16:42:40 INFO - 'tpaint', 16:42:40 INFO - 'sessionrestore', 16:42:40 INFO - 'sessionrestore_no_auto_restore', 16:42:40 INFO - 'tabpaint']}, 16:42:40 INFO - 'other_l64': {'tests': ['a11yr', 16:42:40 INFO - 'ts_paint', 16:42:40 INFO - 'tpaint', 16:42:40 INFO - 'sessionrestore', 16:42:40 INFO - 'sessionrestore_no_auto_restore', 16:42:40 INFO - 'tabpaint']}, 16:42:40 INFO - 'other_nol64': {'tests': ['a11yr', 16:42:40 INFO - 'ts_paint', 16:42:40 INFO - 'tpaint', 16:42:40 INFO - 'sessionrestore', 16:42:40 INFO - 'sessionrestore_no_auto_restore', 16:42:40 INFO - 'tabpaint']}, 16:42:40 INFO - 'svgr': {'tests': ['tsvgx', 16:42:40 INFO - 'tsvgr_opacity', 16:42:40 INFO - 'tart', 16:42:40 INFO - 'tscrollx', 16:42:40 INFO - 'cart']}, 16:42:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['tsvgx', 16:42:40 INFO - 'tsvgr_opacity', 16:42:40 INFO - 'tart', 16:42:40 INFO - 'tscrollx', 16:42:40 INFO - 'cart']}, 16:42:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'tests': ['tp5o']}, 16:42:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'talos_options': ['--e10s'], 16:42:40 INFO - 'tests': ['tp5o']}, 16:42:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'talos_options': ['--xperf_path', 16:42:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:40 INFO - 'tests': ['tp5n']}, 16:42:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:40 INFO - 'talos_options': ['--e10s', 16:42:40 INFO - '--xperf_path', 16:42:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:40 INFO - 'tests': ['tp5n']}}, 16:42:40 INFO - 'talos.zip': {'path': '', 16:42:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:42:40 INFO - Running post-action listener: _resource_record_post_action 16:42:40 INFO - ##### 16:42:40 INFO - ##### Running create-virtualenv step. 16:42:40 INFO - ##### 16:42:40 INFO - Running pre-action listener: _resource_record_pre_action 16:42:40 INFO - Running main action method: create_virtualenv 16:42:40 INFO - Creating virtualenv /builds/slave/test/build/venv 16:42:40 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 16:42:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:42:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:42:40 INFO - Using real prefix '/usr' 16:42:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:42:40 INFO - Installing distribute.............................................................................................................................................................................................done. 16:42:42 INFO - Installing pip.................done. 16:42:42 INFO - Return code: 0 16:42:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:42:42 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')]} 16:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:42 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')]} 16:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:42 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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42:42 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 16:42:42 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 16:42:42 INFO - Using env: {'DISPLAY': ':0', 16:42:42 INFO - 'HOME': '/home/cltbld', 16:42:42 INFO - 'LANG': 'en_US.UTF-8', 16:42:42 INFO - 'LANGUAGE': 'en_US:en', 16:42:42 INFO - 'LOGNAME': 'cltbld', 16:42:42 INFO - 'MAIL': '/var/mail/cltbld', 16:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:42 INFO - 'MOZ_NO_REMOTE': '1', 16:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:42 INFO - 'NO_EM_RESTART': '1', 16:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:42 INFO - 'PWD': '/builds/slave/test', 16:42:42 INFO - 'SHELL': '/bin/bash', 16:42:42 INFO - 'SHLVL': '1', 16:42:42 INFO - 'TERM': 'linux', 16:42:42 INFO - 'TMOUT': '86400', 16:42:42 INFO - 'USER': 'cltbld', 16:42:42 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:42 INFO - '_': '/tools/buildbot/bin/python'} 16:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:42 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 16:42:42 INFO - Cleaning up... 16:42:42 INFO - Return code: 0 16:42:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:42:42 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')]} 16:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:42 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')]} 16:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:42 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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42:42 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 16:42:42 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 16:42:42 INFO - Using env: {'DISPLAY': ':0', 16:42:42 INFO - 'HOME': '/home/cltbld', 16:42:42 INFO - 'LANG': 'en_US.UTF-8', 16:42:42 INFO - 'LANGUAGE': 'en_US:en', 16:42:42 INFO - 'LOGNAME': 'cltbld', 16:42:42 INFO - 'MAIL': '/var/mail/cltbld', 16:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:42 INFO - 'MOZ_NO_REMOTE': '1', 16:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:42 INFO - 'NO_EM_RESTART': '1', 16:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:42 INFO - 'PWD': '/builds/slave/test', 16:42:42 INFO - 'SHELL': '/bin/bash', 16:42:42 INFO - 'SHLVL': '1', 16:42:42 INFO - 'TERM': 'linux', 16:42:42 INFO - 'TMOUT': '86400', 16:42:42 INFO - 'USER': 'cltbld', 16:42:42 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:42 INFO - '_': '/tools/buildbot/bin/python'} 16:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:43 INFO - Downloading/unpacking psutil>=0.7.1 16:42:43 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 16:42:43 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 16:42:43 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 16:42:43 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 16:42:43 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 16:42:43 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 16:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:42:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:44 INFO - Installing collected packages: psutil 16:42:44 INFO - Running setup.py install for psutil 16:42:45 INFO - building 'psutil._psutil_linux' extension 16:42:45 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 16:42:45 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 16:42:45 INFO - building 'psutil._psutil_posix' extension 16:42:45 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 16:42:45 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 16:42:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:45 INFO - Successfully installed psutil 16:42:45 INFO - Cleaning up... 16:42:45 INFO - Return code: 0 16:42:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:42:45 INFO - Using env: {'DISPLAY': ':0', 16:42:45 INFO - 'HOME': '/home/cltbld', 16:42:45 INFO - 'LANG': 'en_US.UTF-8', 16:42:45 INFO - 'LANGUAGE': 'en_US:en', 16:42:45 INFO - 'LOGNAME': 'cltbld', 16:42:45 INFO - 'MAIL': '/var/mail/cltbld', 16:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:45 INFO - 'MOZ_NO_REMOTE': '1', 16:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:45 INFO - 'NO_EM_RESTART': '1', 16:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:45 INFO - 'PWD': '/builds/slave/test', 16:42:45 INFO - 'SHELL': '/bin/bash', 16:42:45 INFO - 'SHLVL': '1', 16:42:45 INFO - 'TERM': 'linux', 16:42:45 INFO - 'TMOUT': '86400', 16:42:45 INFO - 'USER': 'cltbld', 16:42:45 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:45 INFO - '_': '/tools/buildbot/bin/python'} 16:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:42:47 INFO - Installing collected packages: mozsystemmonitor 16:42:47 INFO - Running setup.py install for mozsystemmonitor 16:42:47 INFO - Successfully installed mozsystemmonitor 16:42:47 INFO - Cleaning up... 16:42:47 INFO - Return code: 0 16:42:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:42: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')]} 16:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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')]} 16:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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', '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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:42: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 blobuploader==1.2.4 16:42:47 INFO - Using env: {'DISPLAY': ':0', 16:42:47 INFO - 'HOME': '/home/cltbld', 16:42:47 INFO - 'LANG': 'en_US.UTF-8', 16:42:47 INFO - 'LANGUAGE': 'en_US:en', 16:42:47 INFO - 'LOGNAME': 'cltbld', 16:42:47 INFO - 'MAIL': '/var/mail/cltbld', 16:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:47 INFO - 'MOZ_NO_REMOTE': '1', 16:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:47 INFO - 'NO_EM_RESTART': '1', 16:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:47 INFO - 'PWD': '/builds/slave/test', 16:42:47 INFO - 'SHELL': '/bin/bash', 16:42:47 INFO - 'SHLVL': '1', 16:42:47 INFO - 'TERM': 'linux', 16:42:47 INFO - 'TMOUT': '86400', 16:42:47 INFO - 'USER': 'cltbld', 16:42:47 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:47 INFO - '_': '/tools/buildbot/bin/python'} 16:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:42:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:42:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:50 INFO - Downloading docopt-0.6.1.tar.gz 16:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:42:50 INFO - Installing collected packages: blobuploader, requests, docopt 16:42:50 INFO - Running setup.py install for blobuploader 16:42:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:42:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:42:50 INFO - Running setup.py install for requests 16:42:51 INFO - Running setup.py install for docopt 16:42:51 INFO - Successfully installed blobuploader requests docopt 16:42:51 INFO - Cleaning up... 16:42:51 INFO - Return code: 0 16:42:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:51 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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42:51 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 16:42:51 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 16:42:51 INFO - Using env: {'DISPLAY': ':0', 16:42:51 INFO - 'HOME': '/home/cltbld', 16:42:51 INFO - 'LANG': 'en_US.UTF-8', 16:42:51 INFO - 'LANGUAGE': 'en_US:en', 16:42:51 INFO - 'LOGNAME': 'cltbld', 16:42:51 INFO - 'MAIL': '/var/mail/cltbld', 16:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:51 INFO - 'MOZ_NO_REMOTE': '1', 16:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:51 INFO - 'NO_EM_RESTART': '1', 16:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:51 INFO - 'PWD': '/builds/slave/test', 16:42:51 INFO - 'SHELL': '/bin/bash', 16:42:51 INFO - 'SHLVL': '1', 16:42:51 INFO - 'TERM': 'linux', 16:42:51 INFO - 'TMOUT': '86400', 16:42:51 INFO - 'USER': 'cltbld', 16:42:51 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:51 INFO - '_': '/tools/buildbot/bin/python'} 16:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:51 INFO - Running setup.py (path:/tmp/pip-00tgDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:51 INFO - Running setup.py (path:/tmp/pip-ZZhfrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:51 INFO - Running setup.py (path:/tmp/pip-927XDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:51 INFO - Running setup.py (path:/tmp/pip-hMmyoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:51 INFO - Running setup.py (path:/tmp/pip-oho90P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:51 INFO - Running setup.py (path:/tmp/pip-IrbHER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:51 INFO - Running setup.py (path:/tmp/pip-Jkpmqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:52 INFO - Running setup.py (path:/tmp/pip-kLtxXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:52 INFO - Running setup.py (path:/tmp/pip-BAO2SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:52 INFO - Running setup.py (path:/tmp/pip-338KKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:52 INFO - Running setup.py (path:/tmp/pip-CnMosL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:52 INFO - Running setup.py (path:/tmp/pip-QKaBKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:52 INFO - Running setup.py (path:/tmp/pip-e1i_FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:52 INFO - Running setup.py (path:/tmp/pip-xbBLG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:52 INFO - Running setup.py (path:/tmp/pip-wQuoZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:52 INFO - Running setup.py (path:/tmp/pip-3nwGjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:52 INFO - Running setup.py (path:/tmp/pip-rBNuKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:42:52 INFO - Running setup.py install for manifestparser 16:42:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:42:52 INFO - Running setup.py install for mozcrash 16:42:52 INFO - Running setup.py install for mozdebug 16:42:53 INFO - Running setup.py install for mozdevice 16:42:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Running setup.py install for mozfile 16:42:53 INFO - Running setup.py install for mozhttpd 16:42:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Running setup.py install for mozinfo 16:42:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Running setup.py install for mozInstall 16:42:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Running setup.py install for mozleak 16:42:53 INFO - Running setup.py install for mozlog 16:42:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Running setup.py install for moznetwork 16:42:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:42:53 INFO - Running setup.py install for mozprocess 16:42:53 INFO - Running setup.py install for mozprofile 16:42:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for mozrunner 16:42:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Running setup.py install for mozscreenshot 16:42:54 INFO - Running setup.py install for moztest 16:42:54 INFO - Running setup.py install for mozversion 16:42:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:42:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:42:54 INFO - Cleaning up... 16:42:54 INFO - Return code: 0 16:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:54 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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42:54 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 16:42:54 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 16:42:54 INFO - Using env: {'DISPLAY': ':0', 16:42:54 INFO - 'HOME': '/home/cltbld', 16:42:54 INFO - 'LANG': 'en_US.UTF-8', 16:42:54 INFO - 'LANGUAGE': 'en_US:en', 16:42:54 INFO - 'LOGNAME': 'cltbld', 16:42:54 INFO - 'MAIL': '/var/mail/cltbld', 16:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:54 INFO - 'MOZ_NO_REMOTE': '1', 16:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:54 INFO - 'NO_EM_RESTART': '1', 16:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:54 INFO - 'PWD': '/builds/slave/test', 16:42:54 INFO - 'SHELL': '/bin/bash', 16:42:54 INFO - 'SHLVL': '1', 16:42:54 INFO - 'TERM': 'linux', 16:42:54 INFO - 'TMOUT': '86400', 16:42:54 INFO - 'USER': 'cltbld', 16:42:54 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:54 INFO - '_': '/tools/buildbot/bin/python'} 16:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:54 INFO - Running setup.py (path:/tmp/pip-yW0for-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:54 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)) 16:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:54 INFO - Running setup.py (path:/tmp/pip-kHW1dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:54 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)) 16:42:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:54 INFO - Running setup.py (path:/tmp/pip-1jjd5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:55 INFO - Running setup.py (path:/tmp/pip-8sle4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:55 INFO - Running setup.py (path:/tmp/pip-GM9VNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:55 INFO - Running setup.py (path:/tmp/pip-9BWMiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:55 INFO - Running setup.py (path:/tmp/pip-RWvslz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:55 INFO - Running setup.py (path:/tmp/pip-bKRTGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:55 INFO - Running setup.py (path:/tmp/pip-rK8agG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:55 INFO - Running setup.py (path:/tmp/pip-9NJ2xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:55 INFO - Running setup.py (path:/tmp/pip-uoqrap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:55 INFO - Running setup.py (path:/tmp/pip-_CEQFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:55 INFO - Running setup.py (path:/tmp/pip-65e466-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:55 INFO - Running setup.py (path:/tmp/pip-oDEOtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:55 INFO - Running setup.py (path:/tmp/pip-yoyZK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:55 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)) 16:42:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:55 INFO - Running setup.py (path:/tmp/pip-Skx53I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:56 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)) 16:42:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:56 INFO - Running setup.py (path:/tmp/pip-ApST7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:56 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)) 16:42:56 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)) 16:42:56 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)) 16:42:56 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)) 16:42:56 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)) 16:42:56 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)) 16:42:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:42:56 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 16:42:56 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 16:42:56 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 16:42:56 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 16:42:56 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 16:42:56 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 16:42:57 INFO - Downloading blessings-1.6.tar.gz 16:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:42:58 INFO - Installing collected packages: blessings 16:42:58 INFO - Running setup.py install for blessings 16:42:58 INFO - Successfully installed blessings 16:42:58 INFO - Cleaning up... 16:42:58 INFO - Return code: 0 16:42:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:58 INFO - Reading from file tmpfile_stdout 16:42:58 INFO - Current package versions: 16:42:58 INFO - argparse == 1.2.1 16:42:58 INFO - blessings == 1.6 16:42:58 INFO - blobuploader == 1.2.4 16:42:58 INFO - docopt == 0.6.1 16:42:58 INFO - manifestparser == 1.1 16:42:58 INFO - mozInstall == 1.12 16:42:58 INFO - mozcrash == 0.17 16:42:58 INFO - mozdebug == 0.1 16:42:58 INFO - mozdevice == 0.48 16:42:58 INFO - mozfile == 1.2 16:42:58 INFO - mozhttpd == 0.7 16:42:58 INFO - mozinfo == 0.9 16:42:58 INFO - mozleak == 0.1 16:42:58 INFO - mozlog == 3.1 16:42:58 INFO - moznetwork == 0.27 16:42:58 INFO - mozprocess == 0.22 16:42:58 INFO - mozprofile == 0.28 16:42:58 INFO - mozrunner == 6.11 16:42:58 INFO - mozscreenshot == 0.1 16:42:58 INFO - mozsystemmonitor == 0.0 16:42:58 INFO - moztest == 0.7 16:42:58 INFO - mozversion == 1.4 16:42:58 INFO - psutil == 3.1.1 16:42:58 INFO - requests == 1.2.3 16:42:58 INFO - wsgiref == 0.1.2 16:42:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:58 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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42:58 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 16:42:58 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 16:42:58 INFO - Using env: {'DISPLAY': ':0', 16:42:58 INFO - 'HOME': '/home/cltbld', 16:42:58 INFO - 'LANG': 'en_US.UTF-8', 16:42:58 INFO - 'LANGUAGE': 'en_US:en', 16:42:58 INFO - 'LOGNAME': 'cltbld', 16:42:58 INFO - 'MAIL': '/var/mail/cltbld', 16:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:58 INFO - 'MOZ_NO_REMOTE': '1', 16:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:58 INFO - 'NO_EM_RESTART': '1', 16:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:58 INFO - 'PWD': '/builds/slave/test', 16:42:58 INFO - 'SHELL': '/bin/bash', 16:42:58 INFO - 'SHLVL': '1', 16:42:58 INFO - 'TERM': 'linux', 16:42:58 INFO - 'TMOUT': '86400', 16:42:58 INFO - 'USER': 'cltbld', 16:42:58 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:58 INFO - '_': '/tools/buildbot/bin/python'} 16:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 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)) 16:42:58 INFO - Cleaning up... 16:42:58 INFO - Return code: 0 16:42:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:58 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 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:42:58 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 16:42:58 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 16:42:58 INFO - Using env: {'DISPLAY': ':0', 16:42:58 INFO - 'HOME': '/home/cltbld', 16:42:58 INFO - 'LANG': 'en_US.UTF-8', 16:42:58 INFO - 'LANGUAGE': 'en_US:en', 16:42:58 INFO - 'LOGNAME': 'cltbld', 16:42:58 INFO - 'MAIL': '/var/mail/cltbld', 16:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:58 INFO - 'MOZ_NO_REMOTE': '1', 16:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:42:58 INFO - 'NO_EM_RESTART': '1', 16:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:58 INFO - 'PWD': '/builds/slave/test', 16:42:58 INFO - 'SHELL': '/bin/bash', 16:42:58 INFO - 'SHLVL': '1', 16:42:58 INFO - 'TERM': 'linux', 16:42:58 INFO - 'TMOUT': '86400', 16:42:58 INFO - 'USER': 'cltbld', 16:42:58 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:58 INFO - '_': '/tools/buildbot/bin/python'} 16:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:58 INFO - Downloading/unpacking jsonschema 16:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:00 INFO - Downloading/unpacking functools32 (from jsonschema) 16:43:00 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 16:43:00 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 16:43:00 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 16:43:00 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 16:43:00 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 16:43:00 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 16:43:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:00 INFO - warning: no files found matching '*.txt' 16:43:00 INFO - no previously-included directories found matching 'build' 16:43:00 INFO - no previously-included directories found matching 'dist' 16:43:00 INFO - no previously-included directories found matching '.git*' 16:43:01 INFO - Installing collected packages: jsonschema, functools32 16:43:01 INFO - Running setup.py install for functools32 16:43:01 INFO - warning: no files found matching '*.txt' 16:43:01 INFO - no previously-included directories found matching 'build' 16:43:01 INFO - no previously-included directories found matching 'dist' 16:43:01 INFO - no previously-included directories found matching '.git*' 16:43:01 INFO - Successfully installed jsonschema functools32 16:43:01 INFO - Cleaning up... 16:43:01 INFO - Return code: 0 16:43:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1abee46f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd70410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', '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 16:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:43:01 INFO - Using env: {'DISPLAY': ':0', 16:43:01 INFO - 'HOME': '/home/cltbld', 16:43:01 INFO - 'LANG': 'en_US.UTF-8', 16:43:01 INFO - 'LANGUAGE': 'en_US:en', 16:43:01 INFO - 'LOGNAME': 'cltbld', 16:43:01 INFO - 'MAIL': '/var/mail/cltbld', 16:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:01 INFO - 'MOZ_NO_REMOTE': '1', 16:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:01 INFO - 'NO_EM_RESTART': '1', 16:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:01 INFO - 'PWD': '/builds/slave/test', 16:43:01 INFO - 'SHELL': '/bin/bash', 16:43:01 INFO - 'SHLVL': '1', 16:43:01 INFO - 'TERM': 'linux', 16:43:01 INFO - 'TMOUT': '86400', 16:43:01 INFO - 'USER': 'cltbld', 16:43:01 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:01 INFO - '_': '/tools/buildbot/bin/python'} 16:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:01 INFO - Downloading/unpacking flake8 16:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:43:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:43:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:43:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:43:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:43:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:43:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:43:04 INFO - no previously-included directories found matching 'docs/_build' 16:43:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:43:04 INFO - Running setup.py install for pep8 16:43:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:43:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:43:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:43:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:43:04 INFO - no previously-included directories found matching 'docs/_build' 16:43:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:43:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:43:04 INFO - Cleaning up... 16:43:04 INFO - Return code: 0 16:43:04 INFO - Running post-action listener: _resource_record_post_action 16:43:04 INFO - Running post-action listener: _start_resource_monitoring 16:43:04 INFO - Starting resource monitoring. 16:43:04 INFO - ##### 16:43:04 INFO - ##### Running install step. 16:43:04 INFO - ##### 16:43:04 INFO - Running pre-action listener: _resource_record_pre_action 16:43:04 INFO - Running main action method: install 16:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:43:04 INFO - Reading from file tmpfile_stdout 16:43:04 INFO - Detecting whether we're running mozinstall >=1.0... 16:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:43:04 INFO - Reading from file tmpfile_stdout 16:43:04 INFO - Output received: 16:43:04 INFO - Usage: mozinstall [options] installer 16:43:04 INFO - Options: 16:43:04 INFO - -h, --help show this help message and exit 16:43:04 INFO - -d DEST, --destination=DEST 16:43:04 INFO - Directory to install application into. [default: 16:43:04 INFO - "/builds/slave/test"] 16:43:04 INFO - --app=APP Application being installed. [default: firefox] 16:43:04 INFO - mkdir: /builds/slave/test/build/application 16:43:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:43:19 INFO - Reading from file tmpfile_stdout 16:43:19 INFO - Output received: 16:43:19 INFO - /builds/slave/test/build/application/firefox/firefox 16:43:19 INFO - Running post-action listener: _resource_record_post_action 16:43:19 INFO - ##### 16:43:19 INFO - ##### Running run-tests step. 16:43:19 INFO - ##### 16:43:19 INFO - Running pre-action listener: _resource_record_pre_action 16:43:19 INFO - Running main action method: run_tests 16:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:19 INFO - Python 2.7.3 16:43:19 INFO - Return code: 0 16:43:19 INFO - grabbing minidump binary from tooltool 16:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:19 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 0xdff160>, '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 0xe00060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe004f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:19 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 16:43:19 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 16:43:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:19 INFO - Return code: 0 16:43:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:43:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:43:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:43:20 INFO - Return code: 0 16:43:20 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/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 16:43:20 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/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 16:43:20 INFO - Using env: {'DISPLAY': ':0', 16:43:20 INFO - 'HOME': '/home/cltbld', 16:43:20 INFO - 'LANG': 'en_US.UTF-8', 16:43:20 INFO - 'LANGUAGE': 'en_US:en', 16:43:20 INFO - 'LOGNAME': 'cltbld', 16:43:20 INFO - 'MAIL': '/var/mail/cltbld', 16:43:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:20 INFO - 'MOZ_NO_REMOTE': '1', 16:43:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:20 INFO - 'NO_EM_RESTART': '1', 16:43:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:20 INFO - 'PWD': '/builds/slave/test', 16:43:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:20 INFO - 'SHELL': '/bin/bash', 16:43:20 INFO - 'SHLVL': '1', 16:43:20 INFO - 'TERM': 'linux', 16:43:20 INFO - 'TMOUT': '86400', 16:43:20 INFO - 'USER': 'cltbld', 16:43:20 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861', 16:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:20 INFO - '_': '/tools/buildbot/bin/python'} 16:43:20 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/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 16:43:21 INFO - mozversion application_buildid: 20160421141100 16:43:21 INFO - mozversion application_changeset: 90fef35d3694ae38eb7aa268c4fd9f1d6b1e514e 16:43:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:43:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:21 INFO - mozversion application_name: Firefox 16:43:21 INFO - mozversion application_remotingname: firefox-dev 16:43:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:43:21 INFO - mozversion application_vendor: Mozilla 16:43:21 INFO - mozversion application_version: 47.0a2 16:43:21 INFO - mozversion platform_buildid: 20160421141100 16:43:21 INFO - mozversion platform_changeset: 90fef35d3694ae38eb7aa268c4fd9f1d6b1e514e 16:43:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:43:21 INFO - mozversion platform_version: 47.0a2 16:43:21 INFO - using testdate: 1461282201 16:43:21 INFO - actual date: 1461282201 16:43:21 INFO - starting webserver on 'localhost:40162' 16:43:21 INFO - SUITE-START | Running 2 tests 16:43:21 INFO - TEST-START | dromaeo_css 16:43:21 INFO - operating with platform_type : linux_ 16:43:21 INFO - Initialising browser for dromaeo_css test... 16:43:21 INFO - TEST-INFO | started process 15785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ZV5pW/profile http://localhost:40162/getInfo.html) 16:43:24 INFO - PROCESS | 15785 | 16:43:24 INFO - PROCESS | 15785 | (process:15862): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:43:25 INFO - PROCESS | 15785 | __metrics Screen width/height:1600/1200 16:43:25 INFO - PROCESS | 15785 | colorDepth:24 16:43:25 INFO - PROCESS | 15785 | Browser inner width/height: 1024/697 16:43:25 INFO - PROCESS | 15785 | __metrics 16:43:25 ERROR - PROCESS | 15785 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:43:26 INFO - TEST-INFO | 15785: exit 0 16:43:26 INFO - Browser initialized. 16:43:26 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:26 INFO - TEST-INFO | started process 15913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ZV5pW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:28 INFO - PROCESS | 15913 | 16:43:28 INFO - PROCESS | 15913 | (process:15981): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:43:38 INFO - PROCESS | 15913 | RSS: Main: 151134208 16:43:38 INFO - PROCESS | 15913 | 16:44:28 INFO - PROCESS | 15913 | 1461282268292 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] 16:46:36 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:40162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40162/tests/dromaeo/cssquery-ext.html) 16:46:37 INFO - PROCESS | 15913 | RSS: Main: 155054080 16:46:37 INFO - PROCESS | 15913 | 16:49:39 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:40162/tests/dromaeo/cssquery-ext.html (next: http://localhost:40162/tests/dromaeo/cssquery-jquery.html) 16:49:39 INFO - PROCESS | 15913 | RSS: Main: 153497600 16:49:39 INFO - PROCESS | 15913 | 16:52:41 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:40162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40162/tests/dromaeo/cssquery-mootools.html) 16:52:41 INFO - PROCESS | 15913 | RSS: Main: 153055232 16:52:41 INFO - PROCESS | 15913 | 16:55:43 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:40162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40162/tests/dromaeo/cssquery-prototype.html) 16:55:44 INFO - PROCESS | 15913 | RSS: Main: 153214976 16:55:44 INFO - PROCESS | 15913 | 16:58:46 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:40162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40162/tests/dromaeo/cssquery-yui.html) 16:58:46 INFO - PROCESS | 15913 | RSS: Main: 154562560 16:58:46 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | Cycle 1(1): loaded http://localhost:40162/tests/dromaeo/cssquery-yui.html (next: http://localhost:40162/tests/dromaeo/cssquery-dojo.html) 17:01:49 INFO - PROCESS | 15913 | RSS: Main: 155389952 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | __start_tp_report 17:01:49 INFO - PROCESS | 15913 | _x_x_mozilla_page_load 17:01:49 INFO - PROCESS | 15913 | _x_x_mozilla_page_load_details 17:01:49 INFO - PROCESS | 15913 | |i|pagename|runs| 17:01:49 INFO - PROCESS | 15913 | |0;dojo.html;3273.23079076417;3331.3503866745996;3331.7334613230937;3357.278185190185;3363.0583436637735;5445.972770136149;5479.287692599962;5485.341758988917;5505.064139096353;5511.751971161302;5481.040817856869;5512.448755124486;5529.419410961851;5533.253010843535;5544.77820887164;4983.875403114933;5045.495450454961;5046.44489106198;5094.566961808251;5105.591552675777;4893.29047288143;4973.403191616993;5084.491550844923;5146.459621739719;5172.8706782330555;5012.423571289312;5038.470960549144;5042.546170844624;5051.444341122492;5100.234964755279;5103.821366252182;5127.384713834326;5188.247704082887;5190.506901844319;5191.636585439021;5040.949590504085;5092.388913330424;5106.846794596168;5131.358580177478;5166.276721259027;5316.574674026068;5329.25390445338;5357.249985002103;5394.298741163623;5416.187571864212;5969.403059693996;5977.312609049972;5994.460498555108;6004.159417681528;6020.247469066367;5875.059990401558;6035.486983606399;6040.637561746309;6044.8186554403;6066.120412540201;5570.2480165177585;5606.327240731098;5615.157726341041;5618.6628802272;5619.019138755997;6092.055731361646;6103.755849766048;6106.969465152646;6107.297660769068;6112.449879510777;5680.693440508706;5855.209546711139;5860.472557469848;5866.765329386777;5878.823635290948;6008.8798224036145;6040.848978775566;6041.6375017499095;6046.758129674852;6077.118817771487;5930.28836539618;5954.76180952757;5957.791477298274;5973.611715238496;5982.0727787193055;5764.452377024176;5921.644701317935;5947.732352044169;5979.820605381846;5992.730327135289;4466.307722303049;4492;4510.0979804039325;4515.480719717209;4525.117602067631;4038.5355684096116;4063.1264278180333;4068.7151899367354;4073.124278280184;4085.4688890444054;5524.14375771748;5653.434656534396;5731.742071606787;5780.971095144581;5785.074388097884;5730.426957304237;5964.642121472725;5968.46283834457;6038.879222415615;6104.298005729398;5621.7751289948765;5623.493885550321;5644.915326270109;5649.322081350264;5649.830505084854;4882.170031094723;4988.6757360771435;5002.199648056294;5009.849704508871;5018.096742586296;6183.598066125687;6184.752609895644;6187.412195841388;6207.068939659087;6222.968885155546;5965.821025369246;6019.187409699634;6025.849353766191;6029.57792954489;6049.153118563317;5907.2911250650195;6136.723847426966;6147.231596050494;6190.133381326708;6194.287656919512;5888.411158884077;5924.763009479572;5928.733207005781;5930.199423077829;5935.317438494456;6007.429294217042;6028.125921741411;6030.216071910623;6031.396860313934;6036.094585812163;5589.80435684749;5747.4252574742195;5834.766609335579;5852.678102704393;5874.882502350015;5878.735456904364;5911.763529458945;5913.408659134052;5923.200367950444;5926.1999630049395;5566.638168519034;5776.422357764358;5796.449337312949;5816.505597024131;5821.039528477754;5913.70431478433;5918.786648736913;5924.348321684525;5929.318128415288;5968.074948383008;5676.4323567642905;5707.6575405475805;5712.228849105318;5717.8570535736935;5727.971360143172 17:01:49 INFO - PROCESS | 15913 | |1;ext.html;544.51810148019;544.8365490352893;563.7378618942192;571.2973043156915;578.6904006356598;36791;37571.24857502848;37591.99999999996;37620.24759504808;37709.24581508368;39320.60679393205;39724.40413393801;40164.196716065664;40232.79883600585;40326;8590.484570925764;8752.387332886701;8777.64889404423;8779.165979231962;8785.121487851227;8475.067742548315;8627.180417860292;8653.653853845839;8907.421017633866;8950.14973577509;8943.731688049369;9031.683891063814;9037.141471560224;9043.231325337354;9067.410618309821;8872.689455869046;8883.200511953923;8931.910680893174;8981.506017169053;8990.910090899073;8826.117388261187;8975.685850995184;8978.326625503048;8986.281097512183;9009.189172974464;39095.8045209775;39331.60668393308;39689.20621587581;39707.40438893419;39731;3657.244522629126;3770.547534295902;3814.313423583754;3832.50177476929;4007.959920400817;32679.183020424443;32742.34515309704;32895.342093158244;33347.33305333904;33515.49726754076;4261.488621365456;4266.509351424595;4306.5478124796755;4345.456817897762;4353.825846966118;291632;295198;297050;297129;298444;60856.391436085076;62353.06470402948;62401.37598624046;62493.68753156205;62611;74079.62960185164;75566.24433755592;75569.24430755622;75621;75753.62123189348;17640.294388224585;17865.910670446563;17982.5504362392;18009.63980720378;18516.444506664822;13785.655358616115;13891.722165556632;13923.930380348034;13935.372908219155;13972.441102355995;22280.220192293193;22620.773792262196;22689.432764180696;22867;22908.885455572614;7737.3036426721865;8210.178982101743;8224.712135075364;8293.709720159766;8317.750467485985;971.795922856194;980.3039841712322;1074.049466222399;1117.4971262931713;1141.9779297528664;29850.776114180368;30002.047001142993;30302.69697303043;30382.84808575943;30449.695503045128;1084.5228099636136;1103.486878601438;1106.6934051224398;1114.9331040137617;1165.0504838556549;15674.294656740474;15739.213039347987;15755.527334179993;15821.68356632861;15946.325635808305;358555;432369;479666;482985;496138;57615.711921440125;57890.4210957885;58363.12455313174;58395.416045838996;58526.41473585295;1434.8206474190727;1449.7390469715342;1457.5627311806415;1461.9049761765452;1466.2375564706292;30253.243668908453;31463.685363146076;31863;32132.83933580317;32145.357092857543;47867.28199077086;48226.758866206845;48320.75839620779;48620.27069593888;48676;242726;242922;243048;245960;246009;41982;42631.57368426276;46749.29876051794;47342.52657473381;47819.5218047829;43660.56339436565;43966.780166098964;44454.77772611116;44959.55040449554;45331.773341133085;37453;39599.80200098981;40943.590564093975;41460.58539414567;41826.1634767309;39304.60695393124;39765.20469590534;40355.79822100871;40622;41292.587074128875;40067.1986560273;40192.59807401888;40651.59348406478;41043;41260.58739412567;34848.30303393969;34859.4771078429;35530.28939421249;35547.82226088853;35748.39132239108;27162.32094197661;27756.58365124565;27933;27971.300717482227;28102.85948570244 17:01:49 INFO - PROCESS | 15913 | |2;jquery.html;334.9631540530541;388.57062945445284;396.8531643291981;397.05698964958225;399.1637519396866;17905.82094179058;18756.43730688078;19202.751821131653;19641.607167856633;19665.803341966577;12871.54949576765;13159.60521184366;13187.472501099968;13264.602061938158;13265.668358291048;5193.974030129853;5422.457754224585;5737.770489180428;5758;5760.222369980062;5667.064934285838;5767.682777447239;5770.163326317682;5773;5779.566532510057;5542.473465020817;5755.597108202427;5757.193992841006;5768.826935191951;5779.711014449282;5677.659340439566;5740.225069615611;5747.08046712524;5748.655080695151;5755.856103597402;5138.794448222066;5210.218467229908;5211.24436956643;5216.26972223889;5230.8692282692855;14500.92749536256;14501.70996580073;14678.412863485448;17062.48812535626;21880.781192188035;2181.7054697615936;2403.975960240393;2430.6111022236532;2489.3652118709615;2662.828355523583;10721.463926803706;11234.550617975272;13749.518766843112;14157.85842141586;14286.928565357211;1922.9615407691908;1923.5479662279354;1931.8357939575153;1956.4521933858543;1975.2099160335838;61089;66285;67233.3276667232;67429.32570674279;68877;10220.284580079471;10335.896641033494;10395.792084158275;10616.150707943347;10821.56713731442;15049.623759406102;15275.694486110215;15302;15332.15673137988;15412.46056388021;8167.509949403055;8233.8353232935;8319.750407487785;8322.45904016237;8415.242628163373;7866.252705992922;8018.278354948083;8023.438359314909;8047.919520804717;8098.3116435103675;4654.208784506574;4658.417697787777;4687;4736.73947932867;4805.9038819224115;1872.7284543741355;1949.9902500487406;1972.8717633353785;1974.2497850816599;2002.589469158819;953.1469334945185;1034.6533911139702;1045.7803861189236;1069.5133714160195;1113.0316624536704;17178.282171782972;17719.55701107457;17742.91128544349;18072.548186295186;18372.724409133873;855.7646647171953;968.9757756056155;996.1731762636994;1033.540074666766;1093.9989909233122;9585.424874507551;9756.90243097574;9944.651937182163;10333.966603339757;10459.68620941373;482700;490046;499993;504214;507593;54113.72943135259;73525;75134.24865751382;77052.22947770562;78311;1011.3375738890891;1061.4692653673164;1062.7396287909512;1069.5721711315537;1097.2812807611188;15682.843171568138;15760.211989400714;16019.8398016023;16652.167391630126;16717;36067.27865442624;36131.63868361283;36327.27345453129;36497.33488527806;37200.81399592985;50198.74900625474;52567;52755.20867187072;53661.463385367206;53745.73127134339;8284.544350060805;8487.745367638981;8697;8840.557972101498;9004.729858104267;12287.201331913755;12881;13243.536476223286;13280.867191327963;13343.132696374705;10445.425501597485;11227.38249396291;11292.830607540729;11595;11674.416279186176;11757.470913808727;11882.524699011943;12000.459979301128;12197.573084941985;12365.07261955339;11299.2655477397;11599.188056835941;11746.647600571996;12165.574204902787;12613.81079283793;8595.269402100892;8813.60338784769;8964.955175224342;8996.820063598561;9247.982721900451;11407.315561066363;11940.223885447418;12069.879301207227;12136.150469467053;12193 17:01:49 INFO - PROCESS | 15913 | |3;mootools.html;1535.2672243406735;1566.4752307976828;1784.3487127198568;1869.7195420686903;1891.1111777464596;7370.078740157481;8047.637856296481;8089.23152300532;8273.710420135296;8289.461185022978;7949.085855126662;8003.319717823992;8138.91861081389;8141.837163256731;8231.300339471152;2442.8656423896678;2457.447074408253;2478.996006617323;2483.31708780086;2486.7513248675077;2362.6456031595226;2412.5657381671294;2413.0347860855622;2417.62526808345;2419.5523828091773;2344.894479748407;2358.811295096397;2361.681173041643;2378.3340664613847;2409.5421869844763;2351.0713268259115;2358.3868194269444;2366;2386.284114765572;2424.9151279705125;2401.2676133779364;2445.3764290106087;2461.7045954485575;2462.815288853343;2467.4078221226955;8332.750017499484;8340.62467188978;8364.079951205362;8383.035950865667;8393;5044.697318160922;5107.846764597068;5166.405863325691;5166.767495462713;5196.68819870809;3124.0940127363037;3140.0736782649174;3151.8108913465267;3160.1625569224175;3196.7122958933573;1011.4993078426153;1041.6458404142552;1056.5773690523774;1074.1889873145724;1101.9173561982884;11410.315381077162;11424.828627570592;11451.541938322458;11472.196946213768;11496.252743571558;4317.179735850178;4360.869173924724;4432.867013989586;4564.064366804797;4583.564561366665;9072.727818165333;9093.090690930854;9136.177744002938;9138.223251023604;9162;4934.654574179773;4988.9750551247735;5020.3724534433195;5029.547340739351;5031.899362012739;4052.230076285496;4521.61566266871;4608.746518941491;4614.284785858197;4642.46611639659;3664;3716.442533619979;3750.6999440044733;3757.9060523486582;3783.886483405502;1104.2380757277454;1128.819388897789;1132.9660110196708;1137.5506674863382;1142.177632104883;928.8420968435247;941.6045260990401;949.1979277510493;1063.3991794636006;1422.0472283570032;7570.091589009354;7624.19945905683;7633.2366763324335;7656.502327348704;7677.886706427536;540.3818499370543;547.7015026810398;549.0720682047407;550.435803301611;559.2478116932718;5820;5824.708764561755;5869.618474799125;5922.940770592325;6069.271687397452;9740.561674724655;10032.899671003343;10100.343477673927;10149.188064954786;10159.796804063877;9462.479563623929;9668.936416994125;9712.660056897974;9809.754756131153;9979.650712225037;7624.961875190699;7648.426368022309;7656.578888161093;7680.3087722104165;7696.4227682924;7371.447141464304;7380.889286660812;7445.367143792838;7462.141853686896;7519.473636845369;8677.956610216908;8841.911580884365;8848.380613357003;8928.553572321487;9002.369834111549;9060.682876099305;9157.31320150978;9171.816563668823;9233.399829011092;9485.57314920844;6627.768028118992;6759.121314229119;6891.069705589882;7039.507234493741;7139.071920650283;7762.844743105219;7773.378129749493;7811.453198276294;7828.373730101692;7880.763577092696;7026.718931242693;7175.8564828704175;7211.134663840373;7302.56184628924;7309.342159205697;6979.1973922999505;7003.4747393944635;7073.257307982588;7091.219965803861;7105.32499412555;7007.264237255014;7149.285071492809;7157.892631610426;7209.567425954459;7210.1708303545765;6572.671366431755;6582.670866456754;6645.800625981228;6646.567973081735;6663;6490.188726409199;6639.170103737033;6641.169853768279;6676.566023208476;6719.899201511884 17:01:49 INFO - PROCESS | 15913 | |4;prototype.html;363.4366731566072;366.254671743003;369.6192921291071;370.21329674441813;375.9605241449648;6319.431251187392;6420.3579642035775;6432.871342573151;6464.482841372691;6468.385503377183;6354.396332348431;6410.743570257196;6449.935500644992;6453.870922581557;6468.126802881609;4697.412823397075;4759.262314341266;4793.520647935214;4797.40032495938;4943.431505376874;4764.475907650156;4786.353842231289;4788.138135135674;4788.521147885201;4793;4716.787744551486;4740.099381117594;4748.240281554952;4800.087983283182;4801.5438533339275;4795.928061079069;4801.2798080287885;4813.855584332476;4816.494268101869;4824.6863953842885;4160.604742549453;4172.520160181588;4172.687048471377;4174.728642638219;4180.707350485437;6034.547408944347;6059.7273122709585;6069.02895536712;6072.301685306202;6072.605280656788;5560.138178582326;5569.136783798518;5571.777128914839;5582.218489411485;5583.85530966151;6613.371729685672;6683.3650803174105;6705.664716764191;6714.227863795677;6717.496187785936;4567.177907976563;4587.266037434028;4590.701604395704;4592.494825569184;4595.862124136282;6990.196127445307;7026.824329391755;7055.823604409879;7056.435485161175;7060.329268719514;4609.354690343354;4663.930041049387;4700.318453824177;4702.130105930414;4702.553257440538;4754.144254034238;4785.449673287547;4790.449098353664;4794.161021821167;4798.880027999328;5561.110222364402;5567.081431563746;5567.109262517978;5597.468240517226;5600.803971860965;6747.561408508432;6771.62756048422;6786;6788.151481064867;6800.52396332252;1651.149657926145;1651.4137481194243;1653.5535405440464;1654.0654530190404;1654.561541191585;1065.4512925843196;1107.5016242690822;1147.0479502013309;1149.4654985431814;1153.8153895376868;6541.6075035498025;6555.639439830855;6564.277929427759;6574.211094668671;6579.30917253691;6968.407685346802;6994.965025174842;7040.401565866959;7056.470764692566;7061.187963384276;6289.433950944437;6414.166158399472;6536.411722944958;6638.701258443381;6664.400203981665;3843.9615603844163;3875.2443273561385;3875.748076375083;3876.282887665791;3880.0687834919418;7290.744823931137;7317.634118294064;7355.668994895243;7360.926390736131;7389.1502477214735;7261.273872612696;7288.3076107769675;7292.927070729331;7295.927040729631;7296.087989001375;7069;7361.190269070398;7387;7397.408207343399;7399.556026638311;7079.079719636415;7103.112110986127;7142.5714457132735;7144.607046612487;7148.392386647193;6900.309969003059;6909.827254318682;6954.617496037564;6958.130233720785;6998.930010699828;7271.200167981412;7360.411167106511;7361.889571656322;7386.630668466448;7395.445341599294;4598.793054312631;4661.953380466288;4703.200455922433;4717.245240761462;4795.064962332312;6982.231954484901;6982.720691172296;7042.330978557029;7066.293370662893;7077.150741911004;6771.695273712597;6785.626790526569;6786.287439818748;6796.660166991532;6806.77478053955;6813.0461735358085;6825.692843822139;6853.4859885507785;6861.005154252505;6866.4506839453725;6551.574147680385;6720.428763554957;6749.730010799513;6798.592084474947;6803.319668033157;6852.8286792828585;6884.862302753817;6889.035535025;6931.133608298963;6940.895886561605;6631.701573429304;6690.19717633887;6693;6699;6720.899186512304 17:01:49 INFO - PROCESS | 15913 | |5;yui.html;769.657502411427;822.1572887790019;824.1867099893018;844.2781421884287;899.1907283444903;13808.240546769923;14115.858841411582;14132.50536231232;14134.858651413482;14151.787723184161;12527.436265368058;12601.180923239983;12622.24266544008;12653.430595623196;12703.237805731662;900.2392977933652;906.0939060939061;911.0707078779641;938.9483578403185;944.1549812917435;952.3238500664537;955.2978560757838;955.4315182466421;956.4930586789013;959.395580784105;988.2686811759282;988.7280997725647;988.8318985772436;991.7223177510273;991.7520619845038;983;983.2429029647203;983.8376667849797;983.9311248212628;986.0681655835202;724.9420046396276;726.6076318787848;727.3599232675265;727.4253339861503;729.3035151430371;13675.794863077062;13680.042397032212;13703;13718.108322958975;13814.861851381458;13144.40850161745;13207.207567545978;13249.337533123306;13254.933725331408;13425.731485370237;10181.796364072678;10397.376157430579;10440.164786817113;10612.416317102556;10851.945740271249;3773.13217959868;3777.376732839078;3790.0903783092135;3814.866479673226;3854.8265328060306;55444.445555544735;55448.168277476274;56111;56112.43887561113;56237;10260.384376937407;10589.205809564313;10719.088877445349;10759.462026898624;10795.460226988776;19047.714284285747;19126.426207213804;19154.138063787163;19294.22823087061;19296.517587060436;7289.307515785992;7368.6919680862575;7409.407247420193;7460;7514.211007844207;4272.658187345005;4427.535108813592;4510.594046535827;4551.840685575989;4552.408186935743;3184.5860038194887;3187.0916788715103;3193.2336239302863;3194.105650417887;3200.135963289899;574.9453801888814;583.1427801132329;590.3122861865963;591;595.1964847455986;624.9562530622812;665.9444780023716;684.2404930527111;708.4686485136148;753.3897542990195;8246.340292776684;8444.57777111142;8526.317894568543;8573.957130214309;8632.482051076955;725.6952080126359;732.2640746050185;734.6693987705447;735.5366119344885;757.9166291707908;3669.889903302905;4071.328230841937;4113.441872780024;4138.896527586834;4254.638355739735;56921.43078569244;57621.711891440274;57689.423105769245;58113;59340.10989835156;54592.45407545953;55008.449915500336;55887.720561396934;56058.159127613115;56350.43649563534;49035;49113;49184.26223606649;49652.25521617251;49793.75103124461;7687.423443241891;7803.414743894117;7878.566678832719;7997.480163789335;8147.511149331059;40224.396634051096;40895.795521022206;41092.383614246406;41121.58878411177;41481.58518414898;48347.51652483571;48557.5144248553;48559.75720121377;48562;50681.49318506768;11654.533818647498;11745.706357340792;11911.166218364631;12043.879561204276;12181.69545761363;12293.139480236297;12779.36103194855;13050.282234477196;13326.200427974352;13335.933320333725;10995.450227488753;11453.656390308304;11783.351915644722;12168.026557875171;12474.376281186085;12029.879701202875;12133;12394.938025309815;12428.62714118578;12433.751324973631;10892.673219803419;12019.63941081769;12102.213356131822;12375.257484550955;12423.254604723745;10190.643327483502;10312.48437578133;10487.056164944886;10659;11091.112710982941;9967.651132210338;10092.293539452461;10123.203798575534;10197.949010255197;10363.119134873621 17:01:49 INFO - PROCESS | 15913 | __end_tp_report 17:01:49 INFO - PROCESS | 15913 | __start_cc_report 17:01:49 INFO - PROCESS | 15913 | _x_x_mozilla_cycle_collect,339 17:01:49 INFO - PROCESS | 15913 | __end_cc_report 17:01:49 INFO - PROCESS | 15913 | __startTimestamp1461283309363__endTimestamp 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | ------- Summary: start ------- 17:01:49 INFO - PROCESS | 15913 | Number of tests: 6 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | [#0] dojo.html Cycles:165 Average:5539.39 Median:5747.43 stddev:630.50 (11.0%) stddev-sans-first:606.85 17:01:49 INFO - PROCESS | 15913 | Values: 3273.2 3331.4 3331.7 3357.3 3363.1 5446.0 5479.3 5485.3 5505.1 5511.8 5481.0 5512.4 5529.4 5533.3 5544.8 4983.9 5045.5 5046.4 5094.6 5105.6 4893.3 4973.4 5084.5 5146.5 5172.9 5012.4 5038.5 5042.5 5051.4 5100.2 5103.8 5127.4 5188.2 5190.5 5191.6 5040.9 5092.4 5106.8 5131.4 5166.3 5316.6 5329.3 5357.2 5394.3 5416.2 5969.4 5977.3 5994.5 6004.2 6020.2 5875.1 6035.5 6040.6 6044.8 6066.1 5570.2 5606.3 5615.2 5618.7 5619.0 6092.1 6103.8 6107.0 6107.3 6112.4 5680.7 5855.2 5860.5 5866.8 5878.8 6008.9 6040.8 6041.6 6046.8 6077.1 5930.3 5954.8 5957.8 5973.6 5982.1 5764.5 5921.6 5947.7 5979.8 5992.7 4466.3 4492.0 4510.1 4515.5 4525.1 4038.5 4063.1 4068.7 4073.1 4085.5 5524.1 5653.4 5731.7 5781.0 5785.1 5730.4 5964.6 5968.5 6038.9 6104.3 5621.8 5623.5 5644.9 5649.3 5649.8 4882.2 4988.7 5002.2 5009.8 5018.1 6183.6 6184.8 6187.4 6207.1 6223.0 5965.8 6019.2 6025.8 6029.6 6049.2 5907.3 6136.7 6147.2 6190.1 6194.3 5888.4 5924.8 5928.7 5930.2 5935.3 6007.4 6028.1 6030.2 6031.4 6036.1 5589.8 5747.4 5834.8 5852.7 5874.9 5878.7 5911.8 5913.4 5923.2 5926.2 5566.6 5776.4 5796.4 5816.5 5821.0 5913.7 5918.8 5924.3 5929.3 5968.1 5676.4 5707.7 5712.2 5717.9 5728.0 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | [#1] ext.html Cycles:180 Average:51524.92 Median:22086.08 stddev:90334.20 (409.0%) stddev-sans-first:90506.52 17:01:49 INFO - PROCESS | 15913 | Values: 544.5 544.8 563.7 571.3 578.7 36791.0 37571.2 37592.0 37620.2 37709.2 39320.6 39724.4 40164.2 40232.8 40326.0 8590.5 8752.4 8777.6 8779.2 8785.1 8475.1 8627.2 8653.7 8907.4 8950.1 8943.7 9031.7 9037.1 9043.2 9067.4 8872.7 8883.2 8931.9 8981.5 8990.9 8826.1 8975.7 8978.3 8986.3 9009.2 39095.8 39331.6 39689.2 39707.4 39731.0 3657.2 3770.5 3814.3 3832.5 4008.0 32679.2 32742.3 32895.3 33347.3 33515.5 4261.5 4266.5 4306.5 4345.5 4353.8 291632.0 295198.0 297050.0 297129.0 298444.0 60856.4 62353.1 62401.4 62493.7 62611.0 74079.6 75566.2 75569.2 75621.0 75753.6 17640.3 17865.9 17982.6 18009.6 18516.4 13785.7 13891.7 13923.9 13935.4 13972.4 22280.2 22620.8 22689.4 22867.0 22908.9 7737.3 8210.2 8224.7 8293.7 8317.8 971.8 980.3 1074.0 1117.5 1142.0 29850.8 30002.0 30302.7 30382.8 30449.7 1084.5 1103.5 1106.7 1114.9 1165.1 15674.3 15739.2 15755.5 15821.7 15946.3 358555.0 432369.0 479666.0 482985.0 496138.0 57615.7 57890.4 58363.1 58395.4 58526.4 1434.8 1449.7 1457.6 1461.9 1466.2 30253.2 31463.7 31863.0 32132.8 32145.4 47867.3 48226.8 48320.8 48620.3 48676.0 242726.0 242922.0 243048.0 245960.0 246009.0 41982.0 42631.6 46749.3 47342.5 47819.5 43660.6 43966.8 44454.8 44959.6 45331.8 37453.0 39599.8 40943.6 41460.6 41826.2 39304.6 39765.2 40355.8 40622.0 41292.6 40067.2 40192.6 40651.6 41043.0 41260.6 34848.3 34859.5 35530.3 35547.8 35748.4 27162.3 27756.6 27933.0 27971.3 28102.9 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | [#2] jquery.html Cycles:180 Average:27543.24 Median:2459.99 stddev:81295.60 (3304.7%) stddev-sans-first:81497.99 17:01:49 INFO - PROCESS | 15913 | Values: 335.0 388.6 396.9 397.1 399.2 17905.8 18756.4 19202.8 19641.6 19665.8 12871.5 13159.6 13187.5 13264.6 13265.7 5194.0 5422.5 5737.8 5758.0 5760.2 5667.1 5767.7 5770.2 5773.0 5779.6 5542.5 5755.6 5757.2 5768.8 5779.7 5677.7 5740.2 5747.1 5748.7 5755.9 5138.8 5210.2 5211.2 5216.3 5230.9 14500.9 14501.7 14678.4 17062.5 21880.8 2181.7 2404.0 2430.6 2489.4 2662.8 10721.5 11234.6 13749.5 14157.9 14286.9 1923.0 1923.5 1931.8 1956.5 1975.2 61089.0 66285.0 67233.3 67429.3 68877.0 10220.3 10335.9 10395.8 10616.2 10821.6 15049.6 15275.7 15302.0 15332.2 15412.5 8167.5 8233.8 8319.8 8322.5 8415.2 7866.3 8018.3 8023.4 8047.9 8098.3 4654.2 4658.4 4687.0 4736.7 4805.9 1872.7 1950.0 1972.9 1974.2 2002.6 953.1 1034.7 1045.8 1069.5 1113.0 17178.3 17719.6 17742.9 18072.5 18372.7 855.8 969.0 996.2 1033.5 1094.0 9585.4 9756.9 9944.7 10334.0 10459.7 482700.0 490046.0 499993.0 504214.0 507593.0 54113.7 73525.0 75134.2 77052.2 78311.0 1011.3 1061.5 1062.7 1069.6 1097.3 15682.8 15760.2 16019.8 16652.2 16717.0 36067.3 36131.6 36327.3 36497.3 37200.8 50198.7 52567.0 52755.2 53661.5 53745.7 8284.5 8487.7 8697.0 8840.6 9004.7 12287.2 12881.0 13243.5 13280.9 13343.1 10445.4 11227.4 11292.8 11595.0 11674.4 11757.5 11882.5 12000.5 12197.6 12365.1 11299.3 11599.2 11746.6 12165.6 12613.8 8595.3 8813.6 8965.0 8996.8 9248.0 11407.3 11940.2 12069.9 12136.2 12193.0 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | [#3] mootools.html Cycles:180 Average:5678.90 Median:6279.73 stddev:2987.86 (47.6%) stddev-sans-first:2980.01 17:01:49 INFO - PROCESS | 15913 | Values: 1535.3 1566.5 1784.3 1869.7 1891.1 7370.1 8047.6 8089.2 8273.7 8289.5 7949.1 8003.3 8138.9 8141.8 8231.3 2442.9 2457.4 2479.0 2483.3 2486.8 2362.6 2412.6 2413.0 2417.6 2419.6 2344.9 2358.8 2361.7 2378.3 2409.5 2351.1 2358.4 2366.0 2386.3 2424.9 2401.3 2445.4 2461.7 2462.8 2467.4 8332.8 8340.6 8364.1 8383.0 8393.0 5044.7 5107.8 5166.4 5166.8 5196.7 3124.1 3140.1 3151.8 3160.2 3196.7 1011.5 1041.6 1056.6 1074.2 1101.9 11410.3 11424.8 11451.5 11472.2 11496.3 4317.2 4360.9 4432.9 4564.1 4583.6 9072.7 9093.1 9136.2 9138.2 9162.0 4934.7 4989.0 5020.4 5029.5 5031.9 4052.2 4521.6 4608.7 4614.3 4642.5 3664.0 3716.4 3750.7 3757.9 3783.9 1104.2 1128.8 1133.0 1137.6 1142.2 928.8 941.6 949.2 1063.4 1422.0 7570.1 7624.2 7633.2 7656.5 7677.9 540.4 547.7 549.1 550.4 559.2 5820.0 5824.7 5869.6 5922.9 6069.3 9740.6 10032.9 10100.3 10149.2 10159.8 9462.5 9668.9 9712.7 9809.8 9979.7 7625.0 7648.4 7656.6 7680.3 7696.4 7371.4 7380.9 7445.4 7462.1 7519.5 8678.0 8841.9 8848.4 8928.6 9002.4 9060.7 9157.3 9171.8 9233.4 9485.6 6627.8 6759.1 6891.1 7039.5 7139.1 7762.8 7773.4 7811.5 7828.4 7880.8 7026.7 7175.9 7211.1 7302.6 7309.3 6979.2 7003.5 7073.3 7091.2 7105.3 7007.3 7149.3 7157.9 7209.6 7210.2 6572.7 6582.7 6645.8 6646.6 6663.0 6490.2 6639.2 6641.2 6676.6 6719.9 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | [#4] prototype.html Cycles:180 Average:5669.38 Median:6468.26 stddev:1745.72 (27.0%) stddev-sans-first:1704.59 17:01:49 INFO - PROCESS | 15913 | Values: 363.4 366.3 369.6 370.2 376.0 6319.4 6420.4 6432.9 6464.5 6468.4 6354.4 6410.7 6449.9 6453.9 6468.1 4697.4 4759.3 4793.5 4797.4 4943.4 4764.5 4786.4 4788.1 4788.5 4793.0 4716.8 4740.1 4748.2 4800.1 4801.5 4795.9 4801.3 4813.9 4816.5 4824.7 4160.6 4172.5 4172.7 4174.7 4180.7 6034.5 6059.7 6069.0 6072.3 6072.6 5560.1 5569.1 5571.8 5582.2 5583.9 6613.4 6683.4 6705.7 6714.2 6717.5 4567.2 4587.3 4590.7 4592.5 4595.9 6990.2 7026.8 7055.8 7056.4 7060.3 4609.4 4663.9 4700.3 4702.1 4702.6 4754.1 4785.4 4790.4 4794.2 4798.9 5561.1 5567.1 5567.1 5597.5 5600.8 6747.6 6771.6 6786.0 6788.2 6800.5 1651.1 1651.4 1653.6 1654.1 1654.6 1065.5 1107.5 1147.0 1149.5 1153.8 6541.6 6555.6 6564.3 6574.2 6579.3 6968.4 6995.0 7040.4 7056.5 7061.2 6289.4 6414.2 6536.4 6638.7 6664.4 3844.0 3875.2 3875.7 3876.3 3880.1 7290.7 7317.6 7355.7 7360.9 7389.2 7261.3 7288.3 7292.9 7295.9 7296.1 7069.0 7361.2 7387.0 7397.4 7399.6 7079.1 7103.1 7142.6 7144.6 7148.4 6900.3 6909.8 6954.6 6958.1 6998.9 7271.2 7360.4 7361.9 7386.6 7395.4 4598.8 4662.0 4703.2 4717.2 4795.1 6982.2 6982.7 7042.3 7066.3 7077.2 6771.7 6785.6 6786.3 6796.7 6806.8 6813.0 6825.7 6853.5 6861.0 6866.5 6551.6 6720.4 6749.7 6798.6 6803.3 6852.8 6884.9 6889.0 6931.1 6940.9 6631.7 6690.2 6693.0 6699.0 6720.9 17:01:49 INFO - PROCESS | 15913 | 17:01:49 INFO - PROCESS | 15913 | [#5] yui.html Cycles:180 Average:14747.87 Median:4469.06 stddev:17348.99 (388.2%) stddev-sans-first:17365.90 17:01:49 INFO - PROCESS | 15913 | Values: 769.7 822.2 824.2 844.3 899.2 13808.2 14115.9 14132.5 14134.9 14151.8 12527.4 12601.2 12622.2 12653.4 12703.2 900.2 906.1 911.1 938.9 944.2 952.3 955.3 955.4 956.5 959.4 988.3 988.7 988.8 991.7 991.8 983.0 983.2 983.8 983.9 986.1 724.9 726.6 727.4 727.4 729.3 13675.8 13680.0 13703.0 13718.1 13814.9 13144.4 13207.2 13249.3 13254.9 13425.7 10181.8 10397.4 10440.2 10612.4 10851.9 3773.1 3777.4 3790.1 3814.9 3854.8 55444.4 55448.2 56111.0 56112.4 56237.0 10260.4 10589.2 10719.1 10759.5 10795.5 19047.7 19126.4 19154.1 19294.2 19296.5 7289.3 7368.7 7409.4 7460.0 7514.2 4272.7 4427.5 4510.6 4551.8 4552.4 3184.6 3187.1 3193.2 3194.1 3200.1 574.9 583.1 590.3 591.0 595.2 625.0 665.9 684.2 708.5 753.4 8246.3 8444.6 8526.3 8574.0 8632.5 725.7 732.3 734.7 735.5 757.9 3669.9 4071.3 4113.4 4138.9 4254.6 56921.4 57621.7 57689.4 58113.0 59340.1 54592.5 55008.4 55887.7 56058.2 56350.4 49035.0 49113.0 49184.3 49652.3 49793.8 7687.4 7803.4 7878.6 7997.5 8147.5 40224.4 40895.8 41092.4 41121.6 41481.6 48347.5 48557.5 48559.8 48562.0 50681.5 11654.5 11745.7 11911.2 12043.9 12181.7 12293.1 12779.4 13050.3 13326.2 13335.9 10995.5 11453.7 11783.4 12168.0 12474.4 12029.9 12133.0 12394.9 12428.6 12433.8 10892.7 12019.6 12102.2 12375.3 12423.3 10190.6 10312.5 10487.1 10659.0 11091.1 9967.7 10092.3 10123.2 10197.9 10363.1 17:01:49 INFO - PROCESS | 15913 | -------- Summary: end -------- 17:01:49 INFO - PROCESS | 15913 | 17:01:50 INFO - TEST-INFO | 15913: exit 0 17:01:50 INFO - TEST-OK | dromaeo_css | took 1109028ms 17:01:50 INFO - TEST-START | kraken 17:01:50 INFO - operating with platform_type : linux_ 17:01:50 INFO - Initialising browser for kraken test... 17:01:50 INFO - TEST-INFO | started process 16156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5GvNgl/profile http://localhost:40162/getInfo.html) 17:01:53 INFO - PROCESS | 16156 | 17:01:53 INFO - PROCESS | 16156 | (process:16235): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:01:54 INFO - PROCESS | 16156 | __metrics Screen width/height:1600/1200 17:01:54 INFO - PROCESS | 16156 | colorDepth:24 17:01:54 INFO - PROCESS | 16156 | Browser inner width/height: 1024/697 17:01:54 INFO - PROCESS | 16156 | __metrics 17:01:54 ERROR - PROCESS | 16156 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:01:55 INFO - TEST-INFO | 16156: exit 0 17:01:55 INFO - Browser initialized. 17:01:55 INFO - Running cycle 1/1 for kraken test... 17:01:55 INFO - TEST-INFO | started process 16286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5GvNgl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:57 INFO - PROCESS | 16286 | 17:01:57 INFO - PROCESS | 16286 | (process:16354): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:02:07 INFO - PROCESS | 16286 | RSS: Main: 151326720 17:02:07 INFO - PROCESS | 16286 | 17:02:10 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40162/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:10 INFO - PROCESS | 16286 | RSS: Main: 154857472 17:02:10 INFO - PROCESS | 16286 | 17:02:13 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40162/tests/kraken/driver.html?testName=audio-dft) 17:02:14 INFO - PROCESS | 16286 | RSS: Main: 155709440 17:02:14 INFO - PROCESS | 16286 | 17:02:16 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40162/tests/kraken/driver.html?testName=audio-fft) 17:02:17 INFO - PROCESS | 16286 | RSS: Main: 156102656 17:02:17 INFO - PROCESS | 16286 | 17:02:19 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40162/tests/kraken/driver.html?testName=audio-oscillator) 17:02:20 INFO - PROCESS | 16286 | RSS: Main: 156172288 17:02:20 INFO - PROCESS | 16286 | 17:02:22 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:22 INFO - PROCESS | 16286 | RSS: Main: 156119040 17:02:22 INFO - PROCESS | 16286 | 17:02:26 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40162/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:26 INFO - PROCESS | 16286 | RSS: Main: 155979776 17:02:26 INFO - PROCESS | 16286 | 17:02:30 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40162/tests/kraken/driver.html?testName=imaging-desaturate) 17:02:30 INFO - PROCESS | 16286 | RSS: Main: 156299264 17:02:30 INFO - PROCESS | 16286 | 17:02:33 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40162/tests/kraken/driver.html?testName=json-parse-financial) 17:02:34 INFO - PROCESS | 16286 | RSS: Main: 156323840 17:02:34 INFO - PROCESS | 16286 | 17:02:35 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:02:36 INFO - PROCESS | 16286 | RSS: Main: 156233728 17:02:36 INFO - PROCESS | 16286 | 17:02:37 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:02:38 INFO - PROCESS | 16286 | RSS: Main: 156782592 17:02:38 INFO - PROCESS | 16286 | 17:02:40 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:02:41 INFO - PROCESS | 16286 | RSS: Main: 156139520 17:02:41 INFO - PROCESS | 16286 | 17:02:43 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:02:44 INFO - PROCESS | 16286 | RSS: Main: 156479488 17:02:44 INFO - PROCESS | 16286 | 17:02:46 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:02:47 INFO - PROCESS | 16286 | RSS: Main: 156803072 17:02:47 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | Cycle 1(1): loaded http://localhost:40162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40162/tests/kraken/driver.html?testName=ai-astar) 17:02:49 INFO - PROCESS | 16286 | RSS: Main: 158633984 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | __start_tp_report 17:02:49 INFO - PROCESS | 16286 | _x_x_mozilla_page_load 17:02:49 INFO - PROCESS | 16286 | _x_x_mozilla_page_load_details 17:02:49 INFO - PROCESS | 16286 | |i|pagename|runs| 17:02:49 INFO - PROCESS | 16286 | |0;ai-astar;113;108;111;110;109;122;111;110;110;110 17:02:49 INFO - PROCESS | 16286 | |1;audio-beat-detection;157;132;150;168;128;162;163;136;167;129 17:02:49 INFO - PROCESS | 16286 | |2;audio-dft;162;163;163;162;167;165;163;165;164;164 17:02:49 INFO - PROCESS | 16286 | |3;audio-fft;79;75;77;162;76;77;74;75;188;76 17:02:49 INFO - PROCESS | 16286 | |4;audio-oscillator;94;94;153;94;93;94;149;93;93;139 17:02:49 INFO - PROCESS | 16286 | |5;imaging-gaussian-blur;117;118;117;118;119;117;117;117;117;117 17:02:49 INFO - PROCESS | 16286 | |6;imaging-darkroom;148;147;147;147;148;149;147;147;147;148 17:02:49 INFO - PROCESS | 16286 | |7;imaging-desaturate;95;96;96;96;97;96;96;96;97;97 17:02:49 INFO - PROCESS | 16286 | |8;json-parse-financial;56;56;56;60;56;63;56;63;56;54 17:02:49 INFO - PROCESS | 16286 | |9;json-stringify-tinderbox;65;65;66;65;66;67;66;66;65;66 17:02:49 INFO - PROCESS | 16286 | |10;stanford-crypto-aes;78;78;79;79;79;79;85;78;80;85 17:02:49 INFO - PROCESS | 16286 | |11;stanford-crypto-ccm;115;112;114;117;124;132;114;126;126;113 17:02:49 INFO - PROCESS | 16286 | |12;stanford-crypto-pbkdf2;149;144;150;150;144;134;145;146;144;145 17:02:49 INFO - PROCESS | 16286 | |13;stanford-crypto-sha256-iterative;70;65;66;68;68;68;66;68;65;66 17:02:49 INFO - PROCESS | 16286 | __end_tp_report 17:02:49 INFO - PROCESS | 16286 | __start_cc_report 17:02:49 INFO - PROCESS | 16286 | _x_x_mozilla_cycle_collect,824 17:02:49 INFO - PROCESS | 16286 | __end_cc_report 17:02:49 INFO - PROCESS | 16286 | __startTimestamp1461283369269__endTimestamp 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | ------- Summary: start ------- 17:02:49 INFO - PROCESS | 16286 | Number of tests: 14 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#0] ai-astar Cycles:10 Average:111.40 Median:110.50 stddev:3.95 (3.6%) stddev-sans-first:4.15 17:02:49 INFO - PROCESS | 16286 | Values: 113.0 108.0 111.0 110.0 109.0 122.0 111.0 110.0 110.0 110.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:159.50 stddev:16.38 (10.3%) stddev-sans-first:17.12 17:02:49 INFO - PROCESS | 16286 | Values: 157.0 132.0 150.0 168.0 128.0 162.0 163.0 136.0 167.0 129.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.55 (0.9%) stddev-sans-first:1.50 17:02:49 INFO - PROCESS | 16286 | Values: 162.0 163.0 163.0 162.0 167.0 165.0 163.0 165.0 164.0 164.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:42.16 (55.5%) stddev-sans-first:44.27 17:02:49 INFO - PROCESS | 16286 | Values: 79.0 75.0 77.0 162.0 76.0 77.0 74.0 75.0 188.0 76.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.50 stddev:26.04 (27.8%) stddev-sans-first:27.00 17:02:49 INFO - PROCESS | 16286 | Values: 94.0 94.0 153.0 94.0 93.0 94.0 149.0 93.0 93.0 139.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:02:49 INFO - PROCESS | 16286 | Values: 117.0 118.0 117.0 118.0 119.0 117.0 117.0 117.0 117.0 117.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 17:02:49 INFO - PROCESS | 16286 | Values: 148.0 147.0 147.0 147.0 148.0 149.0 147.0 147.0 147.0 148.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 17:02:49 INFO - PROCESS | 16286 | Values: 95.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 97.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:3.20 (5.7%) stddev-sans-first:3.35 17:02:49 INFO - PROCESS | 16286 | Values: 56.0 56.0 56.0 60.0 56.0 63.0 56.0 63.0 56.0 54.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 17:02:49 INFO - PROCESS | 16286 | Values: 65.0 65.0 66.0 65.0 66.0 67.0 66.0 66.0 65.0 66.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:2.71 (3.4%) stddev-sans-first:2.77 17:02:49 INFO - PROCESS | 16286 | Values: 78.0 78.0 79.0 79.0 79.0 79.0 85.0 78.0 80.0 85.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:120.50 stddev:7.04 (5.8%) stddev-sans-first:7.29 17:02:49 INFO - PROCESS | 16286 | Values: 115.0 112.0 114.0 117.0 124.0 132.0 114.0 126.0 126.0 113.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:145.50 stddev:4.61 (3.2%) stddev-sans-first:4.66 17:02:49 INFO - PROCESS | 16286 | Values: 149.0 144.0 150.0 150.0 144.0 134.0 145.0 146.0 144.0 145.0 17:02:49 INFO - PROCESS | 16286 | 17:02:49 INFO - PROCESS | 16286 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:68.00 stddev:1.63 (2.4%) stddev-sans-first:1.32 17:02:49 INFO - PROCESS | 16286 | Values: 70.0 65.0 66.0 68.0 68.0 68.0 66.0 68.0 65.0 66.0 17:02:49 INFO - PROCESS | 16286 | -------- Summary: end -------- 17:02:49 INFO - PROCESS | 16286 | 17:02:50 INFO - TEST-INFO | 16286: exit 0 17:02:50 INFO - TEST-OK | kraken | took 60108ms 17:02:50 INFO - SUITE-END | took 1169s 17:02:50 INFO - Completed test suite (00:19:29) 17:02:50 INFO - javascript benchmark 17:02:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3273.23079076417, 3331.3503866745996, 3331.7334613230937, 3357.278185190185, 3363.0583436637735, 5445.972770136149, 5479.287692599962, 5485.341758988917, 5505.064139096353, 5511.751971161302, 5481.040817856869, 5512.448755124486, 5529.419410961851, 5533.253010843535, 5544.77820887164, 4983.875403114933, 5045.495450454961, 5046.44489106198, 5094.566961808251, 5105.591552675777, 4893.29047288143, 4973.403191616993, 5084.491550844923, 5146.459621739719, 5172.8706782330555, 5012.423571289312, 5038.470960549144, 5042.546170844624, 5051.444341122492, 5100.234964755279, 5103.821366252182, 5127.384713834326, 5188.247704082887, 5190.506901844319, 5191.636585439021, 5040.949590504085, 5092.388913330424, 5106.846794596168, 5131.358580177478, 5166.276721259027, 5316.574674026068, 5329.25390445338, 5357.249985002103, 5394.298741163623, 5416.187571864212, 5969.403059693996, 5977.312609049972, 5994.460498555108, 6004.159417681528, 6020.247469066367, 5875.059990401558, 6035.486983606399, 6040.637561746309, 6044.8186554403, 6066.120412540201, 5570.2480165177585, 5606.327240731098, 5615.157726341041, 5618.6628802272, 5619.019138755997, 6092.055731361646, 6103.755849766048, 6106.969465152646, 6107.297660769068, 6112.449879510777, 5680.693440508706, 5855.209546711139, 5860.472557469848, 5866.765329386777, 5878.823635290948, 6008.8798224036145, 6040.848978775566, 6041.6375017499095, 6046.758129674852, 6077.118817771487, 5930.28836539618, 5954.76180952757, 5957.791477298274, 5973.611715238496, 5982.0727787193055, 5764.452377024176, 5921.644701317935, 5947.732352044169, 5979.820605381846, 5992.730327135289, 4466.307722303049, 4492.0, 4510.0979804039325, 4515.480719717209, 4525.117602067631, 4038.5355684096116, 4063.1264278180333, 4068.7151899367354, 4073.124278280184, 4085.4688890444054, 5524.14375771748, 5653.434656534396, 5731.742071606787, 5780.971095144581, 5785.074388097884, 5730.426957304237, 5964.642121472725, 5968.46283834457, 6038.879222415615, 6104.298005729398, 5621.7751289948765, 5623.493885550321, 5644.915326270109, 5649.322081350264, 5649.830505084854, 4882.170031094723, 4988.6757360771435, 5002.199648056294, 5009.849704508871, 5018.096742586296, 6183.598066125687, 6184.752609895644, 6187.412195841388, 6207.068939659087, 6222.968885155546, 5965.821025369246, 6019.187409699634, 6025.849353766191, 6029.57792954489, 6049.153118563317, 5907.2911250650195, 6136.723847426966, 6147.231596050494, 6190.133381326708, 6194.287656919512, 5888.411158884077, 5924.763009479572, 5928.733207005781, 5930.199423077829, 5935.317438494456, 6007.429294217042, 6028.125921741411, 6030.216071910623, 6031.396860313934, 6036.094585812163, 5589.80435684749, 5747.4252574742195, 5834.766609335579, 5852.678102704393, 5874.882502350015, 5878.735456904364, 5911.763529458945, 5913.408659134052, 5923.200367950444, 5926.1999630049395, 5566.638168519034, 5776.422357764358, 5796.449337312949, 5816.505597024131, 5821.039528477754, 5913.70431478433, 5918.786648736913, 5924.348321684525, 5929.318128415288, 5968.074948383008, 5676.4323567642905, 5707.6575405475805, 5712.228849105318, 5717.8570535736935, 5727.971360143172], "unit": "score", "name": "dojo.html", "value": 5497.583994347062}, {"lowerIsBetter": false, "replicates": [544.51810148019, 544.8365490352893, 563.7378618942192, 571.2973043156915, 578.6904006356598, 36791.0, 37571.24857502848, 37591.99999999996, 37620.24759504808, 37709.24581508368, 39320.60679393205, 39724.40413393801, 40164.196716065664, 40232.79883600585, 40326.0, 8590.484570925764, 8752.387332886701, 8777.64889404423, 8779.165979231962, 8785.121487851227, 8475.067742548315, 8627.180417860292, 8653.653853845839, 8907.421017633866, 8950.14973577509, 8943.731688049369, 9031.683891063814, 9037.141471560224, 9043.231325337354, 9067.410618309821, 8872.689455869046, 8883.200511953923, 8931.910680893174, 8981.506017169053, 8990.910090899073, 8826.117388261187, 8975.685850995184, 8978.326625503048, 8986.281097512183, 9009.189172974464, 39095.8045209775, 39331.60668393308, 39689.20621587581, 39707.40438893419, 39731.0, 3657.244522629126, 3770.547534295902, 3814.313423583754, 3832.50177476929, 4007.959920400817, 32679.183020424443, 32742.34515309704, 32895.342093158244, 33347.33305333904, 33515.49726754076, 4261.488621365456, 4266.509351424595, 4306.5478124796755, 4345.456817897762, 4353.825846966118, 291632.0, 295198.0, 297050.0, 297129.0, 298444.0, 60856.391436085076, 62353.06470402948, 62401.37598624046, 62493.68753156205, 62611.0, 74079.62960185164, 75566.24433755592, 75569.24430755622, 75621.0, 75753.62123189348, 17640.294388224585, 17865.910670446563, 17982.5504362392, 18009.63980720378, 18516.444506664822, 13785.655358616115, 13891.722165556632, 13923.930380348034, 13935.372908219155, 13972.441102355995, 22280.220192293193, 22620.773792262196, 22689.432764180696, 22867.0, 22908.885455572614, 7737.3036426721865, 8210.178982101743, 8224.712135075364, 8293.709720159766, 8317.750467485985, 971.795922856194, 980.3039841712322, 1074.049466222399, 1117.4971262931713, 1141.9779297528664, 29850.776114180368, 30002.047001142993, 30302.69697303043, 30382.84808575943, 30449.695503045128, 1084.5228099636136, 1103.486878601438, 1106.6934051224398, 1114.9331040137617, 1165.0504838556549, 15674.294656740474, 15739.213039347987, 15755.527334179993, 15821.68356632861, 15946.325635808305, 358555.0, 432369.0, 479666.0, 482985.0, 496138.0, 57615.711921440125, 57890.4210957885, 58363.12455313174, 58395.416045838996, 58526.41473585295, 1434.8206474190727, 1449.7390469715342, 1457.5627311806415, 1461.9049761765452, 1466.2375564706292, 30253.243668908453, 31463.685363146076, 31863.0, 32132.83933580317, 32145.357092857543, 47867.28199077086, 48226.758866206845, 48320.75839620779, 48620.27069593888, 48676.0, 242726.0, 242922.0, 243048.0, 245960.0, 246009.0, 41982.0, 42631.57368426276, 46749.29876051794, 47342.52657473381, 47819.5218047829, 43660.56339436565, 43966.780166098964, 44454.77772611116, 44959.55040449554, 45331.773341133085, 37453.0, 39599.80200098981, 40943.590564093975, 41460.58539414567, 41826.1634767309, 39304.60695393124, 39765.20469590534, 40355.79822100871, 40622.0, 41292.587074128875, 40067.1986560273, 40192.59807401888, 40651.59348406478, 41043.0, 41260.58739412567, 34848.30303393969, 34859.4771078429, 35530.28939421249, 35547.82226088853, 35748.39132239108, 27162.32094197661, 27756.58365124565, 27933.0, 27971.300717482227, 28102.85948570244], "unit": "score", "name": "ext.html", "value": 19978.766744832144}, {"lowerIsBetter": false, "replicates": [334.9631540530541, 388.57062945445284, 396.8531643291981, 397.05698964958225, 399.1637519396866, 17905.82094179058, 18756.43730688078, 19202.751821131653, 19641.607167856633, 19665.803341966577, 12871.54949576765, 13159.60521184366, 13187.472501099968, 13264.602061938158, 13265.668358291048, 5193.974030129853, 5422.457754224585, 5737.770489180428, 5758.0, 5760.222369980062, 5667.064934285838, 5767.682777447239, 5770.163326317682, 5773.0, 5779.566532510057, 5542.473465020817, 5755.597108202427, 5757.193992841006, 5768.826935191951, 5779.711014449282, 5677.659340439566, 5740.225069615611, 5747.08046712524, 5748.655080695151, 5755.856103597402, 5138.794448222066, 5210.218467229908, 5211.24436956643, 5216.26972223889, 5230.8692282692855, 14500.92749536256, 14501.70996580073, 14678.412863485448, 17062.48812535626, 21880.781192188035, 2181.7054697615936, 2403.975960240393, 2430.6111022236532, 2489.3652118709615, 2662.828355523583, 10721.463926803706, 11234.550617975272, 13749.518766843112, 14157.85842141586, 14286.928565357211, 1922.9615407691908, 1923.5479662279354, 1931.8357939575153, 1956.4521933858543, 1975.2099160335838, 61089.0, 66285.0, 67233.3276667232, 67429.32570674279, 68877.0, 10220.284580079471, 10335.896641033494, 10395.792084158275, 10616.150707943347, 10821.56713731442, 15049.623759406102, 15275.694486110215, 15302.0, 15332.15673137988, 15412.46056388021, 8167.509949403055, 8233.8353232935, 8319.750407487785, 8322.45904016237, 8415.242628163373, 7866.252705992922, 8018.278354948083, 8023.438359314909, 8047.919520804717, 8098.3116435103675, 4654.208784506574, 4658.417697787777, 4687.0, 4736.73947932867, 4805.9038819224115, 1872.7284543741355, 1949.9902500487406, 1972.8717633353785, 1974.2497850816599, 2002.589469158819, 953.1469334945185, 1034.6533911139702, 1045.7803861189236, 1069.5133714160195, 1113.0316624536704, 17178.282171782972, 17719.55701107457, 17742.91128544349, 18072.548186295186, 18372.724409133873, 855.7646647171953, 968.9757756056155, 996.1731762636994, 1033.540074666766, 1093.9989909233122, 9585.424874507551, 9756.90243097574, 9944.651937182163, 10333.966603339757, 10459.68620941373, 482700.0, 490046.0, 499993.0, 504214.0, 507593.0, 54113.72943135259, 73525.0, 75134.24865751382, 77052.22947770562, 78311.0, 1011.3375738890891, 1061.4692653673164, 1062.7396287909512, 1069.5721711315537, 1097.2812807611188, 15682.843171568138, 15760.211989400714, 16019.8398016023, 16652.167391630126, 16717.0, 36067.27865442624, 36131.63868361283, 36327.27345453129, 36497.33488527806, 37200.81399592985, 50198.74900625474, 52567.0, 52755.20867187072, 53661.463385367206, 53745.73127134339, 8284.544350060805, 8487.745367638981, 8697.0, 8840.557972101498, 9004.729858104267, 12287.201331913755, 12881.0, 13243.536476223286, 13280.867191327963, 13343.132696374705, 10445.425501597485, 11227.38249396291, 11292.830607540729, 11595.0, 11674.416279186176, 11757.470913808727, 11882.524699011943, 12000.459979301128, 12197.573084941985, 12365.07261955339, 11299.2655477397, 11599.188056835941, 11746.647600571996, 12165.574204902787, 12613.81079283793, 8595.269402100892, 8813.60338784769, 8964.955175224342, 8996.820063598561, 9247.982721900451, 11407.315561066363, 11940.223885447418, 12069.879301207227, 12136.150469467053, 12193.0], "unit": "score", "name": "jquery.html", "value": 8886.548160227398}, {"lowerIsBetter": false, "replicates": [1535.2672243406735, 1566.4752307976828, 1784.3487127198568, 1869.7195420686903, 1891.1111777464596, 7370.078740157481, 8047.637856296481, 8089.23152300532, 8273.710420135296, 8289.461185022978, 7949.085855126662, 8003.319717823992, 8138.91861081389, 8141.837163256731, 8231.300339471152, 2442.8656423896678, 2457.447074408253, 2478.996006617323, 2483.31708780086, 2486.7513248675077, 2362.6456031595226, 2412.5657381671294, 2413.0347860855622, 2417.62526808345, 2419.5523828091773, 2344.894479748407, 2358.811295096397, 2361.681173041643, 2378.3340664613847, 2409.5421869844763, 2351.0713268259115, 2358.3868194269444, 2366.0, 2386.284114765572, 2424.9151279705125, 2401.2676133779364, 2445.3764290106087, 2461.7045954485575, 2462.815288853343, 2467.4078221226955, 8332.750017499484, 8340.62467188978, 8364.079951205362, 8383.035950865667, 8393.0, 5044.697318160922, 5107.846764597068, 5166.405863325691, 5166.767495462713, 5196.68819870809, 3124.0940127363037, 3140.0736782649174, 3151.8108913465267, 3160.1625569224175, 3196.7122958933573, 1011.4993078426153, 1041.6458404142552, 1056.5773690523774, 1074.1889873145724, 1101.9173561982884, 11410.315381077162, 11424.828627570592, 11451.541938322458, 11472.196946213768, 11496.252743571558, 4317.179735850178, 4360.869173924724, 4432.867013989586, 4564.064366804797, 4583.564561366665, 9072.727818165333, 9093.090690930854, 9136.177744002938, 9138.223251023604, 9162.0, 4934.654574179773, 4988.9750551247735, 5020.3724534433195, 5029.547340739351, 5031.899362012739, 4052.230076285496, 4521.61566266871, 4608.746518941491, 4614.284785858197, 4642.46611639659, 3664.0, 3716.442533619979, 3750.6999440044733, 3757.9060523486582, 3783.886483405502, 1104.2380757277454, 1128.819388897789, 1132.9660110196708, 1137.5506674863382, 1142.177632104883, 928.8420968435247, 941.6045260990401, 949.1979277510493, 1063.3991794636006, 1422.0472283570032, 7570.091589009354, 7624.19945905683, 7633.2366763324335, 7656.502327348704, 7677.886706427536, 540.3818499370543, 547.7015026810398, 549.0720682047407, 550.435803301611, 559.2478116932718, 5820.0, 5824.708764561755, 5869.618474799125, 5922.940770592325, 6069.271687397452, 9740.561674724655, 10032.899671003343, 10100.343477673927, 10149.188064954786, 10159.796804063877, 9462.479563623929, 9668.936416994125, 9712.660056897974, 9809.754756131153, 9979.650712225037, 7624.961875190699, 7648.426368022309, 7656.578888161093, 7680.3087722104165, 7696.4227682924, 7371.447141464304, 7380.889286660812, 7445.367143792838, 7462.141853686896, 7519.473636845369, 8677.956610216908, 8841.911580884365, 8848.380613357003, 8928.553572321487, 9002.369834111549, 9060.682876099305, 9157.31320150978, 9171.816563668823, 9233.399829011092, 9485.57314920844, 6627.768028118992, 6759.121314229119, 6891.069705589882, 7039.507234493741, 7139.071920650283, 7762.844743105219, 7773.378129749493, 7811.453198276294, 7828.373730101692, 7880.763577092696, 7026.718931242693, 7175.8564828704175, 7211.134663840373, 7302.56184628924, 7309.342159205697, 6979.1973922999505, 7003.4747393944635, 7073.257307982588, 7091.219965803861, 7105.32499412555, 7007.264237255014, 7149.285071492809, 7157.892631610426, 7209.567425954459, 7210.1708303545765, 6572.671366431755, 6582.670866456754, 6645.800625981228, 6646.567973081735, 6663.0, 6490.188726409199, 6639.170103737033, 6641.169853768279, 6676.566023208476, 6719.899201511884], "unit": "score", "name": "mootools.html", "value": 4575.200292543668}, {"lowerIsBetter": false, "replicates": [363.4366731566072, 366.254671743003, 369.6192921291071, 370.21329674441813, 375.9605241449648, 6319.431251187392, 6420.3579642035775, 6432.871342573151, 6464.482841372691, 6468.385503377183, 6354.396332348431, 6410.743570257196, 6449.935500644992, 6453.870922581557, 6468.126802881609, 4697.412823397075, 4759.262314341266, 4793.520647935214, 4797.40032495938, 4943.431505376874, 4764.475907650156, 4786.353842231289, 4788.138135135674, 4788.521147885201, 4793.0, 4716.787744551486, 4740.099381117594, 4748.240281554952, 4800.087983283182, 4801.5438533339275, 4795.928061079069, 4801.2798080287885, 4813.855584332476, 4816.494268101869, 4824.6863953842885, 4160.604742549453, 4172.520160181588, 4172.687048471377, 4174.728642638219, 4180.707350485437, 6034.547408944347, 6059.7273122709585, 6069.02895536712, 6072.301685306202, 6072.605280656788, 5560.138178582326, 5569.136783798518, 5571.777128914839, 5582.218489411485, 5583.85530966151, 6613.371729685672, 6683.3650803174105, 6705.664716764191, 6714.227863795677, 6717.496187785936, 4567.177907976563, 4587.266037434028, 4590.701604395704, 4592.494825569184, 4595.862124136282, 6990.196127445307, 7026.824329391755, 7055.823604409879, 7056.435485161175, 7060.329268719514, 4609.354690343354, 4663.930041049387, 4700.318453824177, 4702.130105930414, 4702.553257440538, 4754.144254034238, 4785.449673287547, 4790.449098353664, 4794.161021821167, 4798.880027999328, 5561.110222364402, 5567.081431563746, 5567.109262517978, 5597.468240517226, 5600.803971860965, 6747.561408508432, 6771.62756048422, 6786.0, 6788.151481064867, 6800.52396332252, 1651.149657926145, 1651.4137481194243, 1653.5535405440464, 1654.0654530190404, 1654.561541191585, 1065.4512925843196, 1107.5016242690822, 1147.0479502013309, 1149.4654985431814, 1153.8153895376868, 6541.6075035498025, 6555.639439830855, 6564.277929427759, 6574.211094668671, 6579.30917253691, 6968.407685346802, 6994.965025174842, 7040.401565866959, 7056.470764692566, 7061.187963384276, 6289.433950944437, 6414.166158399472, 6536.411722944958, 6638.701258443381, 6664.400203981665, 3843.9615603844163, 3875.2443273561385, 3875.748076375083, 3876.282887665791, 3880.0687834919418, 7290.744823931137, 7317.634118294064, 7355.668994895243, 7360.926390736131, 7389.1502477214735, 7261.273872612696, 7288.3076107769675, 7292.927070729331, 7295.927040729631, 7296.087989001375, 7069.0, 7361.190269070398, 7387.0, 7397.408207343399, 7399.556026638311, 7079.079719636415, 7103.112110986127, 7142.5714457132735, 7144.607046612487, 7148.392386647193, 6900.309969003059, 6909.827254318682, 6954.617496037564, 6958.130233720785, 6998.930010699828, 7271.200167981412, 7360.411167106511, 7361.889571656322, 7386.630668466448, 7395.445341599294, 4598.793054312631, 4661.953380466288, 4703.200455922433, 4717.245240761462, 4795.064962332312, 6982.231954484901, 6982.720691172296, 7042.330978557029, 7066.293370662893, 7077.150741911004, 6771.695273712597, 6785.626790526569, 6786.287439818748, 6796.660166991532, 6806.77478053955, 6813.0461735358085, 6825.692843822139, 6853.4859885507785, 6861.005154252505, 6866.4506839453725, 6551.574147680385, 6720.428763554957, 6749.730010799513, 6798.592084474947, 6803.319668033157, 6852.8286792828585, 6884.862302753817, 6889.035535025, 6931.133608298963, 6940.895886561605, 6631.701573429304, 6690.19717633887, 6693.0, 6699.0, 6720.899186512304], "unit": "score", "name": "prototype.html", "value": 5102.803903550679}, {"lowerIsBetter": false, "replicates": [769.657502411427, 822.1572887790019, 824.1867099893018, 844.2781421884287, 899.1907283444903, 13808.240546769923, 14115.858841411582, 14132.50536231232, 14134.858651413482, 14151.787723184161, 12527.436265368058, 12601.180923239983, 12622.24266544008, 12653.430595623196, 12703.237805731662, 900.2392977933652, 906.0939060939061, 911.0707078779641, 938.9483578403185, 944.1549812917435, 952.3238500664537, 955.2978560757838, 955.4315182466421, 956.4930586789013, 959.395580784105, 988.2686811759282, 988.7280997725647, 988.8318985772436, 991.7223177510273, 991.7520619845038, 983.0, 983.2429029647203, 983.8376667849797, 983.9311248212628, 986.0681655835202, 724.9420046396276, 726.6076318787848, 727.3599232675265, 727.4253339861503, 729.3035151430371, 13675.794863077062, 13680.042397032212, 13703.0, 13718.108322958975, 13814.861851381458, 13144.40850161745, 13207.207567545978, 13249.337533123306, 13254.933725331408, 13425.731485370237, 10181.796364072678, 10397.376157430579, 10440.164786817113, 10612.416317102556, 10851.945740271249, 3773.13217959868, 3777.376732839078, 3790.0903783092135, 3814.866479673226, 3854.8265328060306, 55444.445555544735, 55448.168277476274, 56111.0, 56112.43887561113, 56237.0, 10260.384376937407, 10589.205809564313, 10719.088877445349, 10759.462026898624, 10795.460226988776, 19047.714284285747, 19126.426207213804, 19154.138063787163, 19294.22823087061, 19296.517587060436, 7289.307515785992, 7368.6919680862575, 7409.407247420193, 7460.0, 7514.211007844207, 4272.658187345005, 4427.535108813592, 4510.594046535827, 4551.840685575989, 4552.408186935743, 3184.5860038194887, 3187.0916788715103, 3193.2336239302863, 3194.105650417887, 3200.135963289899, 574.9453801888814, 583.1427801132329, 590.3122861865963, 591.0, 595.1964847455986, 624.9562530622812, 665.9444780023716, 684.2404930527111, 708.4686485136148, 753.3897542990195, 8246.340292776684, 8444.57777111142, 8526.317894568543, 8573.957130214309, 8632.482051076955, 725.6952080126359, 732.2640746050185, 734.6693987705447, 735.5366119344885, 757.9166291707908, 3669.889903302905, 4071.328230841937, 4113.441872780024, 4138.896527586834, 4254.638355739735, 56921.43078569244, 57621.711891440274, 57689.423105769245, 58113.0, 59340.10989835156, 54592.45407545953, 55008.449915500336, 55887.720561396934, 56058.159127613115, 56350.43649563534, 49035.0, 49113.0, 49184.26223606649, 49652.25521617251, 49793.75103124461, 7687.423443241891, 7803.414743894117, 7878.566678832719, 7997.480163789335, 8147.511149331059, 40224.396634051096, 40895.795521022206, 41092.383614246406, 41121.58878411177, 41481.58518414898, 48347.51652483571, 48557.5144248553, 48559.75720121377, 48562.0, 50681.49318506768, 11654.533818647498, 11745.706357340792, 11911.166218364631, 12043.879561204276, 12181.69545761363, 12293.139480236297, 12779.36103194855, 13050.282234477196, 13326.200427974352, 13335.933320333725, 10995.450227488753, 11453.656390308304, 11783.351915644722, 12168.026557875171, 12474.376281186085, 12029.879701202875, 12133.0, 12394.938025309815, 12428.62714118578, 12433.751324973631, 10892.673219803419, 12019.63941081769, 12102.213356131822, 12375.257484550955, 12423.254604723745, 10190.643327483502, 10312.48437578133, 10487.056164944886, 10659.0, 11091.112710982941, 9967.651132210338, 10092.293539452461, 10123.203798575534, 10197.949010255197, 10363.119134873621], "unit": "score", "name": "yui.html", "value": 6715.448486294863}], "name": "dromaeo_css", "value": 7313.651782170195}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 111.0, 110.0, 109.0, 122.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [157.0, 132.0, 150.0, 168.0, 128.0, 162.0, 163.0, 136.0, 167.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 162.0, 167.0, 165.0, 163.0, 165.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 77.0, 162.0, 76.0, 77.0, 74.0, 75.0, 188.0, 76.0], "unit": "score", "name": "audio-fft", "value": 95.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 153.0, 94.0, 93.0, 94.0, 149.0, 93.0, 93.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 60.0, 56.0, 63.0, 56.0, 63.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.7}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 79.0, 79.0, 79.0, 79.0, 85.0, 78.0, 80.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [115.0, 112.0, 114.0, 117.0, 124.0, 132.0, 114.0, 126.0, 126.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [149.0, 144.0, 150.0, 150.0, 144.0, 134.0, 145.0, 146.0, 144.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [70.0, 65.0, 66.0, 68.0, 68.0, 68.0, 66.0, 68.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1525.7}]} 17:02:50 INFO - Return code: 0 17:02:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:02:50 ERROR - # TBPL SUCCESS # 17:02:50 INFO - Running post-action listener: _resource_record_post_action 17:02:50 INFO - Running post-run listener: _resource_record_post_run 17:02:51 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 487407616; Read time: 0; Write time: 521064 17:02:51 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 182083584; Read time: 0; Write time: 266156 17:02:51 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 254803968; Read time: 0; Write time: 138728 17:02:51 INFO - Running post-run listener: _upload_blobber_files 17:02:51 INFO - Blob upload gear active. 17:02:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:02:51 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 17:02:51 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'] 17:02:51 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 17:02:52 INFO - (blobuploader) - INFO - Open directory for files ... 17:02:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:02:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:53 INFO - (blobuploader) - INFO - Done attempting. 17:02:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:02:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:02:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:53 INFO - (blobuploader) - INFO - Done attempting. 17:02:53 INFO - (blobuploader) - INFO - Iteration through files over. 17:02:53 INFO - Return code: 0 17:02:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:02:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:02:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f9dd460d6272bc138b68eb3828becfaea53d4f03f3eb411b7bd8c807f3bb73e1487e7c66cb035423caa4cac2b96b7a075cae728317a44b11e7997d4452edbeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaa2628c70ec58e4bd3d549ae53518a26b5b49748454307a01a7cf3b5196eccd274c763607e6c7122b13b25035c736dc49a8103622911f0e006893b016f762"} 17:02:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:02:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:02:53 INFO - Contents: 17:02:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f9dd460d6272bc138b68eb3828becfaea53d4f03f3eb411b7bd8c807f3bb73e1487e7c66cb035423caa4cac2b96b7a075cae728317a44b11e7997d4452edbeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaa2628c70ec58e4bd3d549ae53518a26b5b49748454307a01a7cf3b5196eccd274c763607e6c7122b13b25035c736dc49a8103622911f0e006893b016f762"} 17:02:53 INFO - Running post-run listener: copy_logs_to_upload_dir 17:02:53 INFO - Copying logs to upload dir... 17:02:53 INFO - mkdir: /builds/slave/test/build/upload/logs 17:02:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.254644 ========= master_lag: 77.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-04-21 17:04:11.109320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 17:04:11.111507) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861 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/9f9dd460d6272bc138b68eb3828becfaea53d4f03f3eb411b7bd8c807f3bb73e1487e7c66cb035423caa4cac2b96b7a075cae728317a44b11e7997d4452edbeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaa2628c70ec58e4bd3d549ae53518a26b5b49748454307a01a7cf3b5196eccd274c763607e6c7122b13b25035c736dc49a8103622911f0e006893b016f762"} build_url:https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/Da0a0aWkTOSkEk9gREWsfg/artifacts/public/build/firefox-47.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/9f9dd460d6272bc138b68eb3828becfaea53d4f03f3eb411b7bd8c807f3bb73e1487e7c66cb035423caa4cac2b96b7a075cae728317a44b11e7997d4452edbeb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eebaa2628c70ec58e4bd3d549ae53518a26b5b49748454307a01a7cf3b5196eccd274c763607e6c7122b13b25035c736dc49a8103622911f0e006893b016f762"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 17:04:11.571628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 17:04:11.571929) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461281927.719957-1284598861 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 17:04:11.695032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 17:04:11.695380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 17:04:12.623644) ========= ========= Total master_lag: 78.37 =========