builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1461190633.33 results: success (0) buildid: 20160420124052 builduid: 273b70f21fd344da850619ad6714fc0e revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.327810) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.328373) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.328657) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.345988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.346422) ========= 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=0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 15:17:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 214M=0s 2016-04-20 15:17:13 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124426 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.484297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.484657) ========= 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=0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018746 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.535527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:13.535849) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --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 2387e00d2ce89a2cd641df7ca92af4feeeebe556 --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=0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 15:17:13,970 truncating revision to first 12 chars 2016-04-20 15:17:13,970 Setting DEBUG logging. 2016-04-20 15:17:13,970 attempt 1/10 2016-04-20 15:17:13,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2387e00d2ce8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 15:17:14,233 unpacking tar archive at: mozilla-aurora-2387e00d2ce8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548971 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.097970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.098305) ========= script_repo_revision: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.098736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.099010) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 15:17:14.107971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-20 15:17:14.108305) ========= /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=0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:17:14 INFO - MultiFileLogger online at 20160420 15:17:14 in /builds/slave/test 15:17:14 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 15:17:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:14 INFO - {'append_to_log': False, 15:17:14 INFO - 'base_work_dir': '/builds/slave/test', 15:17:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:17:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:14 INFO - 'branch': 'Mozilla-Aurora', 15:17:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:14 INFO - 'config_files': ('talos/linux_config.py',), 15:17:14 INFO - 'default_actions': ('clobber', 15:17:14 INFO - 'read-buildbot-config', 15:17:14 INFO - 'download-and-extract', 15:17:14 INFO - 'populate-webroot', 15:17:14 INFO - 'create-virtualenv', 15:17:14 INFO - 'install', 15:17:14 INFO - 'run-tests'), 15:17:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:14 INFO - 'download_minidump_stackwalk': True, 15:17:14 INFO - 'download_symbols': 'ondemand', 15:17:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:14 INFO - 'installer_path': 'installer.exe', 15:17:14 INFO - 'log_level': 'info', 15:17:14 INFO - 'log_name': 'talos', 15:17:14 INFO - 'log_to_console': True, 15:17:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:17:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:17:14 INFO - 'opt_config_files': (), 15:17:14 INFO - 'pip_index': False, 15:17:14 INFO - 'sps_profile': False, 15:17:14 INFO - 'sps_profile_interval': 0, 15:17:14 INFO - 'suite': 'dromaeojs-e10s', 15:17:14 INFO - 'system_bits': '32', 15:17:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:14 INFO - 'title': 'talos-linux64-ix-017', 15:17:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:14 INFO - 'use_talos_json': True, 15:17:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:14 INFO - 'work_dir': 'build'} 15:17:14 INFO - ##### 15:17:14 INFO - ##### Running clobber step. 15:17:14 INFO - ##### 15:17:14 INFO - Running pre-action listener: _resource_record_pre_action 15:17:14 INFO - Running main action method: clobber 15:17:14 INFO - rmtree: /builds/slave/test/build 15:17:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:15 INFO - Running post-action listener: _resource_record_post_action 15:17:15 INFO - ##### 15:17:15 INFO - ##### Running read-buildbot-config step. 15:17:15 INFO - ##### 15:17:15 INFO - Running pre-action listener: _resource_record_pre_action 15:17:15 INFO - Running main action method: read_buildbot_config 15:17:15 INFO - Using buildbot properties: 15:17:15 INFO - { 15:17:15 INFO - "project": "", 15:17:15 INFO - "product": "firefox", 15:17:15 INFO - "script_repo_revision": "production", 15:17:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:17:15 INFO - "repository": "", 15:17:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:17:15 INFO - "buildid": "20160420124052", 15:17:15 INFO - "pgo_build": "True", 15:17:15 INFO - "basedir": "/builds/slave/test", 15:17:15 INFO - "buildnumber": 222, 15:17:15 INFO - "slavename": "talos-linux64-ix-017", 15:17:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:17:15 INFO - "platform": "ubuntu64_hw", 15:17:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:17:15 INFO - "branch": "mozilla-aurora", 15:17:15 INFO - "repo_path": "releases/mozilla-aurora", 15:17:15 INFO - "revision": "2387e00d2ce89a2cd641df7ca92af4feeeebe556", 15:17:15 INFO - "stage_platform": "linux64-pgo", 15:17:15 INFO - "builduid": "273b70f21fd344da850619ad6714fc0e", 15:17:15 INFO - "slavebuilddir": "test" 15:17:15 INFO - } 15:17:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 15:17:15 INFO - Running post-action listener: _resource_record_post_action 15:17:15 INFO - ##### 15:17:15 INFO - ##### Running download-and-extract step. 15:17:15 INFO - ##### 15:17:15 INFO - Running pre-action listener: _resource_record_pre_action 15:17:15 INFO - Running main action method: download_and_extract 15:17:15 INFO - mkdir: /builds/slave/test/build/tests 15:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:15 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:17:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:17:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:17:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:19 INFO - Downloaded 1448 bytes. 15:17:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:17:19 INFO - Using the following test package requirements: 15:17:19 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:19 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:17:19 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:17:19 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'jsshell-linux-x86_64.zip'], 15:17:19 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:17:19 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:19 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:17:19 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:17:19 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:17:19 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:17:19 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:17:19 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:17:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:17: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')]} 15:17:19 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:31 INFO - Downloaded 23353627 bytes. 15:17:31 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'] 15:17:31 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 15:17:32 INFO - Return code: 0 15:17:32 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 15:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:32 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:17:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:17:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:33 INFO - Downloaded 23353627 bytes. 15:17: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'] 15:17: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 15:17:35 INFO - Return code: 0 15:17: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')]} 15:17:35 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:17:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:17:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:17:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:36 INFO - Downloaded 10845198 bytes. 15:17:36 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'] 15:17:36 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 15:17:36 INFO - Return code: 0 15:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:36 INFO - https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:17:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A84jzeqiSAmDJLoDUrfqHA/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 15:17:38 INFO - Downloaded 60606797 bytes. 15:17:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:38 INFO - mkdir: /builds/slave/test/properties 15:17:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:38 INFO - Contents: 15:17:38 INFO - build_url:https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:17:39 INFO - Running post-action listener: _resource_record_post_action 15:17:39 INFO - Running post-action listener: set_extra_try_arguments 15:17:39 INFO - ##### 15:17:39 INFO - ##### Running populate-webroot step. 15:17:39 INFO - ##### 15:17:39 INFO - Running pre-action listener: _resource_record_pre_action 15:17:39 INFO - Running main action method: populate_webroot 15:17:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:39 INFO - '--tppagecycles', 15:17:39 INFO - '7'], 15:17:39 INFO - 'tests': ['tsvgm']}}, 15:17:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:17:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:17:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'tests': ['damp', 'tps']}, 15:17:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['damp', 'tps']}, 15:17:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:17:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:39 INFO - 'other': {'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other_l64': {'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'other_nol64': {'tests': ['a11yr', 15:17:39 INFO - 'ts_paint', 15:17:39 INFO - 'tpaint', 15:17:39 INFO - 'sessionrestore', 15:17:39 INFO - 'sessionrestore_no_auto_restore', 15:17:39 INFO - 'tabpaint']}, 15:17:39 INFO - 'svgr': {'tests': ['tsvgx', 15:17:39 INFO - 'tsvgr_opacity', 15:17:39 INFO - 'tart', 15:17:39 INFO - 'tscrollx', 15:17:39 INFO - 'cart']}, 15:17:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['tsvgx', 15:17:39 INFO - 'tsvgr_opacity', 15:17:39 INFO - 'tart', 15:17:39 INFO - 'tscrollx', 15:17:39 INFO - 'cart']}, 15:17:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'tests': ['tp5o']}, 15:17:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--e10s'], 15:17:39 INFO - 'tests': ['tp5o']}, 15:17:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--xperf_path', 15:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:39 INFO - 'tests': ['tp5n']}, 15:17:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:39 INFO - 'talos_options': ['--e10s', 15:17:39 INFO - '--xperf_path', 15:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:39 INFO - 'tests': ['tp5n']}}, 15:17:39 INFO - 'talos.zip': {'path': '', 15:17:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:39 INFO - Running post-action listener: _resource_record_post_action 15:17:39 INFO - ##### 15:17:39 INFO - ##### Running create-virtualenv step. 15:17:39 INFO - ##### 15:17:39 INFO - Running pre-action listener: _resource_record_pre_action 15:17:39 INFO - Running main action method: create_virtualenv 15:17:39 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:39 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 15:17:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:40 INFO - Using real prefix '/usr' 15:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:40 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:42 INFO - Installing pip.................done. 15:17:42 INFO - Return code: 0 15:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:42 INFO - Using env: {'DISPLAY': ':0', 15:17:42 INFO - 'HOME': '/home/cltbld', 15:17:42 INFO - 'LANG': 'en_US.UTF-8', 15:17:42 INFO - 'LANGUAGE': 'en_US:en', 15:17:42 INFO - 'LOGNAME': 'cltbld', 15:17:42 INFO - 'MAIL': '/var/mail/cltbld', 15:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:42 INFO - 'MOZ_NO_REMOTE': '1', 15:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:42 INFO - 'NO_EM_RESTART': '1', 15:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:42 INFO - 'PWD': '/builds/slave/test', 15:17:42 INFO - 'SHELL': '/bin/bash', 15:17:42 INFO - 'SHLVL': '1', 15:17:42 INFO - 'TERM': 'linux', 15:17:42 INFO - 'TMOUT': '86400', 15:17:42 INFO - 'USER': 'cltbld', 15:17:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:42 INFO - '_': '/tools/buildbot/bin/python'} 15:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17: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 15:17:42 INFO - Cleaning up... 15:17:42 INFO - Return code: 0 15:17:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:42 INFO - Using env: {'DISPLAY': ':0', 15:17:42 INFO - 'HOME': '/home/cltbld', 15:17:42 INFO - 'LANG': 'en_US.UTF-8', 15:17:42 INFO - 'LANGUAGE': 'en_US:en', 15:17:42 INFO - 'LOGNAME': 'cltbld', 15:17:42 INFO - 'MAIL': '/var/mail/cltbld', 15:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:42 INFO - 'MOZ_NO_REMOTE': '1', 15:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:42 INFO - 'NO_EM_RESTART': '1', 15:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:42 INFO - 'PWD': '/builds/slave/test', 15:17:42 INFO - 'SHELL': '/bin/bash', 15:17:42 INFO - 'SHLVL': '1', 15:17:42 INFO - 'TERM': 'linux', 15:17:42 INFO - 'TMOUT': '86400', 15:17:42 INFO - 'USER': 'cltbld', 15:17:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:42 INFO - '_': '/tools/buildbot/bin/python'} 15:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:42 INFO - Downloading/unpacking psutil>=0.7.1 15:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:44 INFO - Installing collected packages: psutil 15:17:44 INFO - Running setup.py install for psutil 15:17:44 INFO - building 'psutil._psutil_linux' extension 15:17:44 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 15:17: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 15:17:45 INFO - building 'psutil._psutil_posix' extension 15:17: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 15:17: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 15:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:45 INFO - Successfully installed psutil 15:17:45 INFO - Cleaning up... 15:17:45 INFO - Return code: 0 15:17:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:45 INFO - Using env: {'DISPLAY': ':0', 15:17:45 INFO - 'HOME': '/home/cltbld', 15:17:45 INFO - 'LANG': 'en_US.UTF-8', 15:17:45 INFO - 'LANGUAGE': 'en_US:en', 15:17:45 INFO - 'LOGNAME': 'cltbld', 15:17:45 INFO - 'MAIL': '/var/mail/cltbld', 15:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:45 INFO - 'MOZ_NO_REMOTE': '1', 15:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:45 INFO - 'NO_EM_RESTART': '1', 15:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:45 INFO - 'PWD': '/builds/slave/test', 15:17:45 INFO - 'SHELL': '/bin/bash', 15:17:45 INFO - 'SHLVL': '1', 15:17:45 INFO - 'TERM': 'linux', 15:17:45 INFO - 'TMOUT': '86400', 15:17:45 INFO - 'USER': 'cltbld', 15:17:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:45 INFO - '_': '/tools/buildbot/bin/python'} 15:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17: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) 15:17:47 INFO - Installing collected packages: mozsystemmonitor 15:17:47 INFO - Running setup.py install for mozsystemmonitor 15:17:47 INFO - Successfully installed mozsystemmonitor 15:17:47 INFO - Cleaning up... 15:17:47 INFO - Return code: 0 15:17:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:47 INFO - Using env: {'DISPLAY': ':0', 15:17:47 INFO - 'HOME': '/home/cltbld', 15:17:47 INFO - 'LANG': 'en_US.UTF-8', 15:17:47 INFO - 'LANGUAGE': 'en_US:en', 15:17:47 INFO - 'LOGNAME': 'cltbld', 15:17:47 INFO - 'MAIL': '/var/mail/cltbld', 15:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:47 INFO - 'MOZ_NO_REMOTE': '1', 15:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:47 INFO - 'NO_EM_RESTART': '1', 15:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:47 INFO - 'PWD': '/builds/slave/test', 15:17:47 INFO - 'SHELL': '/bin/bash', 15:17:47 INFO - 'SHLVL': '1', 15:17:47 INFO - 'TERM': 'linux', 15:17:47 INFO - 'TMOUT': '86400', 15:17:47 INFO - 'USER': 'cltbld', 15:17:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:47 INFO - '_': '/tools/buildbot/bin/python'} 15:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:49 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:50 INFO - Downloading docopt-0.6.1.tar.gz 15:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:50 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:50 INFO - Running setup.py install for blobuploader 15:17:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:50 INFO - Running setup.py install for requests 15:17:51 INFO - Running setup.py install for docopt 15:17:51 INFO - Successfully installed blobuploader requests docopt 15:17:51 INFO - Cleaning up... 15:17:51 INFO - Return code: 0 15:17:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:51 INFO - Using env: {'DISPLAY': ':0', 15:17:51 INFO - 'HOME': '/home/cltbld', 15:17:51 INFO - 'LANG': 'en_US.UTF-8', 15:17:51 INFO - 'LANGUAGE': 'en_US:en', 15:17:51 INFO - 'LOGNAME': 'cltbld', 15:17:51 INFO - 'MAIL': '/var/mail/cltbld', 15:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:51 INFO - 'MOZ_NO_REMOTE': '1', 15:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:51 INFO - 'NO_EM_RESTART': '1', 15:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:51 INFO - 'PWD': '/builds/slave/test', 15:17:51 INFO - 'SHELL': '/bin/bash', 15:17:51 INFO - 'SHLVL': '1', 15:17:51 INFO - 'TERM': 'linux', 15:17:51 INFO - 'TMOUT': '86400', 15:17:51 INFO - 'USER': 'cltbld', 15:17:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:51 INFO - '_': '/tools/buildbot/bin/python'} 15:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:51 INFO - Running setup.py (path:/tmp/pip-3EFkOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:51 INFO - Running setup.py (path:/tmp/pip-xNRdKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:51 INFO - Running setup.py (path:/tmp/pip-36UcV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:51 INFO - Running setup.py (path:/tmp/pip-dJKHTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:51 INFO - Running setup.py (path:/tmp/pip-MzcdIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:51 INFO - Running setup.py (path:/tmp/pip-qt0L3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:51 INFO - Running setup.py (path:/tmp/pip-zdSfNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:52 INFO - Running setup.py (path:/tmp/pip-zKSiYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:52 INFO - Running setup.py (path:/tmp/pip-dnp8If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:52 INFO - Running setup.py (path:/tmp/pip-RzLskX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:52 INFO - Running setup.py (path:/tmp/pip-qWqK23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:52 INFO - Running setup.py (path:/tmp/pip-Y9aueb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:52 INFO - Running setup.py (path:/tmp/pip-TTK1Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:52 INFO - Running setup.py (path:/tmp/pip-xEY_Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:52 INFO - Running setup.py (path:/tmp/pip-dbbC_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:52 INFO - Running setup.py (path:/tmp/pip-EwdAk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:52 INFO - Running setup.py (path:/tmp/pip-gzgnVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:52 INFO - Running setup.py install for manifestparser 15:17:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozcrash 15:17:52 INFO - Running setup.py install for mozdebug 15:17:53 INFO - Running setup.py install for mozdevice 15:17:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for mozfile 15:17:53 INFO - Running setup.py install for mozhttpd 15:17:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for mozinfo 15:17:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for mozInstall 15:17:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for mozleak 15:17:53 INFO - Running setup.py install for mozlog 15:17:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for moznetwork 15:17:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for mozprocess 15:17:53 INFO - Running setup.py install for mozprofile 15:17:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:54 INFO - Running setup.py install for mozrunner 15:17:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:54 INFO - Running setup.py install for mozscreenshot 15:17:54 INFO - Running setup.py install for moztest 15:17:54 INFO - Running setup.py install for mozversion 15:17:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:54 INFO - Cleaning up... 15:17:54 INFO - Return code: 0 15:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:54 INFO - Using env: {'DISPLAY': ':0', 15:17:54 INFO - 'HOME': '/home/cltbld', 15:17:54 INFO - 'LANG': 'en_US.UTF-8', 15:17:54 INFO - 'LANGUAGE': 'en_US:en', 15:17:54 INFO - 'LOGNAME': 'cltbld', 15:17:54 INFO - 'MAIL': '/var/mail/cltbld', 15:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:54 INFO - 'MOZ_NO_REMOTE': '1', 15:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:54 INFO - 'NO_EM_RESTART': '1', 15:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:54 INFO - 'PWD': '/builds/slave/test', 15:17:54 INFO - 'SHELL': '/bin/bash', 15:17:54 INFO - 'SHLVL': '1', 15:17:54 INFO - 'TERM': 'linux', 15:17:54 INFO - 'TMOUT': '86400', 15:17:54 INFO - 'USER': 'cltbld', 15:17:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:54 INFO - '_': '/tools/buildbot/bin/python'} 15:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:54 INFO - Running setup.py (path:/tmp/pip-z7MQwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17: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)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:54 INFO - Running setup.py (path:/tmp/pip-8NkF7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17: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)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:54 INFO - Running setup.py (path:/tmp/pip-VaEZwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:54 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)) 15:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:54 INFO - Running setup.py (path:/tmp/pip-lQUZZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:55 INFO - Running setup.py (path:/tmp/pip-URXF_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:55 INFO - Running setup.py (path:/tmp/pip-egEIUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:55 INFO - Running setup.py (path:/tmp/pip-8494PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:55 INFO - Running setup.py (path:/tmp/pip-fQvq2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:55 INFO - Running setup.py (path:/tmp/pip-RC4EEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:55 INFO - Running setup.py (path:/tmp/pip-7fPXf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:55 INFO - Running setup.py (path:/tmp/pip-yXam8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:55 INFO - Running setup.py (path:/tmp/pip-Mx_KRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:55 INFO - Running setup.py (path:/tmp/pip-LCuanB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:55 INFO - Running setup.py (path:/tmp/pip-r8BupA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:55 INFO - Running setup.py (path:/tmp/pip-7HZjAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17: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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:55 INFO - Running setup.py (path:/tmp/pip-9OB_Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:55 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)) 15:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:55 INFO - Running setup.py (path:/tmp/pip-9AjJuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:55 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)) 15:17:55 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)) 15:17:55 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)) 15:17:55 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)) 15:17:55 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)) 15:17:55 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)) 15:17:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:57 INFO - Downloading blessings-1.6.tar.gz 15:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:57 INFO - Installing collected packages: blessings 15:17:57 INFO - Running setup.py install for blessings 15:17:58 INFO - Successfully installed blessings 15:17:58 INFO - Cleaning up... 15:17:58 INFO - Return code: 0 15:17:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:58 INFO - Reading from file tmpfile_stdout 15:17:58 INFO - Current package versions: 15:17:58 INFO - argparse == 1.2.1 15:17:58 INFO - blessings == 1.6 15:17:58 INFO - blobuploader == 1.2.4 15:17:58 INFO - docopt == 0.6.1 15:17:58 INFO - manifestparser == 1.1 15:17:58 INFO - mozInstall == 1.12 15:17:58 INFO - mozcrash == 0.17 15:17:58 INFO - mozdebug == 0.1 15:17:58 INFO - mozdevice == 0.48 15:17:58 INFO - mozfile == 1.2 15:17:58 INFO - mozhttpd == 0.7 15:17:58 INFO - mozinfo == 0.9 15:17:58 INFO - mozleak == 0.1 15:17:58 INFO - mozlog == 3.1 15:17:58 INFO - moznetwork == 0.27 15:17:58 INFO - mozprocess == 0.22 15:17:58 INFO - mozprofile == 0.28 15:17:58 INFO - mozrunner == 6.11 15:17:58 INFO - mozscreenshot == 0.1 15:17:58 INFO - mozsystemmonitor == 0.0 15:17:58 INFO - moztest == 0.7 15:17:58 INFO - mozversion == 1.4 15:17:58 INFO - psutil == 3.1.1 15:17:58 INFO - requests == 1.2.3 15:17:58 INFO - wsgiref == 0.1.2 15:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:58 INFO - Using env: {'DISPLAY': ':0', 15:17:58 INFO - 'HOME': '/home/cltbld', 15:17:58 INFO - 'LANG': 'en_US.UTF-8', 15:17:58 INFO - 'LANGUAGE': 'en_US:en', 15:17:58 INFO - 'LOGNAME': 'cltbld', 15:17:58 INFO - 'MAIL': '/var/mail/cltbld', 15:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:58 INFO - 'MOZ_NO_REMOTE': '1', 15:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:58 INFO - 'NO_EM_RESTART': '1', 15:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:58 INFO - 'PWD': '/builds/slave/test', 15:17:58 INFO - 'SHELL': '/bin/bash', 15:17:58 INFO - 'SHLVL': '1', 15:17:58 INFO - 'TERM': 'linux', 15:17:58 INFO - 'TMOUT': '86400', 15:17:58 INFO - 'USER': 'cltbld', 15:17:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:58 INFO - '_': '/tools/buildbot/bin/python'} 15:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17: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)) 15:17:58 INFO - Cleaning up... 15:17:58 INFO - Return code: 0 15:17:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17: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')]} 15:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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')]} 15:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:17: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 15:17: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 15:17:58 INFO - Using env: {'DISPLAY': ':0', 15:17:58 INFO - 'HOME': '/home/cltbld', 15:17:58 INFO - 'LANG': 'en_US.UTF-8', 15:17:58 INFO - 'LANGUAGE': 'en_US:en', 15:17:58 INFO - 'LOGNAME': 'cltbld', 15:17:58 INFO - 'MAIL': '/var/mail/cltbld', 15:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:58 INFO - 'MOZ_NO_REMOTE': '1', 15:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:58 INFO - 'NO_EM_RESTART': '1', 15:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:58 INFO - 'PWD': '/builds/slave/test', 15:17:58 INFO - 'SHELL': '/bin/bash', 15:17:58 INFO - 'SHLVL': '1', 15:17:58 INFO - 'TERM': 'linux', 15:17:58 INFO - 'TMOUT': '86400', 15:17:58 INFO - 'USER': 'cltbld', 15:17:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:58 INFO - '_': '/tools/buildbot/bin/python'} 15:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:58 INFO - Downloading/unpacking jsonschema 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:18:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:00 INFO - Downloading/unpacking functools32 (from jsonschema) 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:00 INFO - warning: no files found matching '*.txt' 15:18:00 INFO - no previously-included directories found matching 'build' 15:18:00 INFO - no previously-included directories found matching 'dist' 15:18:00 INFO - no previously-included directories found matching '.git*' 15:18:00 INFO - Installing collected packages: jsonschema, functools32 15:18:00 INFO - Running setup.py install for functools32 15:18:00 INFO - warning: no files found matching '*.txt' 15:18:00 INFO - no previously-included directories found matching 'build' 15:18:00 INFO - no previously-included directories found matching 'dist' 15:18:00 INFO - no previously-included directories found matching '.git*' 15:18:01 INFO - Successfully installed jsonschema functools32 15:18:01 INFO - Cleaning up... 15:18:01 INFO - Return code: 0 15:18:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:18: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')]} 15:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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')]} 15:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:18: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 0x7f5a43fe1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, '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': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', '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 15:18: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 15:18: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 15:18:01 INFO - Using env: {'DISPLAY': ':0', 15:18:01 INFO - 'HOME': '/home/cltbld', 15:18:01 INFO - 'LANG': 'en_US.UTF-8', 15:18:01 INFO - 'LANGUAGE': 'en_US:en', 15:18:01 INFO - 'LOGNAME': 'cltbld', 15:18:01 INFO - 'MAIL': '/var/mail/cltbld', 15:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:01 INFO - 'MOZ_NO_REMOTE': '1', 15:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:01 INFO - 'NO_EM_RESTART': '1', 15:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:01 INFO - 'PWD': '/builds/slave/test', 15:18:01 INFO - 'SHELL': '/bin/bash', 15:18:01 INFO - 'SHLVL': '1', 15:18:01 INFO - 'TERM': 'linux', 15:18:01 INFO - 'TMOUT': '86400', 15:18:01 INFO - 'USER': 'cltbld', 15:18:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:01 INFO - '_': '/tools/buildbot/bin/python'} 15:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:01 INFO - Downloading/unpacking flake8 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:18:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:18:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18: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 15:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:18:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:03 INFO - no previously-included directories found matching 'docs/_build' 15:18:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:18:03 INFO - Running setup.py install for pep8 15:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:18:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:18:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:18:04 INFO - no previously-included directories found matching 'docs/_build' 15:18:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:18:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:18:04 INFO - Cleaning up... 15:18:04 INFO - Return code: 0 15:18:04 INFO - Running post-action listener: _resource_record_post_action 15:18:04 INFO - Running post-action listener: _start_resource_monitoring 15:18:04 INFO - Starting resource monitoring. 15:18:04 INFO - ##### 15:18:04 INFO - ##### Running install step. 15:18:04 INFO - ##### 15:18:04 INFO - Running pre-action listener: _resource_record_pre_action 15:18:04 INFO - Running main action method: install 15:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:04 INFO - Reading from file tmpfile_stdout 15:18:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:04 INFO - Reading from file tmpfile_stdout 15:18:04 INFO - Output received: 15:18:04 INFO - Usage: mozinstall [options] installer 15:18:04 INFO - Options: 15:18:04 INFO - -h, --help show this help message and exit 15:18:04 INFO - -d DEST, --destination=DEST 15:18:04 INFO - Directory to install application into. [default: 15:18:04 INFO - "/builds/slave/test"] 15:18:04 INFO - --app=APP Application being installed. [default: firefox] 15:18:04 INFO - mkdir: /builds/slave/test/build/application 15:18: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'] 15:18: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 15:18:19 INFO - Reading from file tmpfile_stdout 15:18:19 INFO - Output received: 15:18:19 INFO - /builds/slave/test/build/application/firefox/firefox 15:18:19 INFO - Running post-action listener: _resource_record_post_action 15:18:19 INFO - ##### 15:18:19 INFO - ##### Running run-tests step. 15:18:19 INFO - ##### 15:18:19 INFO - Running pre-action listener: _resource_record_pre_action 15:18:19 INFO - Running main action method: run_tests 15:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:19 INFO - Python 2.7.3 15:18:19 INFO - Return code: 0 15:18:19 INFO - grabbing minidump binary from tooltool 15:18: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')]} 15:18: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 0x2a87160>, '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 0x2a88060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a884f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18: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 15:18: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 15:18:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:19 INFO - Return code: 0 15:18:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:18:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:18:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:18:20 INFO - Return code: 0 15:18: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/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:18: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/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 15:18:20 INFO - Using env: {'DISPLAY': ':0', 15:18:20 INFO - 'HOME': '/home/cltbld', 15:18:20 INFO - 'LANG': 'en_US.UTF-8', 15:18:20 INFO - 'LANGUAGE': 'en_US:en', 15:18:20 INFO - 'LOGNAME': 'cltbld', 15:18:20 INFO - 'MAIL': '/var/mail/cltbld', 15:18:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:20 INFO - 'MOZ_NO_REMOTE': '1', 15:18:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:20 INFO - 'NO_EM_RESTART': '1', 15:18:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:20 INFO - 'PWD': '/builds/slave/test', 15:18:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:20 INFO - 'SHELL': '/bin/bash', 15:18:20 INFO - 'SHLVL': '1', 15:18:20 INFO - 'TERM': 'linux', 15:18:20 INFO - 'TMOUT': '86400', 15:18:20 INFO - 'USER': 'cltbld', 15:18:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803', 15:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:20 INFO - '_': '/tools/buildbot/bin/python'} 15:18: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/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:18:20 INFO - mozversion application_buildid: 20160420124052 15:18:20 INFO - mozversion application_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 15:18:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:18:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:20 INFO - mozversion application_name: Firefox 15:18:20 INFO - mozversion application_remotingname: firefox-dev 15:18:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:18:20 INFO - mozversion application_vendor: Mozilla 15:18:20 INFO - mozversion application_version: 47.0a2 15:18:20 INFO - mozversion platform_buildid: 20160420124052 15:18:20 INFO - mozversion platform_changeset: 2387e00d2ce89a2cd641df7ca92af4feeeebe556 15:18:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:18:20 INFO - mozversion platform_version: 47.0a2 15:18:20 INFO - using testdate: 1461190700 15:18:20 INFO - actual date: 1461190700 15:18:20 INFO - starting webserver on 'localhost:37198' 15:18:20 INFO - SUITE-START | Running 2 tests 15:18:20 INFO - TEST-START | dromaeo_css 15:18:20 INFO - operating with platform_type : linux_ 15:18:20 INFO - Initialising browser for dromaeo_css test... 15:18:20 INFO - TEST-INFO | started process 17828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi4aO1Y/profile http://localhost:37198/getInfo.html) 15:18:24 INFO - PROCESS | 17828 | 15:18:24 INFO - PROCESS | 17828 | (process:17905): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:18:25 INFO - PROCESS | 17828 | __metrics Screen width/height:1600/1200 15:18:25 INFO - PROCESS | 17828 | colorDepth:24 15:18:25 INFO - PROCESS | 17828 | Browser inner width/height: 1024/697 15:18:25 INFO - PROCESS | 17828 | __metrics 15:18:25 ERROR - PROCESS | 17828 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:18:26 INFO - TEST-INFO | 17828: exit 0 15:18:26 INFO - Browser initialized. 15:18:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:26 INFO - TEST-INFO | started process 17956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi4aO1Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:28 INFO - PROCESS | 17956 | 15:18:28 INFO - PROCESS | 17956 | (process:18025): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:18:38 INFO - PROCESS | 17956 | RSS: Main: 150999040 15:18:38 INFO - PROCESS | 17956 | 15:19:27 INFO - PROCESS | 17956 | 1461190767967 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] 15:21:36 INFO - PROCESS | 17956 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37198/tests/dromaeo/cssquery-ext.html) 15:21:37 INFO - PROCESS | 17956 | RSS: Main: 154521600 15:21:37 INFO - PROCESS | 17956 | 15:24:39 INFO - PROCESS | 17956 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-ext.html (next: http://localhost:37198/tests/dromaeo/cssquery-jquery.html) 15:24:39 INFO - PROCESS | 17956 | RSS: Main: 153460736 15:24:39 INFO - PROCESS | 17956 | 15:27:41 INFO - PROCESS | 17956 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37198/tests/dromaeo/cssquery-mootools.html) 15:27:42 INFO - PROCESS | 17956 | RSS: Main: 153014272 15:27:42 INFO - PROCESS | 17956 | 15:30:43 INFO - PROCESS | 17956 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37198/tests/dromaeo/cssquery-prototype.html) 15:30:44 INFO - PROCESS | 17956 | RSS: Main: 152469504 15:30:44 INFO - PROCESS | 17956 | 15:33:46 INFO - PROCESS | 17956 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37198/tests/dromaeo/cssquery-yui.html) 15:33:47 INFO - PROCESS | 17956 | RSS: Main: 153288704 15:33:47 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | Cycle 1(1): loaded http://localhost:37198/tests/dromaeo/cssquery-yui.html (next: http://localhost:37198/tests/dromaeo/cssquery-dojo.html) 15:36:49 INFO - PROCESS | 17956 | RSS: Main: 155316224 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | __start_tp_report 15:36:49 INFO - PROCESS | 17956 | _x_x_mozilla_page_load 15:36:49 INFO - PROCESS | 17956 | _x_x_mozilla_page_load_details 15:36:49 INFO - PROCESS | 17956 | |i|pagename|runs| 15:36:49 INFO - PROCESS | 17956 | |0;dojo.html;3352.6814952579502;3438.4670376091713;3441.879534216302;3473.565804274466;3487.860485580575;5642.576806739501;5649.6327738696955;5659.9999999999945;5671.659700417978;5693.715314234288;5636.7181640918;5655.915161272574;5674;5675.318961724599;5675.978323901706;5071.087204303224;5164.845054648366;5203.895922081556;5226.033183860979;5245.239440281157;5154.046501397234;5252.789888404459;5292.867678308035;5315.202719592073;5321.3348331458565;5230.2416149658275;5245.370555533342;5284.682919024852;5321.494458026481;5345.946540534604;5208.531232189102;5253.212018197282;5287.233351164098;5292.100342941709;5304.602154838402;4992.975035124801;5030.220315851049;5136.974315128437;5151.7166555839785;5256.132738098209;5464.617476776627;5466.781328746845;5494.36814766303;5495.642783219078;5496.7526461309335;6076.422739839708;6094;6109.755609775648;6111.572189946705;6136.969315153396;6008.429199226067;6074.42292982166;6157.199564056688;6175.44421002112;6200.069989501566;5796.710164491758;5815.447532484407;5818.534517238695;5823.4467725566;5824.213731146326;6054;6352.904706429407;6369.394907483782;6369.777057802955;6370.235571731422;5992.161097446361;6059.030555111161;6060.484858786965;6066.787662431793;6101.603395779349;6105.297890742621;6106.694665266719;6108.816735497942;6112.449879510777;6113.816585502442;5819.359870414251;6064.211652485149;6070.544709146831;6079.696015199311;6128.63228206309;6098.512119030467;6133.579501509479;6145.784897528654;6146.016637338004;6159.045347971071;4637.443506779208;4646.140464014168;4658.068386322749;4678.602318802872;4698.671093023524;4073.551909289976;4098.631123198927;4141.937870931938;4170.436991006236;4200.663946884242;5667.858303542444;5702.7433765480655;5703.401142879938;5732.398098199712;5778.855528611818;6182.814515564541;6213.782517611862;6215.782447614311;6233.875322493615;6245.250569931637;5835.037218858841;5842.8539286517325;5850.23946886902;5854.297484301911;5893.616914900518;5088.516590923857;5272.710000949908;5320.920186197211;5338.91991620126;5382.085045542267;6191.1641928339095;6223.066540019034;6223.937760622426;6237.438630523275;6245.0632405139595;5953.374895635896;6151.876962460815;6157.661328626789;6158.630482171084;6171.382861713792;6199.659018754011;6250.687465626791;6335.873282534231;6346.2067241594805;6359.236891572856;6055.303640081271;6061.212042434456;6061.605995610271;6080.331163572092;6135.969320153549;5961.523078153824;6195.96902015487;6233.283172435046;6241.375862413723;6248.312685604489;5939.316978547349;6000.459958603747;6003.0695242237525;6020.307664618625;6039.184710064085;6024.096385542204;6049.727762250797;6050.273967123973;6051.334353221054;6054.969725151346;5782.537397008314;5876.911846322223;5904.439078287728;5934;5939.406059394026;6016.308124565731;6070.575059745775;6082.574219804571;6094.055421409688;6096.207493025879;5889.263842019747;5925.140854576149;5941.732622032106;5946.702664866826;5948.583599148018 15:36:49 INFO - PROCESS | 17956 | |1;ext.html;546.7293689623637;555.1791629027402;571.4085921071689;572.5019233267058;588.4615576747276;41014.58985410145;41180.58819411805;41538.79230603843;41639.58360416395;41744;43892.56107438933;44468.55531444684;44543.554564454345;44592.77703611486;44675.32987005189;8959.328050396214;9125.178733913946;9130.497822619753;9136.543172841364;9157.038510956354;8892.15524525169;9103.317251206154;9138.0405057469;9320.953395233048;9332.346735728503;9352.532373381338;9363;9396.060393960617;9409.388389754678;9445.149936505713;9261.212796912238;9391.436513809193;9393.953030234874;9424.717258482257;9429.339946203769;9283.675071372469;9405.106514881076;9428.340016198868;9439.103285187895;9454;44863.551364486266;44888.326675099575;44934.101317973786;45117.548824511665;45222.547774522165;3055.526393409003;3725.962740372616;3890.455336252927;3937.03542632057;4022.3966405039187;29145.70854291451;29469.70530294691;29787;29818.701812982028;30340.54489182664;4166.500019997589;4230.9365359519325;4249.660027197817;4250.681198910094;4268.231718290706;209476;211677;212252.99999999846;212538;213392;47857.52142478531;57760;58091;58507.41492585105;58568;46072;46143.538564614595;46308.3053754194;46325;46408.76795616068;14369;14440.350184241524;14464.421423143167;14505.274736263145;14520.927395363167;12864.935675321563;12871.356432178354;12916.612501624966;12974.35128243584;12983.35083245834;15524.456644017631;15653.60865978337;15863.444779432664;15949.362025518849;16032.438864639682;6006.279246490361;6228.906566401508;6258;6287.465565426898;6399.9040014399825;977.1059480575336;1012.7063151686076;1097.6926460591046;1111.216592302425;1153.7058050197313;29942;30349.393012139633;30762.84618576893;30832.53751193734;30883.691163088082;1129.3224065560598;1159.5187996981326;1195.2768575012167;1204.6988252936767;1250.687328167958;15731;15820.525384238492;15853;15911.522654320388;16108.033517988959;369738;373478;375373;375497;376768;60240.39759602348;60708.392916070276;60848;60969.39030609637;61067.69466152641;1500.167407089076;1503.7142942840826;1513.9856296281298;1530.4413888930683;1536.8078990126235;30266.638001289553;30433;30599.847000764854;30604.234894126934;30692.386152277275;52738.736306319755;53304;53416.73291633517;53423.732881335345;53588;352908;353582;354640;356069;356740;36349.27301454009;37038;51862.740686296325;53349;53356;48665.27002094901;50568;56798.43201568097;57476.9858166661;58544.414555853895;41618.58381416268;41947.37078943879;41975.58024419717;42535.3619695711;42575.787121065434;40212;44690.3296450547;44981;46062.30906536338;46092.769536152104;44513.332300016176;44986.55013449823;45987;46466.30300545427;46839.765801172136;39080.218395632495;39506.40740388954;39622.80188599038;40312.3953140709;40747.796261018506;30918;30931.84534077315;30936.69063309338;30987.84506077455;31286.217844554067 15:36:49 INFO - PROCESS | 17956 | |2;jquery.html;390.1358490942562;395.7922090902276;397.7136461747541;399.6582921602031;406.1288536090087;14694;17626.11869406531;17814.10929453527;18449;18517.16672749726;16881.83118168818;17123.571910702238;17313.39403120891;17356;17401.73897391537;5551.72241387931;5594.272744543204;5736.942630573682;5755.107958266475;5825.533957283407;5642.943570564283;5687.943120568803;5690.630109042899;5718.885622287552;5720.742566584514;5673.177389278552;5685.118806584966;5695.45893140151;5698.059820129673;5709.257796486451;5607.663540187581;5742.511886489653;5750.511206547449;5753.367129615739;5753.884922301551;5165;5166.199239117943;5180.766865491062;5193.039287731782;5206.557442617382;12447.564335248313;19092.904535477373;19211.80788192114;19951.80048199514;20010.299639512694;2204.393791707277;2206.4594174427207;2255.0754190781863;2395.149721848736;2912.37383962447;9866.60533578656;10025.548850301753;10109.03964123407;10186.59253629854;10216.284860059799;1903.6287923854854;1931.3723040011912;1944.0765636322774;2017.1931227508967;2027.3309807763403;64514.677426612565;67897;68277;68558;68888;10423.114035307084;10568.418736969541;10816.351018938889;10854.565817367216;11475.081993440504;13243.470261189444;14047.438102475786;15212.847871521142;15276.465323713617;15279.312430940412;6372.808815735535;6401.64790936503;7339.376153026946;7756.224377562198;7923.603819808986;7445.292697193758;7525.247475252431;7536.171021187665;7572.8485430292185;7697.076350837935;4627.722336659811;4664.976675116671;4748.548887855648;4776.522347765195;4816.975915120402;1933.8162874526897;1955.5724321245286;2001.9499512512011;2019.3739940618455;2047.5393036566952;920.6133423961952;995.2933417273672;1025.4565080507343;1030.891756365571;1075.499892549968;16790.916045419694;16881.15594220284;16926.23831927566;17196;17606.823931760773;1009.258195226508;1024.7233247023412;1026.8870424253325;1027.7225149209671;1081.1458947431597;9747.707568772807;9806.65676701312;9951;10152.187824973984;10258.230632702576;466156;468254;478589;480586;481833;77468;77993.22006779973;78802.60598696969;79289.60355198187;81743.59128204321;1084.3006260961636;1113.9944300278446;1115.6151127860876;1117.0839911272678;1119.904808091305;15888.682226355639;16033.67932641364;16192.433264835674;16213.432529861399;16516.50450486487;25757;30774.076777696704;36616.81691591525;36798.63201368059;37720.811395942845;50800.23799642934;50814.23778643397;50949.74525127499;50981.23528147155;51346;7773.883391749016;8385.413021088709;8503.149685031447;8749;8786.912130878609;12708.237505749685;12842.101052926206;12871.678208044874;13008.47966081384;13042.54351097707;10169.288149829441;10427.733994333117;10450.47747612601;10484.423356715453;10588.629397971034;11485.19603627738;11540.711482213012;11541.653750387502;12033.398330083635;12093.455794489446;10565.366078035342;10703;10846;10990.505427255634;11094.667159985212;8589.8711519326;8793.692220772242;8812.91187088121;8950.194482496607;8958.955205223932;8188.754337369888;10337.586496540054;10763.784724305626;10764.677059688222;10942.17933654963 15:36:49 INFO - PROCESS | 17956 | |3;mootools.html;1584.239565008796;1597.3051722500713;1865.4590168851034;1925.1048262557908;1984.1765667248092;7454.329110380065;8109.148539403366;8325.125861784516;8523.659053637846;8525.744227673173;8317.043539992903;8317.209865062825;8401.243888050074;8423.326133909288;8452.661893524251;2352.282553821088;2393.114547617375;2400.8919598618104;2401.7838394544488;2409.180878501309;2379.2267513058237;2388.7850093491584;2426.8422552534116;2436.902523899042;2439.9268021959283;2413.746556611557;2416.6979127609047;2438.366024833538;2476.319012271622;2478.2317481580676;2433.0997530913673;2443.3769388805918;2449.081594402099;2464.2114523352534;2465.0755966512556;2428.3564855313357;2434.42790944128;2437.8293519453646;2443.816713746476;2454.3250606083293;8566.057733649293;8582.44214126086;8634.395592308541;8638.265747411477;8646.178613031752;5003.199488081926;5201.063808514466;5210.739463026872;5224.451432599561;5250.18622113573;3253.2192273854102;3268.7058164765285;3304.289577740797;3312.8840490582957;3344.4314466540745;1060.1412855586923;1130.711668524521;1131.0894729742554;1139.3790384240608;1142.0863309352485;11949.522019119226;12041.458134383975;12047.21693089955;12050.457729402198;12069.336186509738;4487.349334346502;4499.370088187657;4623.745693986796;4625.583697467244;4647.9767601161775;10037.69886903394;10057.14514266281;10072.345297555636;10128.240381971382;10129.493525323704;5130.127878260705;5144.125498665236;5159.25190847325;5165.535101840853;5167.767450464738;4158.542560318362;4693.436787585511;4704.482506924235;4727.196376615983;4804.471508134103;3835.175437280998;3890.9416358754643;3912.6087391260644;3926.8232929517667;3968.523777146761;1203.6750077479032;1224.993875030637;1246.7942789439642;1247.3638444393425;1253.260576260011;1453.1716921354937;1468.9853101469062;1472.8158980127484;1473.3369983507464;1496.895217334798;8090.393220508486;8143.063547691972;8143.796405089802;8147.144549822302;8161.959190204011;553.2641586689693;563.1580786723874;565.2284631478003;569.9800506982235;576.2163457697528;6009.819705408845;6114.2357205349335;6137.956547386955;6143.877122457526;6254.937450625435;10340.482975851177;10587.894121058845;10703.19726020536;10732.570697172026;10742.301750386356;10319.1744660427;10506.579736810594;10576.206784491194;10588;10599.417032063311;8210.671573137128;8231.259186673227;8232.094469608339;8244.464109832841;8302.958485207657;7833.647485863035;7913.010873640795;7926.167752386147;7935.722249721232;7989.081255655674;9276.886773587214;9347.065293470598;9486.95256523713;9505.619775208914;9539.904600953902;9536.713898583053;9714.708558743248;9717.319787614799;9857.950710246403;9883.851742224017;6626.734930602722;7111.715531378687;7358.337749602561;7637.770866874002;7683.423743219169;7950.920490795018;7966.402519810921;7976.361891048586;8024.719134830253;8031.518108913484;7045.823854403681;7253.528520646141;7259.564426134449;7329.1937886833475;7353.926460735538;6949;6968.686409111703;7115.644217789193;7223.855522889407;7276.017737605355;7402.29678180572;7504.174540800398;7504.662290197063;7513.549187048795;7526.02161718973;6609.504287178384;6614.8346291343105;6635.9004614929845;6672.899906501503;6680.966595166993;6927;6961.686724097326;6963.2340442552295;6982.301769822977;6991.300869912968 15:36:49 INFO - PROCESS | 17956 | |4;prototype.html;367.6727712336021;373.2646686028523;374.08162959933367;381.1462324393356;383.9961600383995;6412.679366031697;6468.547201695877;6507.804765857026;6527.379898909596;6545.803625891219;6405.007223880294;6405.871882562357;6410.871782564346;6411.358864113587;6421.7752378666755;4730.479647238801;4821.590164835993;4852.805887764485;4859.781309841065;4986.376702912136;4850.248211527219;4857.805687772502;4860.076585448771;4889.973105647819;4900.58345040672;4828.541288577597;4830.589399900995;4838.080764654722;4839.104765618355;4841.661083724141;4823.807047718087;4832.975835120819;4845.781939812717;4860.684055536414;4873.756312184377;4215.662746980234;4222;4226.281532139513;4230.17511585241;4230.746155230696;6023.186869772612;6143.846403839895;6159.414855588712;6161.04503801907;6162.630242185483;5726.169705392695;5737.483626473638;5740.913886291667;5740.942590574125;5753.165790960329;6739.191297044337;6768.424683901874;6805.693743781541;6829.214640316378;6857.759978400732;4749.4063242094735;4749.7387643679585;4752.239641657353;4753.073150735608;4761.690490118166;7040.507164498487;7097.858042839166;7099.680514376865;7118.07465029548;7134.393576545948;4662.370579971661;4779.330893674888;4865.245886887538;4889.217725164028;4893.584045356113;4854.101991131652;4871.902561948741;4874.390701162355;4890.193118135468;4907.190313598217;5628.887422251532;5634;5655.208270842086;5666.036773748473;5666.150077488327;6848.452123830081;6916.1700595927805;6922.342377474132;6928.515003949776;6930.549514281555;1723.8448539631493;1737.7219644856762;1748.9593691753387;1754.877158598886;1756.481837857835;1116.3700996544974;1145.7593905279984;1149.4137989625185;1159.7390587117832;1163.6036755892962;6491.383318584727;6498.187726534184;6508.9023664645065;6518.543701940914;6541.28045914949;6953.443724502028;6998.930010699828;7016.859662806715;7021.29787021304;7026.754063607749;6421.229452465641;6498.090267362573;6529.804105876831;6561.40947314744;6581.670916454158;3801.752886062397;3859.6526312632;3862.942055869108;3866.516685414323;3873.2447172801035;7303;7337.559746415125;7350.4119670426235;7375.225601311892;7379.188289288174;7290.088738907637;7293.9635301823155;7306.415486761046;7311.780646580611;7340.4127669786285;7144.714211431588;7315.597642129734;7359.521631093961;7396.297351751575;7406.703731850774;7056.329648683367;7073.434125270069;7088.645567721696;7114.217436081924;7142.214356420894;6952.44380449573;6979.4765392594745;7029.19164296092;7032.542884712478;7034.683439245348;7304.086989126359;7325.230850760593;7344.339009489172;7363.337299642843;7364.3372096511575;4633.30500424939;4761.500042495488;4797.592204662643;4820.060088282891;4881.487443818348;7005.859882802417;7014.649267536704;7030;7040.331168538981;7065.046218760402;6718.966405167943;6810.897836532356;6839.760608378683;6845.5550389224545;6853.074834897225;6830;6854.280300568368;6910.44716422695;6933.479989000744;6964.756233531802;6548.541602087998;6684.16447944007;6715.597064176165;6779.559328643622;6782.830429239111;6877.518573699793;6914.55055421396;6927.792166235021;6937.618430986344;6942.826429339307;6685.197776266879;6703.597784132968;6711.429528489938;6725.058491811248;6732.225794033553 15:36:49 INFO - PROCESS | 17956 | |5;yui.html;775.6083177995112;786.0763602766751;795.824918517926;881.8060026794107;883.6730409748392;14954.177520236397;15217.543473695807;15234.6953060939;15246.542603721879;15286.464973725922;14380.49668261611;14400.135991840498;14433.566992990201;14453.78319325211;14514.782278265808;892.9687460938868;911.9908800912006;913.7258822353301;914.07221670005;915.4919019943961;939.4363381970797;942.006183476432;943.556528431636;944.4286206844863;945.2438049560359;986.2997271936897;986.960521579136;991.2169386184905;992.3252188511809;1001.0990108901974;971.4268581536892;972.8978457262027;974.7027156717198;978.0122076702511;980.3137803537552;729.0158286313488;732.8717474442004;733.0323972356491;733.4645708632728;735.6505659811601;15674.608134796606;15770;15780;15820.525384238375;15881.602959925978;14060.789088163685;14137;14141.575752727333;14142.08076475036;14165.858341416557;11096.778064438748;11428.542858285658;11534.307941523535;11830.053595712323;11924.880751192464;3872.9031774205587;3902.551206611219;3909.257241124177;3991.1219531702977;4065.024394145413;49934.500654993346;50102;50604.493955060716;50758.746206268734;53045.469545304826;11212.10303175744;11233.269837460539;11438.199326047263;11464.828027579426;11523.48144333507;19647.41057768269;19805.801941980684;19916.302929397403;19924.90037549803;19929.10319035647;8098.797530061795;8387.161283871565;8396.370272229486;8482.363822713321;8543.231109200202;4419.469663640384;4572;4590.908181836411;4610.423697037871;4881.292212629149;3538.6992105671306;3580.98209508956;3589.6051434342203;3594.8022858742497;3598.946015809765;644.7421031587403;658.6542065415695;666.4368608525788;673.5823789250696;682.3347236444426;607.5625549604366;679.8436359637311;686.50228584276;698.4098436820879;703.8486725353971;7879.487833290817;7891.960540197377;8044.678212871537;8064.153263907206;8134.674613015532;645.4384685323798;662.9403353698191;670.6244503078194;674.9122614060141;696.20632478974;3701.1857391373856;3716.312482190803;3799.5820459749407;3835.961640383616;3909.139989202371;62515.37484625186;64961.67519162374;65681.34318656848;65947.67026164838;66328;53861;54984.725076375165;55965;56809.7159514208;56867.14699279514;46187;49652.25521617178;51668;51905.48094519082;52087.218691718896;8239;8247.752567422987;8369.748907532783;8578.099299573705;8672.869906951275;37784.86645400643;37821.62178378181;38036;38141.237175256894;38672;49963.25055124249;50177;50258.748706256236;50856.74571627118;51417.742911285204;11771.823422648496;11935.283882967049;12320.876791231973;12543.3101179436;12617.432215550505;12961.351932403153;13065.216087034809;13103.803442948172;13185.274809885548;13341.799873002106;11287;11306.717332066764;11319.773604528027;11375.26060806045;11484.655460336204;11168.274062185932;11386.43067846621;11402.144839136932;11493.252938558968;11752.764944700886;11001.394923279297;11102.722431939266;11309.886901131213;11338.036266917405;11492.138089643144;10444.216683748597;10764.892351076389;10885.074768644754;10909.781804364027;11138.3873886937;9671.129598336183;9790.846013876935;9796.9020309796;10114.342567733074;10210.897891020995 15:36:49 INFO - PROCESS | 17956 | __end_tp_report 15:36:49 INFO - PROCESS | 17956 | __start_cc_report 15:36:49 INFO - PROCESS | 17956 | _x_x_mozilla_cycle_collect,336 15:36:49 INFO - PROCESS | 17956 | __end_cc_report 15:36:49 INFO - PROCESS | 17956 | __startTimestamp1461191809785__endTimestamp 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | ------- Summary: start ------- 15:36:49 INFO - PROCESS | 17956 | Number of tests: 6 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | [#0] dojo.html Cycles:165 Average:5689.51 Median:5939.32 stddev:637.59 (10.7%) stddev-sans-first:612.63 15:36:49 INFO - PROCESS | 17956 | Values: 3352.7 3438.5 3441.9 3473.6 3487.9 5642.6 5649.6 5660.0 5671.7 5693.7 5636.7 5655.9 5674.0 5675.3 5676.0 5071.1 5164.8 5203.9 5226.0 5245.2 5154.0 5252.8 5292.9 5315.2 5321.3 5230.2 5245.4 5284.7 5321.5 5345.9 5208.5 5253.2 5287.2 5292.1 5304.6 4993.0 5030.2 5137.0 5151.7 5256.1 5464.6 5466.8 5494.4 5495.6 5496.8 6076.4 6094.0 6109.8 6111.6 6137.0 6008.4 6074.4 6157.2 6175.4 6200.1 5796.7 5815.4 5818.5 5823.4 5824.2 6054.0 6352.9 6369.4 6369.8 6370.2 5992.2 6059.0 6060.5 6066.8 6101.6 6105.3 6106.7 6108.8 6112.4 6113.8 5819.4 6064.2 6070.5 6079.7 6128.6 6098.5 6133.6 6145.8 6146.0 6159.0 4637.4 4646.1 4658.1 4678.6 4698.7 4073.6 4098.6 4141.9 4170.4 4200.7 5667.9 5702.7 5703.4 5732.4 5778.9 6182.8 6213.8 6215.8 6233.9 6245.3 5835.0 5842.9 5850.2 5854.3 5893.6 5088.5 5272.7 5320.9 5338.9 5382.1 6191.2 6223.1 6223.9 6237.4 6245.1 5953.4 6151.9 6157.7 6158.6 6171.4 6199.7 6250.7 6335.9 6346.2 6359.2 6055.3 6061.2 6061.6 6080.3 6136.0 5961.5 6196.0 6233.3 6241.4 6248.3 5939.3 6000.5 6003.1 6020.3 6039.2 6024.1 6049.7 6050.3 6051.3 6055.0 5782.5 5876.9 5904.4 5934.0 5939.4 6016.3 6070.6 6082.6 6094.1 6096.2 5889.3 5925.1 5941.7 5946.7 5948.6 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | [#1] ext.html Cycles:180 Average:50193.12 Median:23103.26 stddev:84456.96 (365.6%) stddev-sans-first:84611.63 15:36:49 INFO - PROCESS | 17956 | Values: 546.7 555.2 571.4 572.5 588.5 41014.6 41180.6 41538.8 41639.6 41744.0 43892.6 44468.6 44543.6 44592.8 44675.3 8959.3 9125.2 9130.5 9136.5 9157.0 8892.2 9103.3 9138.0 9321.0 9332.3 9352.5 9363.0 9396.1 9409.4 9445.1 9261.2 9391.4 9394.0 9424.7 9429.3 9283.7 9405.1 9428.3 9439.1 9454.0 44863.6 44888.3 44934.1 45117.5 45222.5 3055.5 3726.0 3890.5 3937.0 4022.4 29145.7 29469.7 29787.0 29818.7 30340.5 4166.5 4230.9 4249.7 4250.7 4268.2 209476.0 211677.0 212253.0 212538.0 213392.0 47857.5 57760.0 58091.0 58507.4 58568.0 46072.0 46143.5 46308.3 46325.0 46408.8 14369.0 14440.4 14464.4 14505.3 14520.9 12864.9 12871.4 12916.6 12974.4 12983.4 15524.5 15653.6 15863.4 15949.4 16032.4 6006.3 6228.9 6258.0 6287.5 6399.9 977.1 1012.7 1097.7 1111.2 1153.7 29942.0 30349.4 30762.8 30832.5 30883.7 1129.3 1159.5 1195.3 1204.7 1250.7 15731.0 15820.5 15853.0 15911.5 16108.0 369738.0 373478.0 375373.0 375497.0 376768.0 60240.4 60708.4 60848.0 60969.4 61067.7 1500.2 1503.7 1514.0 1530.4 1536.8 30266.6 30433.0 30599.8 30604.2 30692.4 52738.7 53304.0 53416.7 53423.7 53588.0 352908.0 353582.0 354640.0 356069.0 356740.0 36349.3 37038.0 51862.7 53349.0 53356.0 48665.3 50568.0 56798.4 57477.0 58544.4 41618.6 41947.4 41975.6 42535.4 42575.8 40212.0 44690.3 44981.0 46062.3 46092.8 44513.3 44986.6 45987.0 46466.3 46839.8 39080.2 39506.4 39622.8 40312.4 40747.8 30918.0 30931.8 30936.7 30987.8 31286.2 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | [#2] jquery.html Cycles:180 Average:26902.64 Median:2325.11 stddev:77923.54 (3351.4%) stddev-sans-first:78116.71 15:36:49 INFO - PROCESS | 17956 | Values: 390.1 395.8 397.7 399.7 406.1 14694.0 17626.1 17814.1 18449.0 18517.2 16881.8 17123.6 17313.4 17356.0 17401.7 5551.7 5594.3 5736.9 5755.1 5825.5 5642.9 5687.9 5690.6 5718.9 5720.7 5673.2 5685.1 5695.5 5698.1 5709.3 5607.7 5742.5 5750.5 5753.4 5753.9 5165.0 5166.2 5180.8 5193.0 5206.6 12447.6 19092.9 19211.8 19951.8 20010.3 2204.4 2206.5 2255.1 2395.1 2912.4 9866.6 10025.5 10109.0 10186.6 10216.3 1903.6 1931.4 1944.1 2017.2 2027.3 64514.7 67897.0 68277.0 68558.0 68888.0 10423.1 10568.4 10816.4 10854.6 11475.1 13243.5 14047.4 15212.8 15276.5 15279.3 6372.8 6401.6 7339.4 7756.2 7923.6 7445.3 7525.2 7536.2 7572.8 7697.1 4627.7 4665.0 4748.5 4776.5 4817.0 1933.8 1955.6 2001.9 2019.4 2047.5 920.6 995.3 1025.5 1030.9 1075.5 16790.9 16881.2 16926.2 17196.0 17606.8 1009.3 1024.7 1026.9 1027.7 1081.1 9747.7 9806.7 9951.0 10152.2 10258.2 466156.0 468254.0 478589.0 480586.0 481833.0 77468.0 77993.2 78802.6 79289.6 81743.6 1084.3 1114.0 1115.6 1117.1 1119.9 15888.7 16033.7 16192.4 16213.4 16516.5 25757.0 30774.1 36616.8 36798.6 37720.8 50800.2 50814.2 50949.7 50981.2 51346.0 7773.9 8385.4 8503.1 8749.0 8786.9 12708.2 12842.1 12871.7 13008.5 13042.5 10169.3 10427.7 10450.5 10484.4 10588.6 11485.2 11540.7 11541.7 12033.4 12093.5 10565.4 10703.0 10846.0 10990.5 11094.7 8589.9 8793.7 8812.9 8950.2 8959.0 8188.8 10337.6 10763.8 10764.7 10942.2 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | [#3] mootools.html Cycles:180 Average:5939.68 Median:5184.42 stddev:3164.99 (61.0%) stddev-sans-first:3156.94 15:36:49 INFO - PROCESS | 17956 | Values: 1584.2 1597.3 1865.5 1925.1 1984.2 7454.3 8109.1 8325.1 8523.7 8525.7 8317.0 8317.2 8401.2 8423.3 8452.7 2352.3 2393.1 2400.9 2401.8 2409.2 2379.2 2388.8 2426.8 2436.9 2439.9 2413.7 2416.7 2438.4 2476.3 2478.2 2433.1 2443.4 2449.1 2464.2 2465.1 2428.4 2434.4 2437.8 2443.8 2454.3 8566.1 8582.4 8634.4 8638.3 8646.2 5003.2 5201.1 5210.7 5224.5 5250.2 3253.2 3268.7 3304.3 3312.9 3344.4 1060.1 1130.7 1131.1 1139.4 1142.1 11949.5 12041.5 12047.2 12050.5 12069.3 4487.3 4499.4 4623.7 4625.6 4648.0 10037.7 10057.1 10072.3 10128.2 10129.5 5130.1 5144.1 5159.3 5165.5 5167.8 4158.5 4693.4 4704.5 4727.2 4804.5 3835.2 3890.9 3912.6 3926.8 3968.5 1203.7 1225.0 1246.8 1247.4 1253.3 1453.2 1469.0 1472.8 1473.3 1496.9 8090.4 8143.1 8143.8 8147.1 8162.0 553.3 563.2 565.2 570.0 576.2 6009.8 6114.2 6138.0 6143.9 6254.9 10340.5 10587.9 10703.2 10732.6 10742.3 10319.2 10506.6 10576.2 10588.0 10599.4 8210.7 8231.3 8232.1 8244.5 8303.0 7833.6 7913.0 7926.2 7935.7 7989.1 9276.9 9347.1 9487.0 9505.6 9539.9 9536.7 9714.7 9717.3 9858.0 9883.9 6626.7 7111.7 7358.3 7637.8 7683.4 7950.9 7966.4 7976.4 8024.7 8031.5 7045.8 7253.5 7259.6 7329.2 7353.9 6949.0 6968.7 7115.6 7223.9 7276.0 7402.3 7504.2 7504.7 7513.5 7526.0 6609.5 6614.8 6635.9 6672.9 6681.0 6927.0 6961.7 6963.2 6982.3 6991.3 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | [#4] prototype.html Cycles:180 Average:5715.11 Median:6503.00 stddev:1734.24 (26.7%) stddev-sans-first:1692.03 15:36:49 INFO - PROCESS | 17956 | Values: 367.7 373.3 374.1 381.1 384.0 6412.7 6468.5 6507.8 6527.4 6545.8 6405.0 6405.9 6410.9 6411.4 6421.8 4730.5 4821.6 4852.8 4859.8 4986.4 4850.2 4857.8 4860.1 4890.0 4900.6 4828.5 4830.6 4838.1 4839.1 4841.7 4823.8 4833.0 4845.8 4860.7 4873.8 4215.7 4222.0 4226.3 4230.2 4230.7 6023.2 6143.8 6159.4 6161.0 6162.6 5726.2 5737.5 5740.9 5740.9 5753.2 6739.2 6768.4 6805.7 6829.2 6857.8 4749.4 4749.7 4752.2 4753.1 4761.7 7040.5 7097.9 7099.7 7118.1 7134.4 4662.4 4779.3 4865.2 4889.2 4893.6 4854.1 4871.9 4874.4 4890.2 4907.2 5628.9 5634.0 5655.2 5666.0 5666.2 6848.5 6916.2 6922.3 6928.5 6930.5 1723.8 1737.7 1749.0 1754.9 1756.5 1116.4 1145.8 1149.4 1159.7 1163.6 6491.4 6498.2 6508.9 6518.5 6541.3 6953.4 6998.9 7016.9 7021.3 7026.8 6421.2 6498.1 6529.8 6561.4 6581.7 3801.8 3859.7 3862.9 3866.5 3873.2 7303.0 7337.6 7350.4 7375.2 7379.2 7290.1 7294.0 7306.4 7311.8 7340.4 7144.7 7315.6 7359.5 7396.3 7406.7 7056.3 7073.4 7088.6 7114.2 7142.2 6952.4 6979.5 7029.2 7032.5 7034.7 7304.1 7325.2 7344.3 7363.3 7364.3 4633.3 4761.5 4797.6 4820.1 4881.5 7005.9 7014.6 7030.0 7040.3 7065.0 6719.0 6810.9 6839.8 6845.6 6853.1 6830.0 6854.3 6910.4 6933.5 6964.8 6548.5 6684.2 6715.6 6779.6 6782.8 6877.5 6914.6 6927.8 6937.6 6942.8 6685.2 6703.6 6711.4 6725.1 6732.2 15:36:49 INFO - PROCESS | 17956 | 15:36:49 INFO - PROCESS | 17956 | [#5] yui.html Cycles:180 Average:15033.57 Median:4600.67 stddev:17593.71 (382.4%) stddev-sans-first:17610.48 15:36:49 INFO - PROCESS | 17956 | Values: 775.6 786.1 795.8 881.8 883.7 14954.2 15217.5 15234.7 15246.5 15286.5 14380.5 14400.1 14433.6 14453.8 14514.8 893.0 912.0 913.7 914.1 915.5 939.4 942.0 943.6 944.4 945.2 986.3 987.0 991.2 992.3 1001.1 971.4 972.9 974.7 978.0 980.3 729.0 732.9 733.0 733.5 735.7 15674.6 15770.0 15780.0 15820.5 15881.6 14060.8 14137.0 14141.6 14142.1 14165.9 11096.8 11428.5 11534.3 11830.1 11924.9 3872.9 3902.6 3909.3 3991.1 4065.0 49934.5 50102.0 50604.5 50758.7 53045.5 11212.1 11233.3 11438.2 11464.8 11523.5 19647.4 19805.8 19916.3 19924.9 19929.1 8098.8 8387.2 8396.4 8482.4 8543.2 4419.5 4572.0 4590.9 4610.4 4881.3 3538.7 3581.0 3589.6 3594.8 3598.9 644.7 658.7 666.4 673.6 682.3 607.6 679.8 686.5 698.4 703.8 7879.5 7892.0 8044.7 8064.2 8134.7 645.4 662.9 670.6 674.9 696.2 3701.2 3716.3 3799.6 3836.0 3909.1 62515.4 64961.7 65681.3 65947.7 66328.0 53861.0 54984.7 55965.0 56809.7 56867.1 46187.0 49652.3 51668.0 51905.5 52087.2 8239.0 8247.8 8369.7 8578.1 8672.9 37784.9 37821.6 38036.0 38141.2 38672.0 49963.3 50177.0 50258.7 50856.7 51417.7 11771.8 11935.3 12320.9 12543.3 12617.4 12961.4 13065.2 13103.8 13185.3 13341.8 11287.0 11306.7 11319.8 11375.3 11484.7 11168.3 11386.4 11402.1 11493.3 11752.8 11001.4 11102.7 11309.9 11338.0 11492.1 10444.2 10764.9 10885.1 10909.8 11138.4 9671.1 9790.8 9796.9 10114.3 10210.9 15:36:49 INFO - PROCESS | 17956 | -------- Summary: end -------- 15:36:49 INFO - PROCESS | 17956 | 15:36:50 INFO - TEST-INFO | 17956: exit 0 15:36:50 INFO - TEST-OK | dromaeo_css | took 1109572ms 15:36:50 INFO - TEST-START | kraken 15:36:50 INFO - operating with platform_type : linux_ 15:36:50 INFO - Initialising browser for kraken test... 15:36:50 INFO - TEST-INFO | started process 18204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjy23GJ/profile http://localhost:37198/getInfo.html) 15:36:53 INFO - PROCESS | 18204 | 15:36:53 INFO - PROCESS | 18204 | (process:18283): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:36:54 INFO - PROCESS | 18204 | __metrics Screen width/height:1600/1200 15:36:54 INFO - PROCESS | 18204 | colorDepth:24 15:36:54 INFO - PROCESS | 18204 | Browser inner width/height: 1024/697 15:36:54 INFO - PROCESS | 18204 | __metrics 15:36:55 ERROR - PROCESS | 18204 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:36:56 INFO - TEST-INFO | 18204: exit 0 15:36:56 INFO - Browser initialized. 15:36:56 INFO - Running cycle 1/1 for kraken test... 15:36:56 INFO - TEST-INFO | started process 18334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjy23GJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:58 INFO - PROCESS | 18334 | 15:36:58 INFO - PROCESS | 18334 | (process:18400): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:37:08 INFO - PROCESS | 18334 | RSS: Main: 150896640 15:37:08 INFO - PROCESS | 18334 | 15:37:10 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:11 INFO - PROCESS | 18334 | RSS: Main: 156495872 15:37:11 INFO - PROCESS | 18334 | 15:37:13 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-dft) 15:37:14 INFO - PROCESS | 18334 | RSS: Main: 156286976 15:37:14 INFO - PROCESS | 18334 | 15:37:17 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-fft) 15:37:17 INFO - PROCESS | 18334 | RSS: Main: 156741632 15:37:17 INFO - PROCESS | 18334 | 15:37:19 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37198/tests/kraken/driver.html?testName=audio-oscillator) 15:37:20 INFO - PROCESS | 18334 | RSS: Main: 157044736 15:37:20 INFO - PROCESS | 18334 | 15:37:22 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37198/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:23 INFO - PROCESS | 18334 | RSS: Main: 156905472 15:37:23 INFO - PROCESS | 18334 | 15:37:26 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37198/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:26 INFO - PROCESS | 18334 | RSS: Main: 156884992 15:37:26 INFO - PROCESS | 18334 | 15:37:30 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37198/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:30 INFO - PROCESS | 18334 | RSS: Main: 157089792 15:37:30 INFO - PROCESS | 18334 | 15:37:33 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37198/tests/kraken/driver.html?testName=json-parse-financial) 15:37:34 INFO - PROCESS | 18334 | RSS: Main: 157073408 15:37:34 INFO - PROCESS | 18334 | 15:37:35 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37198/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:36 INFO - PROCESS | 18334 | RSS: Main: 156938240 15:37:36 INFO - PROCESS | 18334 | 15:37:38 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:38 INFO - PROCESS | 18334 | RSS: Main: 156860416 15:37:38 INFO - PROCESS | 18334 | 15:37:40 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:41 INFO - PROCESS | 18334 | RSS: Main: 157540352 15:37:41 INFO - PROCESS | 18334 | 15:37:43 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:44 INFO - PROCESS | 18334 | RSS: Main: 157597696 15:37:44 INFO - PROCESS | 18334 | 15:37:47 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:47 INFO - PROCESS | 18334 | RSS: Main: 157671424 15:37:47 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | Cycle 1(1): loaded http://localhost:37198/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37198/tests/kraken/driver.html?testName=ai-astar) 15:37:49 INFO - PROCESS | 18334 | RSS: Main: 159330304 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | __start_tp_report 15:37:49 INFO - PROCESS | 18334 | _x_x_mozilla_page_load 15:37:49 INFO - PROCESS | 18334 | _x_x_mozilla_page_load_details 15:37:49 INFO - PROCESS | 18334 | |i|pagename|runs| 15:37:49 INFO - PROCESS | 18334 | |0;ai-astar;111;106;111;108;110;120;111;109;109;109 15:37:49 INFO - PROCESS | 18334 | |1;audio-beat-detection;168;127;153;165;128;157;155;132;176;129 15:37:49 INFO - PROCESS | 18334 | |2;audio-dft;163;161;163;162;173;163;162;162;163;162 15:37:49 INFO - PROCESS | 18334 | |3;audio-fft;76;74;75;165;74;77;78;78;158;77 15:37:49 INFO - PROCESS | 18334 | |4;audio-oscillator;92;94;139;93;93;92;147;93;92;131 15:37:49 INFO - PROCESS | 18334 | |5;imaging-gaussian-blur;117;118;117;117;119;117;118;117;117;118 15:37:49 INFO - PROCESS | 18334 | |6;imaging-darkroom;147;147;147;147;147;147;147;146;147;147 15:37:49 INFO - PROCESS | 18334 | |7;imaging-desaturate;97;97;97;97;97;96;96;97;96;97 15:37:49 INFO - PROCESS | 18334 | |8;json-parse-financial;56;58;57;57;56;58;60;63;55;54 15:37:49 INFO - PROCESS | 18334 | |9;json-stringify-tinderbox;66;65;64;65;64;65;64;64;65;65 15:37:49 INFO - PROCESS | 18334 | |10;stanford-crypto-aes;86;79;81;87;81;87;79;79;79;78 15:37:49 INFO - PROCESS | 18334 | |11;stanford-crypto-ccm;120;129;124;115;132;126;122;118;115;115 15:37:49 INFO - PROCESS | 18334 | |12;stanford-crypto-pbkdf2;136;144;150;143;140;144;142;147;142;144 15:37:49 INFO - PROCESS | 18334 | |13;stanford-crypto-sha256-iterative;68;67;68;66;67;73;66;69;65;66 15:37:49 INFO - PROCESS | 18334 | __end_tp_report 15:37:49 INFO - PROCESS | 18334 | __start_cc_report 15:37:49 INFO - PROCESS | 18334 | _x_x_mozilla_cycle_collect,823 15:37:49 INFO - PROCESS | 18334 | __end_cc_report 15:37:49 INFO - PROCESS | 18334 | __startTimestamp1461191869639__endTimestamp 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | ------- Summary: start ------- 15:37:49 INFO - PROCESS | 18334 | Number of tests: 14 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:3.72 (3.4%) stddev-sans-first:3.94 15:37:49 INFO - PROCESS | 18334 | Values: 111.0 106.0 111.0 108.0 110.0 120.0 111.0 109.0 109.0 109.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:156.00 stddev:18.49 (11.9%) stddev-sans-first:18.29 15:37:49 INFO - PROCESS | 18334 | Values: 168.0 127.0 153.0 165.0 128.0 157.0 155.0 132.0 176.0 129.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:3.44 (2.1%) stddev-sans-first:3.64 15:37:49 INFO - PROCESS | 18334 | Values: 163.0 161.0 163.0 162.0 173.0 163.0 162.0 162.0 163.0 162.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.50 stddev:36.06 (47.1%) stddev-sans-first:37.71 15:37:49 INFO - PROCESS | 18334 | Values: 76.0 74.0 75.0 165.0 74.0 77.0 78.0 78.0 158.0 77.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#4] audio-oscillator Cycles:10 Average:106.60 Median:92.50 stddev:22.68 (24.5%) stddev-sans-first:23.43 15:37:49 INFO - PROCESS | 18334 | Values: 92.0 94.0 139.0 93.0 93.0 92.0 147.0 93.0 92.0 131.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 15:37:49 INFO - PROCESS | 18334 | Values: 117.0 118.0 117.0 117.0 119.0 117.0 118.0 117.0 117.0 118.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 15:37:49 INFO - PROCESS | 18334 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:37:49 INFO - PROCESS | 18334 | Values: 97.0 97.0 97.0 97.0 97.0 96.0 96.0 97.0 96.0 97.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:2.59 (4.5%) stddev-sans-first:2.70 15:37:49 INFO - PROCESS | 18334 | Values: 56.0 58.0 57.0 57.0 56.0 58.0 60.0 63.0 55.0 54.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 15:37:49 INFO - PROCESS | 18334 | Values: 66.0 65.0 64.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:3.63 (4.5%) stddev-sans-first:3.48 15:37:49 INFO - PROCESS | 18334 | Values: 86.0 79.0 81.0 87.0 81.0 87.0 79.0 79.0 79.0 78.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:123.00 stddev:6.10 (5.0%) stddev-sans-first:6.44 15:37:49 INFO - PROCESS | 18334 | Values: 120.0 129.0 124.0 115.0 132.0 126.0 122.0 118.0 115.0 115.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.00 stddev:3.77 (2.6%) stddev-sans-first:2.96 15:37:49 INFO - PROCESS | 18334 | Values: 136.0 144.0 150.0 143.0 140.0 144.0 142.0 147.0 142.0 144.0 15:37:49 INFO - PROCESS | 18334 | 15:37:49 INFO - PROCESS | 18334 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:2.27 (3.4%) stddev-sans-first:2.40 15:37:49 INFO - PROCESS | 18334 | Values: 68.0 67.0 68.0 66.0 67.0 73.0 66.0 69.0 65.0 66.0 15:37:49 INFO - PROCESS | 18334 | -------- Summary: end -------- 15:37:49 INFO - PROCESS | 18334 | 15:37:50 INFO - TEST-INFO | 18334: exit 0 15:37:50 INFO - TEST-OK | kraken | took 60072ms 15:37:50 INFO - SUITE-END | took 1169s 15:37:50 INFO - Completed test suite (00:19:29) 15:37:50 INFO - javascript benchmark 15:37:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3352.6814952579502, 3438.4670376091713, 3441.879534216302, 3473.565804274466, 3487.860485580575, 5642.576806739501, 5649.6327738696955, 5659.9999999999945, 5671.659700417978, 5693.715314234288, 5636.7181640918, 5655.915161272574, 5674.0, 5675.318961724599, 5675.978323901706, 5071.087204303224, 5164.845054648366, 5203.895922081556, 5226.033183860979, 5245.239440281157, 5154.046501397234, 5252.789888404459, 5292.867678308035, 5315.202719592073, 5321.3348331458565, 5230.2416149658275, 5245.370555533342, 5284.682919024852, 5321.494458026481, 5345.946540534604, 5208.531232189102, 5253.212018197282, 5287.233351164098, 5292.100342941709, 5304.602154838402, 4992.975035124801, 5030.220315851049, 5136.974315128437, 5151.7166555839785, 5256.132738098209, 5464.617476776627, 5466.781328746845, 5494.36814766303, 5495.642783219078, 5496.7526461309335, 6076.422739839708, 6094.0, 6109.755609775648, 6111.572189946705, 6136.969315153396, 6008.429199226067, 6074.42292982166, 6157.199564056688, 6175.44421002112, 6200.069989501566, 5796.710164491758, 5815.447532484407, 5818.534517238695, 5823.4467725566, 5824.213731146326, 6054.0, 6352.904706429407, 6369.394907483782, 6369.777057802955, 6370.235571731422, 5992.161097446361, 6059.030555111161, 6060.484858786965, 6066.787662431793, 6101.603395779349, 6105.297890742621, 6106.694665266719, 6108.816735497942, 6112.449879510777, 6113.816585502442, 5819.359870414251, 6064.211652485149, 6070.544709146831, 6079.696015199311, 6128.63228206309, 6098.512119030467, 6133.579501509479, 6145.784897528654, 6146.016637338004, 6159.045347971071, 4637.443506779208, 4646.140464014168, 4658.068386322749, 4678.602318802872, 4698.671093023524, 4073.551909289976, 4098.631123198927, 4141.937870931938, 4170.436991006236, 4200.663946884242, 5667.858303542444, 5702.7433765480655, 5703.401142879938, 5732.398098199712, 5778.855528611818, 6182.814515564541, 6213.782517611862, 6215.782447614311, 6233.875322493615, 6245.250569931637, 5835.037218858841, 5842.8539286517325, 5850.23946886902, 5854.297484301911, 5893.616914900518, 5088.516590923857, 5272.710000949908, 5320.920186197211, 5338.91991620126, 5382.085045542267, 6191.1641928339095, 6223.066540019034, 6223.937760622426, 6237.438630523275, 6245.0632405139595, 5953.374895635896, 6151.876962460815, 6157.661328626789, 6158.630482171084, 6171.382861713792, 6199.659018754011, 6250.687465626791, 6335.873282534231, 6346.2067241594805, 6359.236891572856, 6055.303640081271, 6061.212042434456, 6061.605995610271, 6080.331163572092, 6135.969320153549, 5961.523078153824, 6195.96902015487, 6233.283172435046, 6241.375862413723, 6248.312685604489, 5939.316978547349, 6000.459958603747, 6003.0695242237525, 6020.307664618625, 6039.184710064085, 6024.096385542204, 6049.727762250797, 6050.273967123973, 6051.334353221054, 6054.969725151346, 5782.537397008314, 5876.911846322223, 5904.439078287728, 5934.0, 5939.406059394026, 6016.308124565731, 6070.575059745775, 6082.574219804571, 6094.055421409688, 6096.207493025879, 5889.263842019747, 5925.140854576149, 5941.732622032106, 5946.702664866826, 5948.583599148018], "unit": "score", "name": "dojo.html", "value": 5647.719708753414}, {"lowerIsBetter": false, "replicates": [546.7293689623637, 555.1791629027402, 571.4085921071689, 572.5019233267058, 588.4615576747276, 41014.58985410145, 41180.58819411805, 41538.79230603843, 41639.58360416395, 41744.0, 43892.56107438933, 44468.55531444684, 44543.554564454345, 44592.77703611486, 44675.32987005189, 8959.328050396214, 9125.178733913946, 9130.497822619753, 9136.543172841364, 9157.038510956354, 8892.15524525169, 9103.317251206154, 9138.0405057469, 9320.953395233048, 9332.346735728503, 9352.532373381338, 9363.0, 9396.060393960617, 9409.388389754678, 9445.149936505713, 9261.212796912238, 9391.436513809193, 9393.953030234874, 9424.717258482257, 9429.339946203769, 9283.675071372469, 9405.106514881076, 9428.340016198868, 9439.103285187895, 9454.0, 44863.551364486266, 44888.326675099575, 44934.101317973786, 45117.548824511665, 45222.547774522165, 3055.526393409003, 3725.962740372616, 3890.455336252927, 3937.03542632057, 4022.3966405039187, 29145.70854291451, 29469.70530294691, 29787.0, 29818.701812982028, 30340.54489182664, 4166.500019997589, 4230.9365359519325, 4249.660027197817, 4250.681198910094, 4268.231718290706, 209476.0, 211677.0, 212252.99999999846, 212538.0, 213392.0, 47857.52142478531, 57760.0, 58091.0, 58507.41492585105, 58568.0, 46072.0, 46143.538564614595, 46308.3053754194, 46325.0, 46408.76795616068, 14369.0, 14440.350184241524, 14464.421423143167, 14505.274736263145, 14520.927395363167, 12864.935675321563, 12871.356432178354, 12916.612501624966, 12974.35128243584, 12983.35083245834, 15524.456644017631, 15653.60865978337, 15863.444779432664, 15949.362025518849, 16032.438864639682, 6006.279246490361, 6228.906566401508, 6258.0, 6287.465565426898, 6399.9040014399825, 977.1059480575336, 1012.7063151686076, 1097.6926460591046, 1111.216592302425, 1153.7058050197313, 29942.0, 30349.393012139633, 30762.84618576893, 30832.53751193734, 30883.691163088082, 1129.3224065560598, 1159.5187996981326, 1195.2768575012167, 1204.6988252936767, 1250.687328167958, 15731.0, 15820.525384238492, 15853.0, 15911.522654320388, 16108.033517988959, 369738.0, 373478.0, 375373.0, 375497.0, 376768.0, 60240.39759602348, 60708.392916070276, 60848.0, 60969.39030609637, 61067.69466152641, 1500.167407089076, 1503.7142942840826, 1513.9856296281298, 1530.4413888930683, 1536.8078990126235, 30266.638001289553, 30433.0, 30599.847000764854, 30604.234894126934, 30692.386152277275, 52738.736306319755, 53304.0, 53416.73291633517, 53423.732881335345, 53588.0, 352908.0, 353582.0, 354640.0, 356069.0, 356740.0, 36349.27301454009, 37038.0, 51862.740686296325, 53349.0, 53356.0, 48665.27002094901, 50568.0, 56798.43201568097, 57476.9858166661, 58544.414555853895, 41618.58381416268, 41947.37078943879, 41975.58024419717, 42535.3619695711, 42575.787121065434, 40212.0, 44690.3296450547, 44981.0, 46062.30906536338, 46092.769536152104, 44513.332300016176, 44986.55013449823, 45987.0, 46466.30300545427, 46839.765801172136, 39080.218395632495, 39506.40740388954, 39622.80188599038, 40312.3953140709, 40747.796261018506, 30918.0, 30931.84534077315, 30936.69063309338, 30987.84506077455, 31286.217844554067], "unit": "score", "name": "ext.html", "value": 19832.241556250836}, {"lowerIsBetter": false, "replicates": [390.1358490942562, 395.7922090902276, 397.7136461747541, 399.6582921602031, 406.1288536090087, 14694.0, 17626.11869406531, 17814.10929453527, 18449.0, 18517.16672749726, 16881.83118168818, 17123.571910702238, 17313.39403120891, 17356.0, 17401.73897391537, 5551.72241387931, 5594.272744543204, 5736.942630573682, 5755.107958266475, 5825.533957283407, 5642.943570564283, 5687.943120568803, 5690.630109042899, 5718.885622287552, 5720.742566584514, 5673.177389278552, 5685.118806584966, 5695.45893140151, 5698.059820129673, 5709.257796486451, 5607.663540187581, 5742.511886489653, 5750.511206547449, 5753.367129615739, 5753.884922301551, 5165.0, 5166.199239117943, 5180.766865491062, 5193.039287731782, 5206.557442617382, 12447.564335248313, 19092.904535477373, 19211.80788192114, 19951.80048199514, 20010.299639512694, 2204.393791707277, 2206.4594174427207, 2255.0754190781863, 2395.149721848736, 2912.37383962447, 9866.60533578656, 10025.548850301753, 10109.03964123407, 10186.59253629854, 10216.284860059799, 1903.6287923854854, 1931.3723040011912, 1944.0765636322774, 2017.1931227508967, 2027.3309807763403, 64514.677426612565, 67897.0, 68277.0, 68558.0, 68888.0, 10423.114035307084, 10568.418736969541, 10816.351018938889, 10854.565817367216, 11475.081993440504, 13243.470261189444, 14047.438102475786, 15212.847871521142, 15276.465323713617, 15279.312430940412, 6372.808815735535, 6401.64790936503, 7339.376153026946, 7756.224377562198, 7923.603819808986, 7445.292697193758, 7525.247475252431, 7536.171021187665, 7572.8485430292185, 7697.076350837935, 4627.722336659811, 4664.976675116671, 4748.548887855648, 4776.522347765195, 4816.975915120402, 1933.8162874526897, 1955.5724321245286, 2001.9499512512011, 2019.3739940618455, 2047.5393036566952, 920.6133423961952, 995.2933417273672, 1025.4565080507343, 1030.891756365571, 1075.499892549968, 16790.916045419694, 16881.15594220284, 16926.23831927566, 17196.0, 17606.823931760773, 1009.258195226508, 1024.7233247023412, 1026.8870424253325, 1027.7225149209671, 1081.1458947431597, 9747.707568772807, 9806.65676701312, 9951.0, 10152.187824973984, 10258.230632702576, 466156.0, 468254.0, 478589.0, 480586.0, 481833.0, 77468.0, 77993.22006779973, 78802.60598696969, 79289.60355198187, 81743.59128204321, 1084.3006260961636, 1113.9944300278446, 1115.6151127860876, 1117.0839911272678, 1119.904808091305, 15888.682226355639, 16033.67932641364, 16192.433264835674, 16213.432529861399, 16516.50450486487, 25757.0, 30774.076777696704, 36616.81691591525, 36798.63201368059, 37720.811395942845, 50800.23799642934, 50814.23778643397, 50949.74525127499, 50981.23528147155, 51346.0, 7773.883391749016, 8385.413021088709, 8503.149685031447, 8749.0, 8786.912130878609, 12708.237505749685, 12842.101052926206, 12871.678208044874, 13008.47966081384, 13042.54351097707, 10169.288149829441, 10427.733994333117, 10450.47747612601, 10484.423356715453, 10588.629397971034, 11485.19603627738, 11540.711482213012, 11541.653750387502, 12033.398330083635, 12093.455794489446, 10565.366078035342, 10703.0, 10846.0, 10990.505427255634, 11094.667159985212, 8589.8711519326, 8793.692220772242, 8812.91187088121, 8950.194482496607, 8958.955205223932, 8188.754337369888, 10337.586496540054, 10763.784724305626, 10764.677059688222, 10942.17933654963], "unit": "score", "name": "jquery.html", "value": 8750.7259748748}, {"lowerIsBetter": false, "replicates": [1584.239565008796, 1597.3051722500713, 1865.4590168851034, 1925.1048262557908, 1984.1765667248092, 7454.329110380065, 8109.148539403366, 8325.125861784516, 8523.659053637846, 8525.744227673173, 8317.043539992903, 8317.209865062825, 8401.243888050074, 8423.326133909288, 8452.661893524251, 2352.282553821088, 2393.114547617375, 2400.8919598618104, 2401.7838394544488, 2409.180878501309, 2379.2267513058237, 2388.7850093491584, 2426.8422552534116, 2436.902523899042, 2439.9268021959283, 2413.746556611557, 2416.6979127609047, 2438.366024833538, 2476.319012271622, 2478.2317481580676, 2433.0997530913673, 2443.3769388805918, 2449.081594402099, 2464.2114523352534, 2465.0755966512556, 2428.3564855313357, 2434.42790944128, 2437.8293519453646, 2443.816713746476, 2454.3250606083293, 8566.057733649293, 8582.44214126086, 8634.395592308541, 8638.265747411477, 8646.178613031752, 5003.199488081926, 5201.063808514466, 5210.739463026872, 5224.451432599561, 5250.18622113573, 3253.2192273854102, 3268.7058164765285, 3304.289577740797, 3312.8840490582957, 3344.4314466540745, 1060.1412855586923, 1130.711668524521, 1131.0894729742554, 1139.3790384240608, 1142.0863309352485, 11949.522019119226, 12041.458134383975, 12047.21693089955, 12050.457729402198, 12069.336186509738, 4487.349334346502, 4499.370088187657, 4623.745693986796, 4625.583697467244, 4647.9767601161775, 10037.69886903394, 10057.14514266281, 10072.345297555636, 10128.240381971382, 10129.493525323704, 5130.127878260705, 5144.125498665236, 5159.25190847325, 5165.535101840853, 5167.767450464738, 4158.542560318362, 4693.436787585511, 4704.482506924235, 4727.196376615983, 4804.471508134103, 3835.175437280998, 3890.9416358754643, 3912.6087391260644, 3926.8232929517667, 3968.523777146761, 1203.6750077479032, 1224.993875030637, 1246.7942789439642, 1247.3638444393425, 1253.260576260011, 1453.1716921354937, 1468.9853101469062, 1472.8158980127484, 1473.3369983507464, 1496.895217334798, 8090.393220508486, 8143.063547691972, 8143.796405089802, 8147.144549822302, 8161.959190204011, 553.2641586689693, 563.1580786723874, 565.2284631478003, 569.9800506982235, 576.2163457697528, 6009.819705408845, 6114.2357205349335, 6137.956547386955, 6143.877122457526, 6254.937450625435, 10340.482975851177, 10587.894121058845, 10703.19726020536, 10732.570697172026, 10742.301750386356, 10319.1744660427, 10506.579736810594, 10576.206784491194, 10588.0, 10599.417032063311, 8210.671573137128, 8231.259186673227, 8232.094469608339, 8244.464109832841, 8302.958485207657, 7833.647485863035, 7913.010873640795, 7926.167752386147, 7935.722249721232, 7989.081255655674, 9276.886773587214, 9347.065293470598, 9486.95256523713, 9505.619775208914, 9539.904600953902, 9536.713898583053, 9714.708558743248, 9717.319787614799, 9857.950710246403, 9883.851742224017, 6626.734930602722, 7111.715531378687, 7358.337749602561, 7637.770866874002, 7683.423743219169, 7950.920490795018, 7966.402519810921, 7976.361891048586, 8024.719134830253, 8031.518108913484, 7045.823854403681, 7253.528520646141, 7259.564426134449, 7329.1937886833475, 7353.926460735538, 6949.0, 6968.686409111703, 7115.644217789193, 7223.855522889407, 7276.017737605355, 7402.29678180572, 7504.174540800398, 7504.662290197063, 7513.549187048795, 7526.02161718973, 6609.504287178384, 6614.8346291343105, 6635.9004614929845, 6672.899906501503, 6680.966595166993, 6927.0, 6961.686724097326, 6963.2340442552295, 6982.301769822977, 6991.300869912968], "unit": "score", "name": "mootools.html", "value": 4792.566358039603}, {"lowerIsBetter": false, "replicates": [367.6727712336021, 373.2646686028523, 374.08162959933367, 381.1462324393356, 383.9961600383995, 6412.679366031697, 6468.547201695877, 6507.804765857026, 6527.379898909596, 6545.803625891219, 6405.007223880294, 6405.871882562357, 6410.871782564346, 6411.358864113587, 6421.7752378666755, 4730.479647238801, 4821.590164835993, 4852.805887764485, 4859.781309841065, 4986.376702912136, 4850.248211527219, 4857.805687772502, 4860.076585448771, 4889.973105647819, 4900.58345040672, 4828.541288577597, 4830.589399900995, 4838.080764654722, 4839.104765618355, 4841.661083724141, 4823.807047718087, 4832.975835120819, 4845.781939812717, 4860.684055536414, 4873.756312184377, 4215.662746980234, 4222.0, 4226.281532139513, 4230.17511585241, 4230.746155230696, 6023.186869772612, 6143.846403839895, 6159.414855588712, 6161.04503801907, 6162.630242185483, 5726.169705392695, 5737.483626473638, 5740.913886291667, 5740.942590574125, 5753.165790960329, 6739.191297044337, 6768.424683901874, 6805.693743781541, 6829.214640316378, 6857.759978400732, 4749.4063242094735, 4749.7387643679585, 4752.239641657353, 4753.073150735608, 4761.690490118166, 7040.507164498487, 7097.858042839166, 7099.680514376865, 7118.07465029548, 7134.393576545948, 4662.370579971661, 4779.330893674888, 4865.245886887538, 4889.217725164028, 4893.584045356113, 4854.101991131652, 4871.902561948741, 4874.390701162355, 4890.193118135468, 4907.190313598217, 5628.887422251532, 5634.0, 5655.208270842086, 5666.036773748473, 5666.150077488327, 6848.452123830081, 6916.1700595927805, 6922.342377474132, 6928.515003949776, 6930.549514281555, 1723.8448539631493, 1737.7219644856762, 1748.9593691753387, 1754.877158598886, 1756.481837857835, 1116.3700996544974, 1145.7593905279984, 1149.4137989625185, 1159.7390587117832, 1163.6036755892962, 6491.383318584727, 6498.187726534184, 6508.9023664645065, 6518.543701940914, 6541.28045914949, 6953.443724502028, 6998.930010699828, 7016.859662806715, 7021.29787021304, 7026.754063607749, 6421.229452465641, 6498.090267362573, 6529.804105876831, 6561.40947314744, 6581.670916454158, 3801.752886062397, 3859.6526312632, 3862.942055869108, 3866.516685414323, 3873.2447172801035, 7303.0, 7337.559746415125, 7350.4119670426235, 7375.225601311892, 7379.188289288174, 7290.088738907637, 7293.9635301823155, 7306.415486761046, 7311.780646580611, 7340.4127669786285, 7144.714211431588, 7315.597642129734, 7359.521631093961, 7396.297351751575, 7406.703731850774, 7056.329648683367, 7073.434125270069, 7088.645567721696, 7114.217436081924, 7142.214356420894, 6952.44380449573, 6979.4765392594745, 7029.19164296092, 7032.542884712478, 7034.683439245348, 7304.086989126359, 7325.230850760593, 7344.339009489172, 7363.337299642843, 7364.3372096511575, 4633.30500424939, 4761.500042495488, 4797.592204662643, 4820.060088282891, 4881.487443818348, 7005.859882802417, 7014.649267536704, 7030.0, 7040.331168538981, 7065.046218760402, 6718.966405167943, 6810.897836532356, 6839.760608378683, 6845.5550389224545, 6853.074834897225, 6830.0, 6854.280300568368, 6910.44716422695, 6933.479989000744, 6964.756233531802, 6548.541602087998, 6684.16447944007, 6715.597064176165, 6779.559328643622, 6782.830429239111, 6877.518573699793, 6914.55055421396, 6927.792166235021, 6937.618430986344, 6942.826429339307, 6685.197776266879, 6703.597784132968, 6711.429528489938, 6725.058491811248, 6732.225794033553], "unit": "score", "name": "prototype.html", "value": 5156.0378288172}, {"lowerIsBetter": false, "replicates": [775.6083177995112, 786.0763602766751, 795.824918517926, 881.8060026794107, 883.6730409748392, 14954.177520236397, 15217.543473695807, 15234.6953060939, 15246.542603721879, 15286.464973725922, 14380.49668261611, 14400.135991840498, 14433.566992990201, 14453.78319325211, 14514.782278265808, 892.9687460938868, 911.9908800912006, 913.7258822353301, 914.07221670005, 915.4919019943961, 939.4363381970797, 942.006183476432, 943.556528431636, 944.4286206844863, 945.2438049560359, 986.2997271936897, 986.960521579136, 991.2169386184905, 992.3252188511809, 1001.0990108901974, 971.4268581536892, 972.8978457262027, 974.7027156717198, 978.0122076702511, 980.3137803537552, 729.0158286313488, 732.8717474442004, 733.0323972356491, 733.4645708632728, 735.6505659811601, 15674.608134796606, 15770.0, 15780.0, 15820.525384238375, 15881.602959925978, 14060.789088163685, 14137.0, 14141.575752727333, 14142.08076475036, 14165.858341416557, 11096.778064438748, 11428.542858285658, 11534.307941523535, 11830.053595712323, 11924.880751192464, 3872.9031774205587, 3902.551206611219, 3909.257241124177, 3991.1219531702977, 4065.024394145413, 49934.500654993346, 50102.0, 50604.493955060716, 50758.746206268734, 53045.469545304826, 11212.10303175744, 11233.269837460539, 11438.199326047263, 11464.828027579426, 11523.48144333507, 19647.41057768269, 19805.801941980684, 19916.302929397403, 19924.90037549803, 19929.10319035647, 8098.797530061795, 8387.161283871565, 8396.370272229486, 8482.363822713321, 8543.231109200202, 4419.469663640384, 4572.0, 4590.908181836411, 4610.423697037871, 4881.292212629149, 3538.6992105671306, 3580.98209508956, 3589.6051434342203, 3594.8022858742497, 3598.946015809765, 644.7421031587403, 658.6542065415695, 666.4368608525788, 673.5823789250696, 682.3347236444426, 607.5625549604366, 679.8436359637311, 686.50228584276, 698.4098436820879, 703.8486725353971, 7879.487833290817, 7891.960540197377, 8044.678212871537, 8064.153263907206, 8134.674613015532, 645.4384685323798, 662.9403353698191, 670.6244503078194, 674.9122614060141, 696.20632478974, 3701.1857391373856, 3716.312482190803, 3799.5820459749407, 3835.961640383616, 3909.139989202371, 62515.37484625186, 64961.67519162374, 65681.34318656848, 65947.67026164838, 66328.0, 53861.0, 54984.725076375165, 55965.0, 56809.7159514208, 56867.14699279514, 46187.0, 49652.25521617178, 51668.0, 51905.48094519082, 52087.218691718896, 8239.0, 8247.752567422987, 8369.748907532783, 8578.099299573705, 8672.869906951275, 37784.86645400643, 37821.62178378181, 38036.0, 38141.237175256894, 38672.0, 49963.25055124249, 50177.0, 50258.748706256236, 50856.74571627118, 51417.742911285204, 11771.823422648496, 11935.283882967049, 12320.876791231973, 12543.3101179436, 12617.432215550505, 12961.351932403153, 13065.216087034809, 13103.803442948172, 13185.274809885548, 13341.799873002106, 11287.0, 11306.717332066764, 11319.773604528027, 11375.26060806045, 11484.655460336204, 11168.274062185932, 11386.43067846621, 11402.144839136932, 11493.252938558968, 11752.764944700886, 11001.394923279297, 11102.722431939266, 11309.886901131213, 11338.036266917405, 11492.138089643144, 10444.216683748597, 10764.892351076389, 10885.074768644754, 10909.781804364027, 11138.3873886937, 9671.129598336183, 9790.846013876935, 9796.9020309796, 10114.342567733074, 10210.897891020995], "unit": "score", "name": "yui.html", "value": 6851.076685113884}], "name": "dromaeo_css", "value": 7413.009170904863}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 108.0, 110.0, 120.0, 111.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [168.0, 127.0, 153.0, 165.0, 128.0, 157.0, 155.0, 132.0, 176.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 163.0, 162.0, 173.0, 163.0, 162.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 75.0, 165.0, 74.0, 77.0, 78.0, 78.0, 158.0, 77.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 139.0, 93.0, 93.0, 92.0, 147.0, 93.0, 92.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0, 117.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 57.0, 57.0, 56.0, 58.0, 60.0, 63.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [86.0, 79.0, 81.0, 87.0, 81.0, 87.0, 79.0, 79.0, 79.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.6}, {"lowerIsBetter": true, "replicates": [120.0, 129.0, 124.0, 115.0, 132.0, 126.0, 122.0, 118.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [136.0, 144.0, 150.0, 143.0, 140.0, 144.0, 142.0, 147.0, 142.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 66.0, 67.0, 73.0, 66.0, 69.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1519.7}]} 15:37:50 INFO - Return code: 0 15:37:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:37:50 ERROR - # TBPL SUCCESS # 15:37:50 INFO - Running post-action listener: _resource_record_post_action 15:37:50 INFO - Running post-run listener: _resource_record_post_run 15:37:51 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500416512; Read time: 296; Write time: 460492 15:37:51 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 251400192; Read time: 0; Write time: 274244 15:37:52 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249016320; Read time: 296; Write time: 186248 15:37:52 INFO - Running post-run listener: _upload_blobber_files 15:37:52 INFO - Blob upload gear active. 15:37:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:52 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 15:37:52 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'] 15:37:52 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 15:37:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:53 INFO - (blobuploader) - INFO - Done attempting. 15:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:53 INFO - (blobuploader) - INFO - Done attempting. 15:37:53 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:53 INFO - Return code: 0 15:37:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fce876d6d79b5f8a07eebed8bcfdaa56e8d1a6c30f77781b8e8fb3b20358d1c207bcd2844884ae9f7b832ea3bb7ea8b1a73cafaffaf290e5968de7af962c191c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426bdc4b74eaa0cef4d25a740b3de98f253f276c70d411830082d93b8c3306f227f1653bb82bf2c8d95fa54e22d1e988cabd2cc031218f06a332e1394df7a543"} 15:37:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:53 INFO - Contents: 15:37:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fce876d6d79b5f8a07eebed8bcfdaa56e8d1a6c30f77781b8e8fb3b20358d1c207bcd2844884ae9f7b832ea3bb7ea8b1a73cafaffaf290e5968de7af962c191c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426bdc4b74eaa0cef4d25a740b3de98f253f276c70d411830082d93b8c3306f227f1653bb82bf2c8d95fa54e22d1e988cabd2cc031218f06a332e1394df7a543"} 15:37:53 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:53 INFO - Copying logs to upload dir... 15:37:53 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.412081 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-04-20 15:37:53.538960) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:53.542772) ========= 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=0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803 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/fce876d6d79b5f8a07eebed8bcfdaa56e8d1a6c30f77781b8e8fb3b20358d1c207bcd2844884ae9f7b832ea3bb7ea8b1a73cafaffaf290e5968de7af962c191c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426bdc4b74eaa0cef4d25a740b3de98f253f276c70d411830082d93b8c3306f227f1653bb82bf2c8d95fa54e22d1e988cabd2cc031218f06a332e1394df7a543"} build_url:https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/A84jzeqiSAmDJLoDUrfqHA/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/fce876d6d79b5f8a07eebed8bcfdaa56e8d1a6c30f77781b8e8fb3b20358d1c207bcd2844884ae9f7b832ea3bb7ea8b1a73cafaffaf290e5968de7af962c191c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/426bdc4b74eaa0cef4d25a740b3de98f253f276c70d411830082d93b8c3306f227f1653bb82bf2c8d95fa54e22d1e988cabd2cc031218f06a332e1394df7a543"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:53.568066) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:53.568438) ========= 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=0333a256a5e4f052382dd180000001b1-1461190438.370145-1037047803 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:37:53.654230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:37:53.654570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:37:53.654893) ========= ========= Total master_lag: 0.17 =========