builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1468424528.96 results: success (0) buildid: 20160713055926 builduid: a17a4545e083444193b0f0066652e7b1 revision: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:08.956443) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:08.956999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:08.957309) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:08.972227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:08.972577) ========= 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=826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 08:42:09-- 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% 67.2M=0s 2016-07-13 08:42:09 (67.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081946 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:09.068599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:09.068932) ========= 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=826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014619 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:09.122333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 08:42:09.122718) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3e019c07ecb8b1f1668d469e64eafa126bb72ceb --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-beta --rev 3e019c07ecb8b1f1668d469e64eafa126bb72ceb --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=826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 08:42:09,878 truncating revision to first 12 chars 2016-07-13 08:42:09,878 Setting DEBUG logging. 2016-07-13 08:42:09,878 attempt 1/10 2016-07-13 08:42:09,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3e019c07ecb8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 08:42:11,242 unpacking tar archive at: mozilla-beta-3e019c07ecb8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.710993 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 08:42:10.848786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:10.849276) ========= script_repo_revision: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:10.849936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:10.850369) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 08:42:10.860457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-13 08:42:10.860735) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:11 INFO - MultiFileLogger online at 20160713 08:42:11 in /builds/slave/test 08:42:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:42:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:11 INFO - {'append_to_log': False, 08:42:11 INFO - 'base_work_dir': '/builds/slave/test', 08:42:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:42:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:11 INFO - 'branch': 'Mozilla-Beta', 08:42:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:11 INFO - 'config_files': ('talos/linux_config.py',), 08:42:11 INFO - 'default_actions': ('clobber', 08:42:11 INFO - 'read-buildbot-config', 08:42:11 INFO - 'download-and-extract', 08:42:11 INFO - 'populate-webroot', 08:42:11 INFO - 'create-virtualenv', 08:42:11 INFO - 'install', 08:42:11 INFO - 'run-tests'), 08:42:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:11 INFO - 'download_minidump_stackwalk': True, 08:42:11 INFO - 'download_symbols': 'ondemand', 08:42:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:11 INFO - 'installer_path': 'installer.exe', 08:42:11 INFO - 'log_level': 'info', 08:42:11 INFO - 'log_name': 'talos', 08:42:11 INFO - 'log_to_console': True, 08:42:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:11 INFO - 'opt_config_files': (), 08:42:11 INFO - 'pip_index': False, 08:42:11 INFO - 'sps_profile': False, 08:42:11 INFO - 'sps_profile_interval': 0, 08:42:11 INFO - 'suite': 'dromaeojs', 08:42:11 INFO - 'system_bits': '32', 08:42:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:11 INFO - 'title': 'talos-linux64-ix-052', 08:42:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:11 INFO - 'use_talos_json': True, 08:42:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:11 INFO - 'work_dir': 'build'} 08:42:11 INFO - ##### 08:42:11 INFO - ##### Running clobber step. 08:42:11 INFO - ##### 08:42:11 INFO - Running pre-action listener: _resource_record_pre_action 08:42:11 INFO - Running main action method: clobber 08:42:11 INFO - rmtree: /builds/slave/test/build 08:42:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:12 INFO - Running post-action listener: _resource_record_post_action 08:42:12 INFO - ##### 08:42:12 INFO - ##### Running read-buildbot-config step. 08:42:12 INFO - ##### 08:42:12 INFO - Running pre-action listener: _resource_record_pre_action 08:42:12 INFO - Running main action method: read_buildbot_config 08:42:12 INFO - Using buildbot properties: 08:42:12 INFO - { 08:42:12 INFO - "project": "", 08:42:12 INFO - "product": "firefox", 08:42:12 INFO - "script_repo_revision": "production", 08:42:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:42:12 INFO - "repository": "", 08:42:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:42:12 INFO - "buildid": "20160713055926", 08:42:12 INFO - "pgo_build": "True", 08:42:12 INFO - "basedir": "/builds/slave/test", 08:42:12 INFO - "buildnumber": 165, 08:42:12 INFO - "slavename": "talos-linux64-ix-052", 08:42:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:12 INFO - "platform": "ubuntu64_hw", 08:42:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:42:12 INFO - "branch": "mozilla-beta", 08:42:12 INFO - "repo_path": "releases/mozilla-beta", 08:42:12 INFO - "revision": "3e019c07ecb8b1f1668d469e64eafa126bb72ceb", 08:42:12 INFO - "stage_platform": "linux64-pgo", 08:42:12 INFO - "builduid": "a17a4545e083444193b0f0066652e7b1", 08:42:12 INFO - "slavebuilddir": "test" 08:42:12 INFO - } 08:42:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 08:42:12 INFO - Running post-action listener: _resource_record_post_action 08:42:12 INFO - ##### 08:42:12 INFO - ##### Running download-and-extract step. 08:42:12 INFO - ##### 08:42:12 INFO - Running pre-action listener: _resource_record_pre_action 08:42:12 INFO - Running main action method: download_and_extract 08:42:12 INFO - mkdir: /builds/slave/test/build/tests 08:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:12 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:42:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:42:13 INFO - Downloaded 1327 bytes. 08:42:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 08:42:13 INFO - Using the following test package requirements: 08:42:13 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:42:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:13 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 08:42:13 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'jsshell-linux-x86_64.zip'], 08:42:13 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:13 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 08:42:13 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 08:42:13 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 08:42:13 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:13 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:13 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')]} 08:42:13 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:21 INFO - Downloaded 24237901 bytes. 08:42:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:22 INFO - Return code: 0 08:42:22 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:22 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 08:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:26 INFO - Downloaded 24237901 bytes. 08:42:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:27 INFO - Return code: 0 08:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:27 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:42:27 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - Running command: ['nslookup', u'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 08:42:27 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 08:42:27 INFO - Server: 10.26.75.40 08:42:27 INFO - Address: 10.26.75.40#53 08:42:27 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 08:42:27 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 08:42:27 INFO - Address: 10.26.48.46 08:42:27 INFO - Return code: 0 08:42:27 INFO - retry: attempt #1 caught exception: 08:42:27 INFO - retry: Failed, sleeping 30 seconds before retrying 08:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 08:42:58 INFO - Downloaded 10840145 bytes. 08:42:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:42:59 INFO - Return code: 0 08:42:59 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')]} 08:42:59 INFO - https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:42:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:43:00 INFO - Downloaded 56030297 bytes. 08:43:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:43:00 INFO - mkdir: /builds/slave/test/properties 08:43:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:00 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:00 INFO - Contents: 08:43:00 INFO - build_url:https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 08:43:01 INFO - Running post-action listener: _resource_record_post_action 08:43:01 INFO - Running post-action listener: set_extra_try_arguments 08:43:01 INFO - ##### 08:43:01 INFO - ##### Running populate-webroot step. 08:43:01 INFO - ##### 08:43:01 INFO - Running pre-action listener: _resource_record_pre_action 08:43:01 INFO - Running main action method: populate_webroot 08:43:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:01 INFO - '--tppagecycles', 08:43:01 INFO - '7'], 08:43:01 INFO - 'tests': ['tsvgm']}}, 08:43:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['damp', 'tps']}, 08:43:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'tests': ['damp', 'tps']}, 08:43:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['dromaeo_dom']}, 08:43:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['a11yr', 08:43:01 INFO - 'ts_paint', 08:43:01 INFO - 'tpaint', 08:43:01 INFO - 'sessionrestore', 08:43:01 INFO - 'sessionrestore_no_auto_restore', 08:43:01 INFO - 'tabpaint']}, 08:43:01 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:01 INFO - 'ts_paint', 08:43:01 INFO - 'tpaint', 08:43:01 INFO - 'sessionrestore', 08:43:01 INFO - 'sessionrestore_no_auto_restore', 08:43:01 INFO - 'tabpaint']}, 08:43:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:01 INFO - 'ts_paint', 08:43:01 INFO - 'tpaint', 08:43:01 INFO - 'sessionrestore', 08:43:01 INFO - 'sessionrestore_no_auto_restore', 08:43:01 INFO - 'tabpaint']}, 08:43:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:01 INFO - 'ts_paint', 08:43:01 INFO - 'tpaint', 08:43:01 INFO - 'sessionrestore', 08:43:01 INFO - 'sessionrestore_no_auto_restore', 08:43:01 INFO - 'tabpaint']}, 08:43:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['a11yr', 08:43:01 INFO - 'ts_paint', 08:43:01 INFO - 'tpaint', 08:43:01 INFO - 'sessionrestore', 08:43:01 INFO - 'sessionrestore_no_auto_restore', 08:43:01 INFO - 'tabpaint']}, 08:43:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['a11yr', 08:43:01 INFO - 'ts_paint', 08:43:01 INFO - 'tpaint', 08:43:01 INFO - 'sessionrestore', 08:43:01 INFO - 'sessionrestore_no_auto_restore', 08:43:01 INFO - 'tabpaint']}, 08:43:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['tsvgx', 08:43:01 INFO - 'tsvgr_opacity', 08:43:01 INFO - 'tart', 08:43:01 INFO - 'tscrollx', 08:43:01 INFO - 'cart']}, 08:43:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:01 INFO - 'tsvgr_opacity', 08:43:01 INFO - 'tart', 08:43:01 INFO - 'tscrollx', 08:43:01 INFO - 'cart']}, 08:43:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'talos_options': ['--disable-e10s'], 08:43:01 INFO - 'tests': ['tp5o']}, 08:43:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'tests': ['tp5o']}, 08:43:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'talos_options': ['--disable-e10s', 08:43:01 INFO - '--xperf_path', 08:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:01 INFO - 'tests': ['tp5n']}, 08:43:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:01 INFO - 'talos_options': ['--xperf_path', 08:43:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:01 INFO - 'tests': ['tp5n']}}, 08:43:01 INFO - 'talos.zip': {'path': '', 08:43:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:01 INFO - Running post-action listener: _resource_record_post_action 08:43:01 INFO - ##### 08:43:01 INFO - ##### Running create-virtualenv step. 08:43:01 INFO - ##### 08:43:01 INFO - Running pre-action listener: _resource_record_pre_action 08:43:01 INFO - Running main action method: create_virtualenv 08:43:01 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:01 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 08:43:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:01 INFO - Using real prefix '/usr' 08:43:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:03 INFO - Installing pip.................done. 08:43:03 INFO - Return code: 0 08:43:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:43:03 INFO - Using env: {'DISPLAY': ':0', 08:43:03 INFO - 'HOME': '/home/cltbld', 08:43:03 INFO - 'LANG': 'en_US.UTF-8', 08:43:03 INFO - 'LANGUAGE': 'en_US:en', 08:43:03 INFO - 'LOGNAME': 'cltbld', 08:43:03 INFO - 'MAIL': '/var/mail/cltbld', 08:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:03 INFO - 'MOZ_NO_REMOTE': '1', 08:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:03 INFO - 'NO_EM_RESTART': '1', 08:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:03 INFO - 'PWD': '/builds/slave/test', 08:43:03 INFO - 'SHELL': '/bin/bash', 08:43:03 INFO - 'SHLVL': '1', 08:43:03 INFO - 'TERM': 'linux', 08:43:03 INFO - 'TMOUT': '86400', 08:43:03 INFO - 'USER': 'cltbld', 08:43:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:03 INFO - '_': '/tools/buildbot/bin/python'} 08:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:04 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 08:43:04 INFO - Cleaning up... 08:43:04 INFO - Return code: 0 08:43:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:43:04 INFO - Using env: {'DISPLAY': ':0', 08:43:04 INFO - 'HOME': '/home/cltbld', 08:43:04 INFO - 'LANG': 'en_US.UTF-8', 08:43:04 INFO - 'LANGUAGE': 'en_US:en', 08:43:04 INFO - 'LOGNAME': 'cltbld', 08:43:04 INFO - 'MAIL': '/var/mail/cltbld', 08:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:04 INFO - 'MOZ_NO_REMOTE': '1', 08:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:04 INFO - 'NO_EM_RESTART': '1', 08:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:04 INFO - 'PWD': '/builds/slave/test', 08:43:04 INFO - 'SHELL': '/bin/bash', 08:43:04 INFO - 'SHLVL': '1', 08:43:04 INFO - 'TERM': 'linux', 08:43:04 INFO - 'TMOUT': '86400', 08:43:04 INFO - 'USER': 'cltbld', 08:43:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:04 INFO - '_': '/tools/buildbot/bin/python'} 08:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:04 INFO - Downloading/unpacking psutil>=0.7.1 08:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:06 INFO - Installing collected packages: psutil 08:43:06 INFO - Running setup.py install for psutil 08:43:06 INFO - building 'psutil._psutil_linux' extension 08:43:06 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 08:43:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:43:06 INFO - building 'psutil._psutil_posix' extension 08:43:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:43:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:06 INFO - Successfully installed psutil 08:43:06 INFO - Cleaning up... 08:43:06 INFO - Return code: 0 08:43:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:43:06 INFO - Using env: {'DISPLAY': ':0', 08:43:06 INFO - 'HOME': '/home/cltbld', 08:43:06 INFO - 'LANG': 'en_US.UTF-8', 08:43:06 INFO - 'LANGUAGE': 'en_US:en', 08:43:06 INFO - 'LOGNAME': 'cltbld', 08:43:06 INFO - 'MAIL': '/var/mail/cltbld', 08:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:06 INFO - 'MOZ_NO_REMOTE': '1', 08:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:06 INFO - 'NO_EM_RESTART': '1', 08:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:06 INFO - 'PWD': '/builds/slave/test', 08:43:06 INFO - 'SHELL': '/bin/bash', 08:43:06 INFO - 'SHLVL': '1', 08:43:06 INFO - 'TERM': 'linux', 08:43:06 INFO - 'TMOUT': '86400', 08:43:06 INFO - 'USER': 'cltbld', 08:43:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:06 INFO - '_': '/tools/buildbot/bin/python'} 08:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:43:07 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 08:43:07 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 08:43:07 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 08:43:07 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 08:43:07 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 08:43:07 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 08:43:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:43:08 INFO - Installing collected packages: mozsystemmonitor 08:43:08 INFO - Running setup.py install for mozsystemmonitor 08:43:09 INFO - Successfully installed mozsystemmonitor 08:43:09 INFO - Cleaning up... 08:43:09 INFO - Return code: 0 08:43:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:09 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')]} 08:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 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')]} 08:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:09 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 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:09 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 08:43:09 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 08:43:09 INFO - Using env: {'DISPLAY': ':0', 08:43:09 INFO - 'HOME': '/home/cltbld', 08:43:09 INFO - 'LANG': 'en_US.UTF-8', 08:43:09 INFO - 'LANGUAGE': 'en_US:en', 08:43:09 INFO - 'LOGNAME': 'cltbld', 08:43:09 INFO - 'MAIL': '/var/mail/cltbld', 08:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:09 INFO - 'MOZ_NO_REMOTE': '1', 08:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:09 INFO - 'NO_EM_RESTART': '1', 08:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:09 INFO - 'PWD': '/builds/slave/test', 08:43:09 INFO - 'SHELL': '/bin/bash', 08:43:09 INFO - 'SHLVL': '1', 08:43:09 INFO - 'TERM': 'linux', 08:43:09 INFO - 'TMOUT': '86400', 08:43:09 INFO - 'USER': 'cltbld', 08:43:09 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:09 INFO - '_': '/tools/buildbot/bin/python'} 08:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:09 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:11 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:11 INFO - Downloading docopt-0.6.1.tar.gz 08:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:12 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:12 INFO - Running setup.py install for blobuploader 08:43:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:12 INFO - Running setup.py install for requests 08:43:12 INFO - Running setup.py install for docopt 08:43:12 INFO - Successfully installed blobuploader requests docopt 08:43:12 INFO - Cleaning up... 08:43:12 INFO - Return code: 0 08:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:43:12 INFO - Using env: {'DISPLAY': ':0', 08:43:12 INFO - 'HOME': '/home/cltbld', 08:43:12 INFO - 'LANG': 'en_US.UTF-8', 08:43:12 INFO - 'LANGUAGE': 'en_US:en', 08:43:12 INFO - 'LOGNAME': 'cltbld', 08:43:12 INFO - 'MAIL': '/var/mail/cltbld', 08:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:12 INFO - 'MOZ_NO_REMOTE': '1', 08:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:12 INFO - 'NO_EM_RESTART': '1', 08:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:12 INFO - 'PWD': '/builds/slave/test', 08:43:12 INFO - 'SHELL': '/bin/bash', 08:43:12 INFO - 'SHLVL': '1', 08:43:12 INFO - 'TERM': 'linux', 08:43:12 INFO - 'TMOUT': '86400', 08:43:12 INFO - 'USER': 'cltbld', 08:43:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:12 INFO - '_': '/tools/buildbot/bin/python'} 08:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:12 INFO - Running setup.py (path:/tmp/pip-3Y5cPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:12 INFO - Running setup.py (path:/tmp/pip-nf_R2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:12 INFO - Running setup.py (path:/tmp/pip-Cb5H33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:13 INFO - Running setup.py (path:/tmp/pip-Hy1ORL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:13 INFO - Running setup.py (path:/tmp/pip-WxQ29Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:13 INFO - Running setup.py (path:/tmp/pip-uzTAkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:13 INFO - Running setup.py (path:/tmp/pip-vjDK29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:13 INFO - Running setup.py (path:/tmp/pip-pcJp96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:13 INFO - Running setup.py (path:/tmp/pip-9lqYG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:13 INFO - Running setup.py (path:/tmp/pip-owp6PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:13 INFO - Running setup.py (path:/tmp/pip-tpmaVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:13 INFO - Running setup.py (path:/tmp/pip-KZtRGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:13 INFO - Running setup.py (path:/tmp/pip-m0Z8r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:13 INFO - Running setup.py (path:/tmp/pip-NlZu4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:13 INFO - Running setup.py (path:/tmp/pip-6Js1tF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:13 INFO - Running setup.py (path:/tmp/pip-GXCAgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:13 INFO - Running setup.py (path:/tmp/pip-WnTqnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:14 INFO - Running setup.py install for manifestparser 08:43:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Running setup.py install for mozcrash 08:43:14 INFO - Running setup.py install for mozdebug 08:43:14 INFO - Running setup.py install for mozdevice 08:43:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Running setup.py install for mozfile 08:43:14 INFO - Running setup.py install for mozhttpd 08:43:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Running setup.py install for mozinfo 08:43:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Running setup.py install for mozInstall 08:43:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:14 INFO - Running setup.py install for mozleak 08:43:14 INFO - Running setup.py install for mozlog 08:43:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:15 INFO - Running setup.py install for moznetwork 08:43:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:15 INFO - Running setup.py install for mozprocess 08:43:15 INFO - Running setup.py install for mozprofile 08:43:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:15 INFO - Running setup.py install for mozrunner 08:43:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:15 INFO - Running setup.py install for mozscreenshot 08:43:15 INFO - Running setup.py install for moztest 08:43:15 INFO - Running setup.py install for mozversion 08:43:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:15 INFO - Cleaning up... 08:43:15 INFO - Return code: 0 08:43:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:43:15 INFO - Using env: {'DISPLAY': ':0', 08:43:15 INFO - 'HOME': '/home/cltbld', 08:43:15 INFO - 'LANG': 'en_US.UTF-8', 08:43:15 INFO - 'LANGUAGE': 'en_US:en', 08:43:15 INFO - 'LOGNAME': 'cltbld', 08:43:15 INFO - 'MAIL': '/var/mail/cltbld', 08:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:15 INFO - 'MOZ_NO_REMOTE': '1', 08:43:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:15 INFO - 'NO_EM_RESTART': '1', 08:43:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:15 INFO - 'PWD': '/builds/slave/test', 08:43:15 INFO - 'SHELL': '/bin/bash', 08:43:15 INFO - 'SHLVL': '1', 08:43:15 INFO - 'TERM': 'linux', 08:43:15 INFO - 'TMOUT': '86400', 08:43:15 INFO - 'USER': 'cltbld', 08:43:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:15 INFO - '_': '/tools/buildbot/bin/python'} 08:43:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:16 INFO - Running setup.py (path:/tmp/pip-WN3_WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:16 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)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:16 INFO - Running setup.py (path:/tmp/pip-cS8kVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:16 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)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:16 INFO - Running setup.py (path:/tmp/pip-E_WvF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:16 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)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:16 INFO - Running setup.py (path:/tmp/pip-IZpFgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:16 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)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:16 INFO - Running setup.py (path:/tmp/pip-2NxBc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:16 INFO - Running setup.py (path:/tmp/pip-7k1vOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:16 INFO - Running setup.py (path:/tmp/pip-_rAcIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:16 INFO - Running setup.py (path:/tmp/pip-PiwhFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:16 INFO - Running setup.py (path:/tmp/pip-JOI2lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:16 INFO - Running setup.py (path:/tmp/pip-v6l22B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:16 INFO - Running setup.py (path:/tmp/pip-Bd4ZPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:16 INFO - Running setup.py (path:/tmp/pip-qFxnq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:43:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:16 INFO - Running setup.py (path:/tmp/pip-0nusP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:17 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)) 08:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:17 INFO - Running setup.py (path:/tmp/pip-tciEyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:17 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)) 08:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:17 INFO - Running setup.py (path:/tmp/pip-44crJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:17 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)) 08:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:17 INFO - Running setup.py (path:/tmp/pip-TRA74r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:17 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)) 08:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:17 INFO - Running setup.py (path:/tmp/pip-3wi3ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:17 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)) 08:43:17 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)) 08:43:17 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)) 08:43:17 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)) 08:43:17 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)) 08:43:17 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)) 08:43:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:17 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 08:43:17 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 08:43:17 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 08:43:17 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 08:43:17 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 08:43:17 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 08:43:19 INFO - Downloading blessings-1.6.tar.gz 08:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:19 INFO - Installing collected packages: blessings 08:43:19 INFO - Running setup.py install for blessings 08:43:19 INFO - Successfully installed blessings 08:43:19 INFO - Cleaning up... 08:43:19 INFO - Return code: 0 08:43:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:19 INFO - Reading from file tmpfile_stdout 08:43:19 INFO - Current package versions: 08:43:19 INFO - argparse == 1.2.1 08:43:19 INFO - blessings == 1.6 08:43:19 INFO - blobuploader == 1.2.4 08:43:19 INFO - docopt == 0.6.1 08:43:19 INFO - manifestparser == 1.1 08:43:19 INFO - mozInstall == 1.12 08:43:19 INFO - mozcrash == 0.17 08:43:19 INFO - mozdebug == 0.1 08:43:19 INFO - mozdevice == 0.48 08:43:19 INFO - mozfile == 1.2 08:43:19 INFO - mozhttpd == 0.7 08:43:19 INFO - mozinfo == 0.9 08:43:19 INFO - mozleak == 0.1 08:43:19 INFO - mozlog == 3.1 08:43:19 INFO - moznetwork == 0.27 08:43:19 INFO - mozprocess == 0.22 08:43:19 INFO - mozprofile == 0.28 08:43:19 INFO - mozrunner == 6.11 08:43:19 INFO - mozscreenshot == 0.1 08:43:19 INFO - mozsystemmonitor == 0.0 08:43:19 INFO - moztest == 0.7 08:43:19 INFO - mozversion == 1.4 08:43:19 INFO - psutil == 3.1.1 08:43:19 INFO - requests == 1.2.3 08:43:19 INFO - wsgiref == 0.1.2 08:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:43:19 INFO - Using env: {'DISPLAY': ':0', 08:43:19 INFO - 'HOME': '/home/cltbld', 08:43:19 INFO - 'LANG': 'en_US.UTF-8', 08:43:19 INFO - 'LANGUAGE': 'en_US:en', 08:43:19 INFO - 'LOGNAME': 'cltbld', 08:43:19 INFO - 'MAIL': '/var/mail/cltbld', 08:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:19 INFO - 'MOZ_NO_REMOTE': '1', 08:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:19 INFO - 'NO_EM_RESTART': '1', 08:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:19 INFO - 'PWD': '/builds/slave/test', 08:43:19 INFO - 'SHELL': '/bin/bash', 08:43:19 INFO - 'SHLVL': '1', 08:43:19 INFO - 'TERM': 'linux', 08:43:19 INFO - 'TMOUT': '86400', 08:43:19 INFO - 'USER': 'cltbld', 08:43:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:19 INFO - '_': '/tools/buildbot/bin/python'} 08:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:19 INFO - Cleaning up... 08:43:19 INFO - Return code: 0 08:43:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:43:19 INFO - Using env: {'DISPLAY': ':0', 08:43:19 INFO - 'HOME': '/home/cltbld', 08:43:19 INFO - 'LANG': 'en_US.UTF-8', 08:43:19 INFO - 'LANGUAGE': 'en_US:en', 08:43:19 INFO - 'LOGNAME': 'cltbld', 08:43:19 INFO - 'MAIL': '/var/mail/cltbld', 08:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:19 INFO - 'MOZ_NO_REMOTE': '1', 08:43:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:19 INFO - 'NO_EM_RESTART': '1', 08:43:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:19 INFO - 'PWD': '/builds/slave/test', 08:43:19 INFO - 'SHELL': '/bin/bash', 08:43:19 INFO - 'SHLVL': '1', 08:43:19 INFO - 'TERM': 'linux', 08:43:19 INFO - 'TMOUT': '86400', 08:43:19 INFO - 'USER': 'cltbld', 08:43:19 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:19 INFO - '_': '/tools/buildbot/bin/python'} 08:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:20 INFO - Downloading/unpacking jsonschema 08:43:20 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 08:43:20 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 08:43:20 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 08:43:20 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 08:43:20 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 08:43:20 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 08:43:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:22 INFO - Downloading/unpacking functools32 (from jsonschema) 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:22 INFO - warning: no files found matching '*.txt' 08:43:22 INFO - no previously-included directories found matching 'build' 08:43:22 INFO - no previously-included directories found matching 'dist' 08:43:22 INFO - no previously-included directories found matching '.git*' 08:43:22 INFO - Installing collected packages: jsonschema, functools32 08:43:22 INFO - Running setup.py install for functools32 08:43:22 INFO - warning: no files found matching '*.txt' 08:43:22 INFO - no previously-included directories found matching 'build' 08:43:22 INFO - no previously-included directories found matching 'dist' 08:43:22 INFO - no previously-included directories found matching '.git*' 08:43:22 INFO - Successfully installed jsonschema functools32 08:43:22 INFO - Cleaning up... 08:43:22 INFO - Return code: 0 08:43:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb79f9af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25d37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, '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': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', '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 08:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:43:22 INFO - Using env: {'DISPLAY': ':0', 08:43:22 INFO - 'HOME': '/home/cltbld', 08:43:22 INFO - 'LANG': 'en_US.UTF-8', 08:43:22 INFO - 'LANGUAGE': 'en_US:en', 08:43:22 INFO - 'LOGNAME': 'cltbld', 08:43:22 INFO - 'MAIL': '/var/mail/cltbld', 08:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:22 INFO - 'MOZ_NO_REMOTE': '1', 08:43:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:22 INFO - 'NO_EM_RESTART': '1', 08:43:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:22 INFO - 'PWD': '/builds/slave/test', 08:43:22 INFO - 'SHELL': '/bin/bash', 08:43:22 INFO - 'SHLVL': '1', 08:43:22 INFO - 'TERM': 'linux', 08:43:22 INFO - 'TMOUT': '86400', 08:43:22 INFO - 'USER': 'cltbld', 08:43:22 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:22 INFO - '_': '/tools/buildbot/bin/python'} 08:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:22 INFO - Downloading/unpacking flake8 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:43:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:43:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 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 08:43:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:25 INFO - no previously-included directories found matching 'docs/_build' 08:43:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:43:25 INFO - Running setup.py install for pep8 08:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:25 INFO - no previously-included directories found matching 'docs/_build' 08:43:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:43:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:43:25 INFO - Cleaning up... 08:43:25 INFO - Return code: 0 08:43:25 INFO - Running post-action listener: _resource_record_post_action 08:43:25 INFO - Running post-action listener: _start_resource_monitoring 08:43:25 INFO - Starting resource monitoring. 08:43:25 INFO - ##### 08:43:25 INFO - ##### Running install step. 08:43:25 INFO - ##### 08:43:25 INFO - Running pre-action listener: _resource_record_pre_action 08:43:25 INFO - Running main action method: install 08:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:25 INFO - Reading from file tmpfile_stdout 08:43:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:25 INFO - Reading from file tmpfile_stdout 08:43:25 INFO - Output received: 08:43:25 INFO - Usage: mozinstall [options] installer 08:43:25 INFO - Options: 08:43:25 INFO - -h, --help show this help message and exit 08:43:25 INFO - -d DEST, --destination=DEST 08:43:25 INFO - Directory to install application into. [default: 08:43:25 INFO - "/builds/slave/test"] 08:43:25 INFO - --app=APP Application being installed. [default: firefox] 08:43:25 INFO - mkdir: /builds/slave/test/build/application 08:43:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:43:39 INFO - Reading from file tmpfile_stdout 08:43:39 INFO - Output received: 08:43:39 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:39 INFO - Running post-action listener: _resource_record_post_action 08:43:39 INFO - ##### 08:43:39 INFO - ##### Running run-tests step. 08:43:39 INFO - ##### 08:43:39 INFO - Running pre-action listener: _resource_record_pre_action 08:43:39 INFO - Running main action method: run_tests 08:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:39 INFO - Python 2.7.3 08:43:39 INFO - Return code: 0 08:43:39 INFO - grabbing minidump binary from tooltool 08:43:39 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')]} 08:43:39 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 0x2662640>, '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 0x2663540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26639d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:39 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 08:43:39 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 08:43:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:39 INFO - Return code: 0 08:43:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:43:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:43:40 INFO - Return code: 0 08:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:43:40 INFO - Using env: {'DISPLAY': ':0', 08:43:40 INFO - 'HOME': '/home/cltbld', 08:43:40 INFO - 'LANG': 'en_US.UTF-8', 08:43:40 INFO - 'LANGUAGE': 'en_US:en', 08:43:40 INFO - 'LOGNAME': 'cltbld', 08:43:40 INFO - 'MAIL': '/var/mail/cltbld', 08:43:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:40 INFO - 'MOZ_NO_REMOTE': '1', 08:43:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:40 INFO - 'NO_EM_RESTART': '1', 08:43:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:40 INFO - 'PWD': '/builds/slave/test', 08:43:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:40 INFO - 'SHELL': '/bin/bash', 08:43:40 INFO - 'SHLVL': '1', 08:43:40 INFO - 'TERM': 'linux', 08:43:40 INFO - 'TMOUT': '86400', 08:43:40 INFO - 'USER': 'cltbld', 08:43:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732', 08:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:40 INFO - '_': '/tools/buildbot/bin/python'} 08:43:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:43:40 INFO - mozversion application_buildid: 20160713055926 08:43:40 INFO - mozversion application_changeset: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb 08:43:40 INFO - mozversion application_display_name: Firefox 08:43:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:40 INFO - mozversion application_name: Firefox 08:43:40 INFO - mozversion application_remotingname: firefox 08:43:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:40 INFO - mozversion application_vendor: Mozilla 08:43:40 INFO - mozversion application_version: 48.0 08:43:40 INFO - mozversion platform_buildid: 20160713055926 08:43:40 INFO - mozversion platform_changeset: 3e019c07ecb8b1f1668d469e64eafa126bb72ceb 08:43:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:43:40 INFO - mozversion platform_version: 48.0 08:43:40 INFO - using testdate: 1468424620 08:43:40 INFO - actual date: 1468424620 08:43:40 INFO - starting webserver on 'localhost:46313' 08:43:40 INFO - SUITE-START | Running 2 tests 08:43:40 INFO - TEST-START | dromaeo_css 08:43:40 INFO - operating with platform_type : linux_ 08:43:40 INFO - Initialising browser for dromaeo_css test... 08:43:40 INFO - TEST-INFO | started process 19627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE43hq/profile http://localhost:46313/getInfo.html) 08:43:43 INFO - PROCESS | 19627 | __metrics Screen width/height:1600/1200 08:43:43 INFO - PROCESS | 19627 | colorDepth:24 08:43:43 INFO - PROCESS | 19627 | Browser inner width/height: 1024/697 08:43:43 INFO - PROCESS | 19627 | __metrics 08:43:44 ERROR - PROCESS | 19627 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:43:45 INFO - TEST-INFO | 19627: exit 0 08:43:45 INFO - Browser initialized. 08:43:45 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:45 INFO - TEST-INFO | started process 19718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeE43hq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:57 INFO - PROCESS | 19718 | RSS: Main: 140152832 08:43:57 INFO - PROCESS | 19718 | 08:44:48 INFO - PROCESS | 19718 | 1468424688342 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] 08:46:55 INFO - PROCESS | 19718 | Cycle 1(1): loaded http://localhost:46313/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46313/tests/dromaeo/cssquery-ext.html) 08:46:56 INFO - PROCESS | 19718 | RSS: Main: 240373760 08:46:56 INFO - PROCESS | 19718 | 08:49:59 INFO - PROCESS | 19718 | Cycle 1(1): loaded http://localhost:46313/tests/dromaeo/cssquery-ext.html (next: http://localhost:46313/tests/dromaeo/cssquery-jquery.html) 08:49:59 INFO - PROCESS | 19718 | RSS: Main: 221458432 08:49:59 INFO - PROCESS | 19718 | 08:53:01 INFO - PROCESS | 19718 | Cycle 1(1): loaded http://localhost:46313/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46313/tests/dromaeo/cssquery-mootools.html) 08:53:02 INFO - PROCESS | 19718 | RSS: Main: 214630400 08:53:02 INFO - PROCESS | 19718 | 08:56:03 INFO - PROCESS | 19718 | Cycle 1(1): loaded http://localhost:46313/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46313/tests/dromaeo/cssquery-prototype.html) 08:56:04 INFO - PROCESS | 19718 | RSS: Main: 214859776 08:56:04 INFO - PROCESS | 19718 | 08:59:06 INFO - PROCESS | 19718 | Cycle 1(1): loaded http://localhost:46313/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46313/tests/dromaeo/cssquery-yui.html) 08:59:07 INFO - PROCESS | 19718 | RSS: Main: 213553152 08:59:07 INFO - PROCESS | 19718 | 09:02:09 INFO - PROCESS | 19718 | Cycle 1(1): loaded http://localhost:46313/tests/dromaeo/cssquery-yui.html (next: http://localhost:46313/tests/dromaeo/cssquery-dojo.html) 09:02:10 INFO - PROCESS | 19718 | RSS: Main: 258117632 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | __start_tp_report 09:02:10 INFO - PROCESS | 19718 | _x_x_mozilla_page_load 09:02:10 INFO - PROCESS | 19718 | _x_x_mozilla_page_load_details 09:02:10 INFO - PROCESS | 19718 | |i|pagename|runs| 09:02:10 INFO - PROCESS | 19718 | |0;dojo.html;3216.3245718399135;3277.049655599875;3293.341331733652;3338.3823992561393;3345.7825241359324;5507.091329930562;5519.392866784656;5531.889362212753;5534.308211473561;5539.723013849311;5488.670679759217;5528.419515950827;5531.1426728856995;5542.861428464291;5571.052921003429;4893.41279046515;4965.106280869433;5077.289179514871;5127.9230811537855;5163.870903227412;4929.21132618781;4983.626228032894;5022.522860328281;5033.521815427529;5039.748012599373;4960.3303554020285;5005.899882002358;5027;5035.748212589374;5087.338645976018;5015.673981191211;5042.067217564726;5042.974785126087;5048.040872234301;5067.315912351841;4888;4899.485554016813;4936.210206367;4970.726610036447;4981.9252711209365;5415.512603865671;5454.699991500466;5460.726963651801;5467.015937131315;5476.808311709111;5887.146363777271;5897.498712609433;5897.852553686149;5899.115132730082;5901.173835662968;5521.365043020064;5774.740136693859;5894.4989675877605;5913.852153696149;5945.583809133319;5509.917351239735;5535.446455354472;5555.722213889329;5556.888862222733;5565.193047008162;5864;6043.7280322385595;6045.758169673251;6052.394760523913;6059.969700151559;5818.970905145532;5874.383189765099;5880.2943646761805;5889.823305300848;5910.793122240787;5790.768369265183;5801.50687191585;5803.564732644984;5809.0124678804705;5811.302643682785;5735.340435849931;5775.624584402;5777.45114214149;5778.479936805707;5840.970795145997;5927.970360148258;5932.703364831741;5934.13954976526;5937.614055086492;5958;4539.863804085882;4542.500324964251;4548.249538826057;4550.431196100488;4572.1312950539295;3948.4866967294643;3991.940120898189;4008.07814202735;4069.4099355593867;4116.279651061052;5634.661920284796;5650.067738823048;5652.74562644682;5661.207430959669;5672.546196304285;5974.9402505974385;5981.61119527238;5984.820455386345;5984.850378740479;5994.940050599525;5441.564674826083;5535.723213839292;5634.492895639412;5636.915446268309;5638.069718496402;5092.388913330424;5093.770780314895;5101.234814777738;5103.566196873233;5128.1794912813775;6075.605085669417;6091.51267898567;6096.359882212304;6103.05402662588;6103.450689437972;5816.447437493432;5946.672932988728;5967.343592204854;5985.760569577168;6036;6066.393360663898;6083.908741368795;6097.085437184458;6107.755689772359;6111.541634377529;5873.676947767914;5876.647401155944;5876.882462350814;5880.26496687914;5889.38161493037;5763.366029736641;5910.379410162043;5974.522038236843;5981.3719559445635;6028.849278768066;5697;5707.8858422832145;5712.228849105318;5734.569907256889;5735.426457354231;5679.00617391963;5683.914741278802;5684.602077854511;5692.231548740867;5701.629394089371;5555.2778138841695;5603.943960560506;5631.915521267266;5722.370539240597;5728.942710572841;5779.595428319977;5798.884022319615;5809.2738407699035;5813.854653633693;5820.70896455184;5698.515626171822;5699.401562835843;5703.5722320826935;5704.973104841169;5732.455416735404 09:02:10 INFO - PROCESS | 19718 | |1;ext.html;604.4680681000722;661.7551505942802;664.7839452178042;677.5799004617138;697.9511434199608;32323.191920202007;32984.17539561512;41874.790626046866;42365.15269694604;42377;44227;45302.32046519305;45315;45350.31974520385;45350.77324613381;7614.619269036553;8887.111288871125;9075.273978081737;9079.273658107335;10378.481075946172;10480.842787358195;10642.57429702811;10645.041946224837;10648.14814814813;10651.520681569347;10625.78748425031;10695.518701658444;10705.304155229886;10716.35701857891;10719.35683858967;10560.419176945265;10602.946985265102;10644.361338319686;10645.467726613677;10645.946770266177;10471.10995565378;10583.57665693379;10593.152547796235;10816.188785841015;10849.891501085045;44067.11865762667;44294.33558496593;44432.77783611061;44499.11001779946;44585.77707111444;3750.19370835269;3783.6783873370796;3838.9616103838885;4094.754314741125;4494.5505449454795;31587;31588.052358429282;31888.521672174935;33868.83065584681;33899;4541.568550987651;4548.6133678637025;4586.082783443325;4589.1510070636705;4804.855854324341;291891.54054229805;291894;292349;293938;294624;40119;40901;63841.361586383544;64340.678296609156;64484.35515644877;38220.42669359962;38311.23377532434;38416.42375364372;38429;38446.846594602204;17188.742168867477;17394.47816565505;17413;17415.91292043557;17419.12904354777;11847.644570662895;14812.777808332883;15161.924190379199;15181.316840742193;15182.392704291926;9287;9287.814243715224;9290.210332121711;9345.813083738287;9388.389754665925;3533.7349698772696;3640.12636967126;3657.1771351446246;3671.30245253401;3694.722895782827;1118.7864551191408;1162.3200427749691;1182.640072960869;1247.9625611231677;1275.515304184404;32654.346913061607;33528;33821.32357352839;33824.830875845466;34300.48549271763;1237.4369661803858;1283.7304166125218;1313.848907375645;1331.6071758831167;1357.518081081202;17801.376951806626;17842.01868897223;17864.106794660216;18007.909960450113;18167.818321816878;532400;541079;542386;543080;543796;64871.67564162243;65529.344706553275;65560;65613.34386656072;65796.67101664461;1399.0766094377661;1532.0348180646345;1535.3628244278723;1544.5829626000916;1642.0476123848139;30053.69946300509;31158.844205778827;31315.37369252648;32264.35471290514;32530.349393012482;47389;63254.683726582916;65152.34847651463;65225.347746521926;65266;332068;334873;335686;336603;336996;39925.401118982656;44054.3391849129;48503.75748121237;48581.27128093152;49635.751821240665;47067;47807;48022;48966.26550601672;57164;41389.37915931203;41800.37299440572;42512.57487425086;43584;45416;40986.590134098275;42085.36871946862;42607.57392426036;43081.353779692705;44835;46389.76805115953;47223;47908.5209147918;48056.759716201195;48442.27336590025;39884.40173397459;41804.58195418007;41855.7907210462;41920.32318707217;42422.787886061604;30997.380052398374;31008.22479438032;31227.84386078055;31259.218519537193;31678.683213168497 09:02:10 INFO - PROCESS | 19718 | |2;jquery.html;428.32752578451846;430.7092712419116;431.7754767520887;437.52965562020813;440.30871531695243;18478.538036549093;18822.811771882276;19046.619067618638;19349.322773702923;19866.404007879788;18910.432687019376;19232.230710771553;20249.69625455616;20261.696074558895;20273.898630506865;5696.629719068258;5736;5743.167240750089;5792.710364481759;5896.498797602188;4193.245215861159;5828.795992140276;5835.737391817378;6207.565470417073;6481.995290729945;6439.58142720724;6457.547971641987;6461.450776683988;6466.870662586745;6468.223813142429;5575.916361254584;5814.825555233349;5816.41835816415;5816.825495235129;6415;3801.82891769871;3953.09078911849;5420.159875219348;5664.490195882349;5669.121286200645;13467.057305988585;13491.66270843227;13695.520656777064;13696.794548081787;18561;2409.6265078912797;2456.8034557235555;2495.8128140389545;2553.2850801775535;2986.566947792558;10060.949695251476;10316.226283028727;10351.275410721253;10692.732681682943;10797.892021079768;1946.7858535561077;1977.73300604418;1994.7406837111228;2030.715699802029;2075.5122546201633;73673.6316318415;75679;81427.5928620359;83253.58373208156;83870;11185.272957257752;11287.548498059985;11301.20891537601;11312.434378281054;11469.426528673699;15786.289616967264;15790.447334343244;15900.840991589936;15916.840831591537;15918.204089795696;8563.443376180529;8565.14348565151;8630.82738345242;8650.610722517502;8699.347548933856;8412.8317433651;8533.35999800005;8832.936849049509;8835.469871807712;8982.056884027083;5059.772310246048;5090.185570308733;5101.311322971425;5122.564582010496;5166.5866730661455;1850.1674246589089;2020.3332900142918;2056.4447599148148;2083.812456878888;2108.420184449258;995.576879826071;1089.6839916424308;1118.9552417903355;1141.2923987127867;1150.1661295560818;18776;18802.717959230624;19006.429807105807;19316.42050738452;19538.12078456473;1059.862217911682;1069.5668254356997;1088.9019988200941;1119.5353928119903;1139.47014638192;10503.2122590806;10747.247692661438;10856.837147442795;10862.34825910448;10865.32656353618;512709;513941.17208284343;514023;521056;535188;67588;86672;92077;93951.53024234972;95534;1062.86182796236;1065.6536625596711;1069.4973362519604;1071.8499410082595;1087.342157994418;17026.574335641708;17031.31874724997;17331;17389.565260868578;17432.477025689248;37927;38600.034999125244;39331.80334098311;39496;40503;56676.716616416656;57232.71383643055;57419;57493.42506574881;57573.71213144075;8551.914480855361;8792.560371981503;8826.382153249211;8955.373123881527;9128.817423651622;12596.244225346509;12601.306928119042;12675.746485070431;12843.743125137631;13372.331383430985;11300.773984520429;11329.90396776599;11450.484728187419;11487.597934072268;11549.307041577533;10893.945530272298;11174.944125279322;11260.774784504429;11658.475368608264;11902.880971190523;6369.7452101915405;10404.803447603623;10778.568857245622;11686.474108664961;11902.107341949215;8464.407491475538;8515.276201522693;8761.03628600866;8824.602892869965;8834.160754728548;9624.37441566296;11831.70420739454;11876.524939002344;11911.940440298089;12009.699757506132 09:02:10 INFO - PROCESS | 19718 | |3;mootools.html;1455.1487379882767;1624.309668390934;1626.9674606507874;1863.5900101977568;1941.2041063164106;8218.712345067925;8381.958090209555;8406.411551191419;8414.15858414159;8419.073901870797;8273.420860539765;8345.74962751117;8399.370047246466;8427.073021967593;8445.95777021114;2316.9073237070497;2333.801626861719;2335.532893421314;2337.5091230841545;2339.7192336919593;2315.8610483370967;2332.2536788227776;2372.6559648850907;2380.5357955198742;2386.570417324881;2285.3029825903095;2309.030207312933;2310.1798861404213;2312.398776318161;2322.2104484475276;2353.823463240247;2378.6907701998803;2380.155044959049;2394.988025059872;2395.077895010425;2316.2435381402533;2368.46709490365;2379.3575734551746;2382.0590866607768;2387.5224955008894;7267.600281984489;8154.673813047471;8554.401191916568;8595.656173753105;8602.311815054843;5133.743312834381;5201.531862132426;5238.423773384925;5239.659422137549;5254.894902101974;3333.449980753173;3367.4275373186615;3424.07549961509;3436.347094052122;3456.9654303456896;1068.5031460370888;1077.6874706335154;1086.4241951765578;1092.579356947573;1107.2526044919728;11996;12187.817182742267;12193.085518586142;12203.084768642299;12215.93892030543;4689.202835517902;4694.413198350207;4723.6929599575915;4734.715917044989;4775.450823155312;10583.153347732163;10590.682279531626;10591.788164236672;10596.947015264874;10603.09873660732;5420.295361603045;5448.591355648263;5465.562754979592;5471.37079235885;5472.808451704172;4892.3884514435695;4948.727819969936;4951.207806750903;4956.8760780980765;4958.9504104959215;4009.258287216874;4086.6526345260986;4118.835246590163;4124.793760311973;4126.711130220856;1248.1949142802841;1249.2254802022621;1253.035162924543;1254.1283807753707;1264.0772236267392;892.7054072156172;1052.4316868890712;1056.5351245451977;1057.9471026448646;1060.2419270221828;5971.820845374646;6088.665123418255;6096.664683442365;6124.326324104345;6240.157578726905;942.4251206763869;1072.1637123044038;1084.0839490630406;1102.4212288548576;1201.825735268381;3996.440498330236;4087.2642924273914;4108.589141085868;4161.334186530201;4196.559361267084;10328.845067323997;10669.146468282519;10712;10739.194560408001;10741.140708743282;10334.483275836179;10551.20865935058;10561.788764224673;10572.312799667998;10586.841197382046;8079.878801817978;8212.63043163059;8292.212239837207;8318.875216871751;8344.62449189788;5755.395683453177;5822.592418530662;5835.9708201458725;5839.182514447895;5865.178874957594;9542.85685714701;9589.808203835744;9628.518574071128;9760.951195244263;9771.951140244537;9734.123928846439;9791.167750740982;9819.803603928025;9827.85258221113;9925.801483970135;6906.930930690629;7066.823329416806;7071.681774320271;7102.289771022856;7456.552606843607;8133.959330203311;8167.305779008613;8211.71259005932;8221.958890205511;8243.711470098518;7113;7228.421726261781;7286.307800758919;7358.11702595692;7368.668409921674;7112.6096693583695;7198.460115491254;7232.204457509775;7297.416206703557;7310;6895.931040689529;6918.481113916376;6948.548344357803;6948.826279343057;6956.965215173892;4423.646108311392;4897.240927656219;5091.796328146833;5115.974420127875;5240.842774716764;5392.137258038695;5418.701971391612;5425.864353391197;5442.102053161184;5479.232907393048 09:02:10 INFO - PROCESS | 19718 | |4;prototype.html;340.56577863224385;342.31878561662285;342.53073289593254;342.55467891740744;342.61626977784886;6152.876942461154;6170.0436432353;6176.567640265172;6219.813405597828;6225.813225603228;6091.573589848713;6186.907196392058;6202.06968954657;6203.348648391921;6213.316535181138;4454.754988475633;4530.682852200347;4538.500764915857;4615.676902616801;4735.6921800083055;4705;4728.645351598627;4735.242361222206;4738.834140805073;4749.881252968687;4693.507181745918;4700.942287985193;4701.553352431531;4701.764911754416;4705.741184234866;4409.757463339531;4508.2336002879265;4555.772211389451;4672.486026537078;4695.225287827504;4110.835566577333;4111.773852438115;4119.290494444802;4125.66994640428;4140.3168477201225;5930.614510056833;5967.194428752106;5973.551983601204;5978.8505287367725;5992.161097446361;5427.538659213971;5431.51116399522;5431.967926094069;5435.402105768362;5454.509094181503;6496.5127615428555;6505.772297969548;6506.3818937200895;6507.3167317431935;6519.282878883367;4322.113966636832;4443.200223959686;4465.82136714531;4546.499655113805;4553.2942393929;6745.628990405526;6785.8642827143185;6795.694193761293;6797.898031529531;6818.181818181801;4531.184386810406;4537.8411755588395;4543.25036369002;4550.840720574764;4551.112533056088;4572.908541829145;4585.403897493371;4596.10375976688;4596.333531637893;4600.447946246405;5296.152615581488;5300;5300.09898317287;5310.707911064851;5376.731163441812;6372.171617689671;6481.638855840326;6486.254080780676;6490.707918143695;6520.347965203537;1587.0636324568559;1594.0913679202974;1603.9518814435585;1605.5986003499124;1610.62955520231;1040.1210976724656;1047.8428235764695;1058.692979036071;1061.0132576703586;1065.6909496246;6159.1069294951985;6217.720202590895;6355;6370.713317900706;6413.903791443132;6821.761238356634;6825.69284382204;6830.214525329551;6901.689423975933;6913.89629155563;6397.904031439532;6416.165898433267;6416.486681065504;6421.101045853584;6421.775237866652;3645.8906232813056;3681.208540163878;3681.963180368162;3689.262147570497;3690.372636651776;6798.354156355138;6939.965300173568;6957.2694867038235;6958.65206739661;6981.89527157093;6884.896726549106;6891.552049116792;6901.896471552931;6911.447084233249;6914.239433662293;6946.861062778716;6948.33990770876;6958.234594194634;6964.79105626832;6967.163940327193;6791;6799.524033317621;6802.693878775368;6818.590884546943;6819.727210911508;6491.091247225487;6652.866942661217;6704.631245281556;6723.495737819585;6751.696173672099;6956.373926346653;6958.756443524452;6968.268331825086;6971.407430368476;6971.930280697331;4586.656000799887;4588.908221835612;4591.081783643352;4596.379488769107;4596.563326483979;6812.455003599799;6813.829654258485;6833.4191593715095;6835.658217089026;6836.863262734618;6418.1656384669695;6618.139641846529;6629.502787290876;6632.469402447696;6633.336666333328;6533.052707357501;6538.248101468392;6546.738130474728;6557.475401967736;6571.638559879252;6501.577397469149;6513.446357059703;6519.641419721961;6539.051837483634;6539.640319782267;6665.166854143232;6667.533272670867;6676.732930682719;6677.998300255001;6682.398584127257;6388.621261633642;6464.062710906798;6484.157059582224;6493.610383376824;6504.512161587994 09:02:10 INFO - PROCESS | 19718 | |5;yui.html;839.7816567692398;865.8614621660536;910.5447276361818;931.0922198649569;947.2658689515624;13804.378802953866;13976.650583735387;13996.300184990761;14008.159510429381;14022.509212177563;12780.61658150257;12890.613281601567;12893.74212515749;12895.613131606044;12906.161099528525;716.0941409117471;902.3322741171519;909.9363044586881;915.922146617535;924.089771574998;921.8663293822425;925.3892430995544;926.0276709455079;926.6802952981211;926.9026752191024;964.2045312617084;964.7105868239535;965.0205041882494;965.2133511188359;965.9178969787577;755.391909512842;959.1799011844877;964.5996911281844;980.9607615695363;981.2444417798256;719.989200161998;723.3273056057864;723.7937187901475;723.9095113110861;724.7173602295109;13446.865531344756;13472.461101555926;13499;13550;13580.253086080262;14305.499307524291;14630.341634626468;14632.634184145376;14915.105093694414;15134.848651513454;12229.571964981184;12253.007511346303;12253.448594813255;12255.75488490234;12373.876261237363;3977.7215594908366;4003.8598649047435;4021.577734337882;4057.57395473474;4147.979260103711;57984.420155798325;58129;58377.124343134885;58761;58945.705271473795;11577.942110289394;11679.649610511698;11840.88159118415;12364.319962401974;12521.74956500865;20864.687029694567;21090;21124.577508450053;21125;21137.89431052835;8093.919060809317;8305.086440491541;8380.916190838136;8414;8898.555072246361;4905.901881962341;5019.372578427697;5044.192929131322;5065;5068.873278168076;3485.233248685285;3550.680438760524;3606.8737594184076;3610.7472476926887;3612.078919875415;614.121805817685;619.1146660275849;717.3185473799911;720.4524561333319;721.1778572427437;659.8383396067994;674.3020973292619;758.6017340895963;762.5272331154608;767.9577623230776;8694.478331300015;9355.90644093564;9456.385334953206;9577.569009394454;9696.854547181798;648.3516483516484;701.2987012987013;722.9349358557755;756.580098045579;775.2673723331397;4452.109578084396;4476.529964353761;4514.954850451453;4527.501974782771;4599.172149013143;65148.34851651423;65455.345446544925;65490.672546637914;65561.67219163873;65800;57833.421665783644;58822;59802.40197598055;59885.10172347418;59986.400135998956;51664.22503662448;52419.73790131025;53096.203556946675;53873.730631347375;54426;9038.819223615359;9082.40964337316;9249.30630202751;9261.305402094735;9273.907260927304;39733.2053358937;39943.60056399515;40462;40973.79513102535;41362.37956430596;47196;47215;52184.47815521796;52403.475965241385;52719.472805271456;11505.827412588986;11518.251313664585;11596.942015290208;11631;11873.940630296793;11780.52877884875;11897.583584574499;12000.15998880105;12020.63938081859;12096.395180241128;12247;12455.93772031134;12612.49550017989;12635.684107897008;12646.557370491988;11687.649370518899;11821.290722556674;11821.645350639494;11866.703332416759;11895.643130706092;11968.581099661471;12170.208936419105;12342.691432714253;12388.690282743004;12417.937910310391;10306.33008854422;10333.121684656888;10504.632337868137;10619.893801062199;10854.457277135954;9855.950720246354;10357.792844143225;10365.844512332473;10378.636747713794;10413.895861041292 09:02:10 INFO - PROCESS | 19718 | __end_tp_report 09:02:10 INFO - PROCESS | 19718 | __start_cc_report 09:02:10 INFO - PROCESS | 19718 | _x_x_mozilla_cycle_collect,800 09:02:10 INFO - PROCESS | 19718 | __end_cc_report 09:02:10 INFO - PROCESS | 19718 | __startTimestamp1468425730016__endTimestamp 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | ------- Summary: start ------- 09:02:10 INFO - PROCESS | 19718 | Number of tests: 6 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | [#0] dojo.html Cycles:165 Average:5482.77 Median:5692.23 stddev:608.48 (10.7%) stddev-sans-first:583.79 09:02:10 INFO - PROCESS | 19718 | Values: 3216.3 3277.0 3293.3 3338.4 3345.8 5507.1 5519.4 5531.9 5534.3 5539.7 5488.7 5528.4 5531.1 5542.9 5571.1 4893.4 4965.1 5077.3 5127.9 5163.9 4929.2 4983.6 5022.5 5033.5 5039.7 4960.3 5005.9 5027.0 5035.7 5087.3 5015.7 5042.1 5043.0 5048.0 5067.3 4888.0 4899.5 4936.2 4970.7 4981.9 5415.5 5454.7 5460.7 5467.0 5476.8 5887.1 5897.5 5897.9 5899.1 5901.2 5521.4 5774.7 5894.5 5913.9 5945.6 5509.9 5535.4 5555.7 5556.9 5565.2 5864.0 6043.7 6045.8 6052.4 6060.0 5819.0 5874.4 5880.3 5889.8 5910.8 5790.8 5801.5 5803.6 5809.0 5811.3 5735.3 5775.6 5777.5 5778.5 5841.0 5928.0 5932.7 5934.1 5937.6 5958.0 4539.9 4542.5 4548.2 4550.4 4572.1 3948.5 3991.9 4008.1 4069.4 4116.3 5634.7 5650.1 5652.7 5661.2 5672.5 5974.9 5981.6 5984.8 5984.9 5994.9 5441.6 5535.7 5634.5 5636.9 5638.1 5092.4 5093.8 5101.2 5103.6 5128.2 6075.6 6091.5 6096.4 6103.1 6103.5 5816.4 5946.7 5967.3 5985.8 6036.0 6066.4 6083.9 6097.1 6107.8 6111.5 5873.7 5876.6 5876.9 5880.3 5889.4 5763.4 5910.4 5974.5 5981.4 6028.8 5697.0 5707.9 5712.2 5734.6 5735.4 5679.0 5683.9 5684.6 5692.2 5701.6 5555.3 5603.9 5631.9 5722.4 5728.9 5779.6 5798.9 5809.3 5813.9 5820.7 5698.5 5699.4 5703.6 5705.0 5732.5 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | [#1] ext.html Cycles:180 Average:56769.71 Median:38265.83 stddev:107089.95 (279.9%) stddev-sans-first:107307.34 09:02:10 INFO - PROCESS | 19718 | Values: 604.5 661.8 664.8 677.6 698.0 32323.2 32984.2 41874.8 42365.2 42377.0 44227.0 45302.3 45315.0 45350.3 45350.8 7614.6 8887.1 9075.3 9079.3 10378.5 10480.8 10642.6 10645.0 10648.1 10651.5 10625.8 10695.5 10705.3 10716.4 10719.4 10560.4 10602.9 10644.4 10645.5 10645.9 10471.1 10583.6 10593.2 10816.2 10849.9 44067.1 44294.3 44432.8 44499.1 44585.8 3750.2 3783.7 3839.0 4094.8 4494.6 31587.0 31588.1 31888.5 33868.8 33899.0 4541.6 4548.6 4586.1 4589.2 4804.9 291891.5 291894.0 292349.0 293938.0 294624.0 40119.0 40901.0 63841.4 64340.7 64484.4 38220.4 38311.2 38416.4 38429.0 38446.8 17188.7 17394.5 17413.0 17415.9 17419.1 11847.6 14812.8 15161.9 15181.3 15182.4 9287.0 9287.8 9290.2 9345.8 9388.4 3533.7 3640.1 3657.2 3671.3 3694.7 1118.8 1162.3 1182.6 1248.0 1275.5 32654.3 33528.0 33821.3 33824.8 34300.5 1237.4 1283.7 1313.8 1331.6 1357.5 17801.4 17842.0 17864.1 18007.9 18167.8 532400.0 541079.0 542386.0 543080.0 543796.0 64871.7 65529.3 65560.0 65613.3 65796.7 1399.1 1532.0 1535.4 1544.6 1642.0 30053.7 31158.8 31315.4 32264.4 32530.3 47389.0 63254.7 65152.3 65225.3 65266.0 332068.0 334873.0 335686.0 336603.0 336996.0 39925.4 44054.3 48503.8 48581.3 49635.8 47067.0 47807.0 48022.0 48966.3 57164.0 41389.4 41800.4 42512.6 43584.0 45416.0 40986.6 42085.4 42607.6 43081.4 44835.0 46389.8 47223.0 47908.5 48056.8 48442.3 39884.4 41804.6 41855.8 41920.3 42422.8 30997.4 31008.2 31227.8 31259.2 31678.7 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | [#2] jquery.html Cycles:180 Average:29363.71 Median:2096.12 stddev:85397.67 (4074.1%) stddev-sans-first:85609.59 09:02:10 INFO - PROCESS | 19718 | Values: 428.3 430.7 431.8 437.5 440.3 18478.5 18822.8 19046.6 19349.3 19866.4 18910.4 19232.2 20249.7 20261.7 20273.9 5696.6 5736.0 5743.2 5792.7 5896.5 4193.2 5828.8 5835.7 6207.6 6482.0 6439.6 6457.5 6461.5 6466.9 6468.2 5575.9 5814.8 5816.4 5816.8 6415.0 3801.8 3953.1 5420.2 5664.5 5669.1 13467.1 13491.7 13695.5 13696.8 18561.0 2409.6 2456.8 2495.8 2553.3 2986.6 10060.9 10316.2 10351.3 10692.7 10797.9 1946.8 1977.7 1994.7 2030.7 2075.5 73673.6 75679.0 81427.6 83253.6 83870.0 11185.3 11287.5 11301.2 11312.4 11469.4 15786.3 15790.4 15900.8 15916.8 15918.2 8563.4 8565.1 8630.8 8650.6 8699.3 8412.8 8533.4 8832.9 8835.5 8982.1 5059.8 5090.2 5101.3 5122.6 5166.6 1850.2 2020.3 2056.4 2083.8 2108.4 995.6 1089.7 1119.0 1141.3 1150.2 18776.0 18802.7 19006.4 19316.4 19538.1 1059.9 1069.6 1088.9 1119.5 1139.5 10503.2 10747.2 10856.8 10862.3 10865.3 512709.0 513941.2 514023.0 521056.0 535188.0 67588.0 86672.0 92077.0 93951.5 95534.0 1062.9 1065.7 1069.5 1071.8 1087.3 17026.6 17031.3 17331.0 17389.6 17432.5 37927.0 38600.0 39331.8 39496.0 40503.0 56676.7 57232.7 57419.0 57493.4 57573.7 8551.9 8792.6 8826.4 8955.4 9128.8 12596.2 12601.3 12675.7 12843.7 13372.3 11300.8 11329.9 11450.5 11487.6 11549.3 10893.9 11174.9 11260.8 11658.5 11902.9 6369.7 10404.8 10778.6 11686.5 11902.1 8464.4 8515.3 8761.0 8824.6 8834.2 9624.4 11831.7 11876.5 11911.9 12009.7 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | [#3] mootools.html Cycles:180 Average:5708.89 Median:4922.98 stddev:3160.80 (64.2%) stddev-sans-first:3153.50 09:02:10 INFO - PROCESS | 19718 | Values: 1455.1 1624.3 1627.0 1863.6 1941.2 8218.7 8382.0 8406.4 8414.2 8419.1 8273.4 8345.7 8399.4 8427.1 8446.0 2316.9 2333.8 2335.5 2337.5 2339.7 2315.9 2332.3 2372.7 2380.5 2386.6 2285.3 2309.0 2310.2 2312.4 2322.2 2353.8 2378.7 2380.2 2395.0 2395.1 2316.2 2368.5 2379.4 2382.1 2387.5 7267.6 8154.7 8554.4 8595.7 8602.3 5133.7 5201.5 5238.4 5239.7 5254.9 3333.4 3367.4 3424.1 3436.3 3457.0 1068.5 1077.7 1086.4 1092.6 1107.3 11996.0 12187.8 12193.1 12203.1 12215.9 4689.2 4694.4 4723.7 4734.7 4775.5 10583.2 10590.7 10591.8 10596.9 10603.1 5420.3 5448.6 5465.6 5471.4 5472.8 4892.4 4948.7 4951.2 4956.9 4959.0 4009.3 4086.7 4118.8 4124.8 4126.7 1248.2 1249.2 1253.0 1254.1 1264.1 892.7 1052.4 1056.5 1057.9 1060.2 5971.8 6088.7 6096.7 6124.3 6240.2 942.4 1072.2 1084.1 1102.4 1201.8 3996.4 4087.3 4108.6 4161.3 4196.6 10328.8 10669.1 10712.0 10739.2 10741.1 10334.5 10551.2 10561.8 10572.3 10586.8 8079.9 8212.6 8292.2 8318.9 8344.6 5755.4 5822.6 5836.0 5839.2 5865.2 9542.9 9589.8 9628.5 9761.0 9772.0 9734.1 9791.2 9819.8 9827.9 9925.8 6906.9 7066.8 7071.7 7102.3 7456.6 8134.0 8167.3 8211.7 8222.0 8243.7 7113.0 7228.4 7286.3 7358.1 7368.7 7112.6 7198.5 7232.2 7297.4 7310.0 6895.9 6918.5 6948.5 6948.8 6957.0 4423.6 4897.2 5091.8 5116.0 5240.8 5392.1 5418.7 5425.9 5442.1 5479.2 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | [#4] prototype.html Cycles:180 Average:5467.86 Median:6222.81 stddev:1673.70 (26.9%) stddev-sans-first:1633.56 09:02:10 INFO - PROCESS | 19718 | Values: 340.6 342.3 342.5 342.6 342.6 6152.9 6170.0 6176.6 6219.8 6225.8 6091.6 6186.9 6202.1 6203.3 6213.3 4454.8 4530.7 4538.5 4615.7 4735.7 4705.0 4728.6 4735.2 4738.8 4749.9 4693.5 4700.9 4701.6 4701.8 4705.7 4409.8 4508.2 4555.8 4672.5 4695.2 4110.8 4111.8 4119.3 4125.7 4140.3 5930.6 5967.2 5973.6 5978.9 5992.2 5427.5 5431.5 5432.0 5435.4 5454.5 6496.5 6505.8 6506.4 6507.3 6519.3 4322.1 4443.2 4465.8 4546.5 4553.3 6745.6 6785.9 6795.7 6797.9 6818.2 4531.2 4537.8 4543.3 4550.8 4551.1 4572.9 4585.4 4596.1 4596.3 4600.4 5296.2 5300.0 5300.1 5310.7 5376.7 6372.2 6481.6 6486.3 6490.7 6520.3 1587.1 1594.1 1604.0 1605.6 1610.6 1040.1 1047.8 1058.7 1061.0 1065.7 6159.1 6217.7 6355.0 6370.7 6413.9 6821.8 6825.7 6830.2 6901.7 6913.9 6397.9 6416.2 6416.5 6421.1 6421.8 3645.9 3681.2 3682.0 3689.3 3690.4 6798.4 6940.0 6957.3 6958.7 6981.9 6884.9 6891.6 6901.9 6911.4 6914.2 6946.9 6948.3 6958.2 6964.8 6967.2 6791.0 6799.5 6802.7 6818.6 6819.7 6491.1 6652.9 6704.6 6723.5 6751.7 6956.4 6958.8 6968.3 6971.4 6971.9 4586.7 4588.9 4591.1 4596.4 4596.6 6812.5 6813.8 6833.4 6835.7 6836.9 6418.2 6618.1 6629.5 6632.5 6633.3 6533.1 6538.2 6546.7 6557.5 6571.6 6501.6 6513.4 6519.6 6539.1 6539.6 6665.2 6667.5 6676.7 6678.0 6682.4 6388.6 6464.1 6484.2 6493.6 6504.5 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - PROCESS | 19718 | [#5] yui.html Cycles:180 Average:15557.22 Median:26060.45 stddev:18513.08 (71.0%) stddev-sans-first:18532.02 09:02:10 INFO - PROCESS | 19718 | Values: 839.8 865.9 910.5 931.1 947.3 13804.4 13976.7 13996.3 14008.2 14022.5 12780.6 12890.6 12893.7 12895.6 12906.2 716.1 902.3 909.9 915.9 924.1 921.9 925.4 926.0 926.7 926.9 964.2 964.7 965.0 965.2 965.9 755.4 959.2 964.6 981.0 981.2 720.0 723.3 723.8 723.9 724.7 13446.9 13472.5 13499.0 13550.0 13580.3 14305.5 14630.3 14632.6 14915.1 15134.8 12229.6 12253.0 12253.4 12255.8 12373.9 3977.7 4003.9 4021.6 4057.6 4148.0 57984.4 58129.0 58377.1 58761.0 58945.7 11577.9 11679.6 11840.9 12364.3 12521.7 20864.7 21090.0 21124.6 21125.0 21137.9 8093.9 8305.1 8380.9 8414.0 8898.6 4905.9 5019.4 5044.2 5065.0 5068.9 3485.2 3550.7 3606.9 3610.7 3612.1 614.1 619.1 717.3 720.5 721.2 659.8 674.3 758.6 762.5 768.0 8694.5 9355.9 9456.4 9577.6 9696.9 648.4 701.3 722.9 756.6 775.3 4452.1 4476.5 4515.0 4527.5 4599.2 65148.3 65455.3 65490.7 65561.7 65800.0 57833.4 58822.0 59802.4 59885.1 59986.4 51664.2 52419.7 53096.2 53873.7 54426.0 9038.8 9082.4 9249.3 9261.3 9273.9 39733.2 39943.6 40462.0 40973.8 41362.4 47196.0 47215.0 52184.5 52403.5 52719.5 11505.8 11518.3 11596.9 11631.0 11873.9 11780.5 11897.6 12000.2 12020.6 12096.4 12247.0 12455.9 12612.5 12635.7 12646.6 11687.6 11821.3 11821.6 11866.7 11895.6 11968.6 12170.2 12342.7 12388.7 12417.9 10306.3 10333.1 10504.6 10619.9 10854.5 9856.0 10357.8 10365.8 10378.6 10413.9 09:02:10 INFO - PROCESS | 19718 | -------- Summary: end -------- 09:02:10 INFO - PROCESS | 19718 | 09:02:10 INFO - TEST-INFO | 19718: exit 0 09:02:10 INFO - TEST-OK | dromaeo_css | took 1110241ms 09:02:10 INFO - TEST-START | kraken 09:02:10 INFO - operating with platform_type : linux_ 09:02:10 INFO - Initialising browser for kraken test... 09:02:10 INFO - TEST-INFO | started process 19911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6qd1JN/profile http://localhost:46313/getInfo.html) 09:02:14 INFO - PROCESS | 19911 | __metrics Screen width/height:1600/1200 09:02:14 INFO - PROCESS | 19911 | colorDepth:24 09:02:14 INFO - PROCESS | 19911 | Browser inner width/height: 1024/697 09:02:14 INFO - PROCESS | 19911 | __metrics 09:02:15 ERROR - PROCESS | 19911 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:02:15 INFO - TEST-INFO | 19911: exit 0 09:02:15 INFO - Browser initialized. 09:02:15 INFO - Running cycle 1/1 for kraken test... 09:02:15 INFO - TEST-INFO | started process 20007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6qd1JN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:27 INFO - PROCESS | 20007 | RSS: Main: 139825152 09:02:27 INFO - PROCESS | 20007 | 09:02:30 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46313/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:30 INFO - PROCESS | 20007 | RSS: Main: 197611520 09:02:30 INFO - PROCESS | 20007 | 09:02:33 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46313/tests/kraken/driver.html?testName=audio-dft) 09:02:34 INFO - PROCESS | 20007 | RSS: Main: 184430592 09:02:34 INFO - PROCESS | 20007 | 09:02:36 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46313/tests/kraken/driver.html?testName=audio-fft) 09:02:37 INFO - PROCESS | 20007 | RSS: Main: 273645568 09:02:37 INFO - PROCESS | 20007 | 09:02:39 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46313/tests/kraken/driver.html?testName=audio-oscillator) 09:02:40 INFO - PROCESS | 20007 | RSS: Main: 179482624 09:02:40 INFO - PROCESS | 20007 | 09:02:42 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46313/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:42 INFO - PROCESS | 20007 | RSS: Main: 178315264 09:02:42 INFO - PROCESS | 20007 | 09:02:45 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46313/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:46 INFO - PROCESS | 20007 | RSS: Main: 212930560 09:02:46 INFO - PROCESS | 20007 | 09:02:49 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46313/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:50 INFO - PROCESS | 20007 | RSS: Main: 212316160 09:02:50 INFO - PROCESS | 20007 | 09:02:53 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46313/tests/kraken/driver.html?testName=json-parse-financial) 09:02:53 INFO - PROCESS | 20007 | RSS: Main: 212389888 09:02:53 INFO - PROCESS | 20007 | 09:02:55 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46313/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:55 INFO - PROCESS | 20007 | RSS: Main: 196780032 09:02:55 INFO - PROCESS | 20007 | 09:02:57 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:58 INFO - PROCESS | 20007 | RSS: Main: 200122368 09:02:58 INFO - PROCESS | 20007 | 09:03:00 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:00 INFO - PROCESS | 20007 | RSS: Main: 207609856 09:03:00 INFO - PROCESS | 20007 | 09:03:03 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:03 INFO - PROCESS | 20007 | RSS: Main: 218451968 09:03:03 INFO - PROCESS | 20007 | 09:03:06 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:07 INFO - PROCESS | 20007 | RSS: Main: 212840448 09:03:07 INFO - PROCESS | 20007 | 09:03:08 INFO - PROCESS | 20007 | Cycle 1(1): loaded http://localhost:46313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46313/tests/kraken/driver.html?testName=ai-astar) 09:03:09 INFO - PROCESS | 20007 | RSS: Main: 273186816 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | __start_tp_report 09:03:09 INFO - PROCESS | 20007 | _x_x_mozilla_page_load 09:03:09 INFO - PROCESS | 20007 | _x_x_mozilla_page_load_details 09:03:09 INFO - PROCESS | 20007 | |i|pagename|runs| 09:03:09 INFO - PROCESS | 20007 | |0;ai-astar;110;109;108;110;110;110;106;110;110;109 09:03:09 INFO - PROCESS | 20007 | |1;audio-beat-detection;154;127;157;181;126;157;149;126;180;125 09:03:09 INFO - PROCESS | 20007 | |2;audio-dft;160;163;160;161;160;161;160;160;159;159 09:03:09 INFO - PROCESS | 20007 | |3;audio-fft;75;76;76;171;75;77;77;77;166;76 09:03:09 INFO - PROCESS | 20007 | |4;audio-oscillator;92;90;163;92;91;93;138;92;92;155 09:03:09 INFO - PROCESS | 20007 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;117;117 09:03:09 INFO - PROCESS | 20007 | |6;imaging-darkroom;145;146;145;145;146;145;145;146;146;146 09:03:09 INFO - PROCESS | 20007 | |7;imaging-desaturate;95;94;95;95;95;94;95;94;94;94 09:03:09 INFO - PROCESS | 20007 | |8;json-parse-financial;53;53;56;55;55;57;54;73;53;53 09:03:09 INFO - PROCESS | 20007 | |9;json-stringify-tinderbox;60;62;59;60;60;60;59;60;59;59 09:03:09 INFO - PROCESS | 20007 | |10;stanford-crypto-aes;72;72;71;80;80;72;73;80;72;72 09:03:09 INFO - PROCESS | 20007 | |11;stanford-crypto-ccm;115;112;113;111;120;112;108;119;127;115 09:03:09 INFO - PROCESS | 20007 | |12;stanford-crypto-pbkdf2;165;160;158;156;159;159;156;163;174;159 09:03:09 INFO - PROCESS | 20007 | |13;stanford-crypto-sha256-iterative;65;65;64;65;66;66;66;64;66;65 09:03:09 INFO - PROCESS | 20007 | __end_tp_report 09:03:09 INFO - PROCESS | 20007 | __start_cc_report 09:03:09 INFO - PROCESS | 20007 | _x_x_mozilla_cycle_collect,1586 09:03:09 INFO - PROCESS | 20007 | __end_cc_report 09:03:09 INFO - PROCESS | 20007 | __startTimestamp1468425789013__endTimestamp 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | ------- Summary: start ------- 09:03:09 INFO - PROCESS | 20007 | Number of tests: 14 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.32 (1.2%) stddev-sans-first:1.36 09:03:09 INFO - PROCESS | 20007 | Values: 110.0 109.0 108.0 110.0 110.0 110.0 106.0 110.0 110.0 109.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:155.50 stddev:21.73 (14.0%) stddev-sans-first:22.95 09:03:09 INFO - PROCESS | 20007 | Values: 154.0 127.0 157.0 181.0 126.0 157.0 149.0 126.0 180.0 125.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 09:03:09 INFO - PROCESS | 20007 | Values: 160.0 163.0 160.0 161.0 160.0 161.0 160.0 160.0 159.0 159.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:38.97 (51.3%) stddev-sans-first:40.69 09:03:09 INFO - PROCESS | 20007 | Values: 75.0 76.0 76.0 171.0 75.0 77.0 77.0 77.0 166.0 76.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:29.75 (32.3%) stddev-sans-first:30.85 09:03:09 INFO - PROCESS | 20007 | Values: 92.0 90.0 163.0 92.0 91.0 93.0 138.0 92.0 92.0 155.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:03:09 INFO - PROCESS | 20007 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:03:09 INFO - PROCESS | 20007 | Values: 145.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 146.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:03:09 INFO - PROCESS | 20007 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:6.07 (11.0%) stddev-sans-first:6.33 09:03:09 INFO - PROCESS | 20007 | Values: 53.0 53.0 56.0 55.0 55.0 57.0 54.0 73.0 53.0 53.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 09:03:09 INFO - PROCESS | 20007 | Values: 60.0 62.0 59.0 60.0 60.0 60.0 59.0 60.0 59.0 59.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:72.50 stddev:3.89 (5.4%) stddev-sans-first:4.03 09:03:09 INFO - PROCESS | 20007 | Values: 72.0 72.0 71.0 80.0 80.0 72.0 73.0 80.0 72.0 72.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:115.00 stddev:5.49 (4.8%) stddev-sans-first:5.83 09:03:09 INFO - PROCESS | 20007 | Values: 115.0 112.0 113.0 111.0 120.0 112.0 108.0 119.0 127.0 115.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:159.50 stddev:5.38 (3.4%) stddev-sans-first:5.50 09:03:09 INFO - PROCESS | 20007 | Values: 165.0 160.0 158.0 156.0 159.0 159.0 156.0 163.0 174.0 159.0 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - PROCESS | 20007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 09:03:09 INFO - PROCESS | 20007 | Values: 65.0 65.0 64.0 65.0 66.0 66.0 66.0 64.0 66.0 65.0 09:03:09 INFO - PROCESS | 20007 | -------- Summary: end -------- 09:03:09 INFO - PROCESS | 20007 | 09:03:09 INFO - TEST-INFO | 20007: exit 0 09:03:09 INFO - TEST-OK | kraken | took 59340ms 09:03:09 INFO - SUITE-END | took 1169s 09:03:10 INFO - Completed test suite (00:19:29) 09:03:10 INFO - javascript benchmark 09:03:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3216.3245718399135, 3277.049655599875, 3293.341331733652, 3338.3823992561393, 3345.7825241359324, 5507.091329930562, 5519.392866784656, 5531.889362212753, 5534.308211473561, 5539.723013849311, 5488.670679759217, 5528.419515950827, 5531.1426728856995, 5542.861428464291, 5571.052921003429, 4893.41279046515, 4965.106280869433, 5077.289179514871, 5127.9230811537855, 5163.870903227412, 4929.21132618781, 4983.626228032894, 5022.522860328281, 5033.521815427529, 5039.748012599373, 4960.3303554020285, 5005.899882002358, 5027.0, 5035.748212589374, 5087.338645976018, 5015.673981191211, 5042.067217564726, 5042.974785126087, 5048.040872234301, 5067.315912351841, 4888.0, 4899.485554016813, 4936.210206367, 4970.726610036447, 4981.9252711209365, 5415.512603865671, 5454.699991500466, 5460.726963651801, 5467.015937131315, 5476.808311709111, 5887.146363777271, 5897.498712609433, 5897.852553686149, 5899.115132730082, 5901.173835662968, 5521.365043020064, 5774.740136693859, 5894.4989675877605, 5913.852153696149, 5945.583809133319, 5509.917351239735, 5535.446455354472, 5555.722213889329, 5556.888862222733, 5565.193047008162, 5864.0, 6043.7280322385595, 6045.758169673251, 6052.394760523913, 6059.969700151559, 5818.970905145532, 5874.383189765099, 5880.2943646761805, 5889.823305300848, 5910.793122240787, 5790.768369265183, 5801.50687191585, 5803.564732644984, 5809.0124678804705, 5811.302643682785, 5735.340435849931, 5775.624584402, 5777.45114214149, 5778.479936805707, 5840.970795145997, 5927.970360148258, 5932.703364831741, 5934.13954976526, 5937.614055086492, 5958.0, 4539.863804085882, 4542.500324964251, 4548.249538826057, 4550.431196100488, 4572.1312950539295, 3948.4866967294643, 3991.940120898189, 4008.07814202735, 4069.4099355593867, 4116.279651061052, 5634.661920284796, 5650.067738823048, 5652.74562644682, 5661.207430959669, 5672.546196304285, 5974.9402505974385, 5981.61119527238, 5984.820455386345, 5984.850378740479, 5994.940050599525, 5441.564674826083, 5535.723213839292, 5634.492895639412, 5636.915446268309, 5638.069718496402, 5092.388913330424, 5093.770780314895, 5101.234814777738, 5103.566196873233, 5128.1794912813775, 6075.605085669417, 6091.51267898567, 6096.359882212304, 6103.05402662588, 6103.450689437972, 5816.447437493432, 5946.672932988728, 5967.343592204854, 5985.760569577168, 6036.0, 6066.393360663898, 6083.908741368795, 6097.085437184458, 6107.755689772359, 6111.541634377529, 5873.676947767914, 5876.647401155944, 5876.882462350814, 5880.26496687914, 5889.38161493037, 5763.366029736641, 5910.379410162043, 5974.522038236843, 5981.3719559445635, 6028.849278768066, 5697.0, 5707.8858422832145, 5712.228849105318, 5734.569907256889, 5735.426457354231, 5679.00617391963, 5683.914741278802, 5684.602077854511, 5692.231548740867, 5701.629394089371, 5555.2778138841695, 5603.943960560506, 5631.915521267266, 5722.370539240597, 5728.942710572841, 5779.595428319977, 5798.884022319615, 5809.2738407699035, 5813.854653633693, 5820.70896455184, 5698.515626171822, 5699.401562835843, 5703.5722320826935, 5704.973104841169, 5732.455416735404], "value": 5443.115819918904, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.4680681000722, 661.7551505942802, 664.7839452178042, 677.5799004617138, 697.9511434199608, 32323.191920202007, 32984.17539561512, 41874.790626046866, 42365.15269694604, 42377.0, 44227.0, 45302.32046519305, 45315.0, 45350.31974520385, 45350.77324613381, 7614.619269036553, 8887.111288871125, 9075.273978081737, 9079.273658107335, 10378.481075946172, 10480.842787358195, 10642.57429702811, 10645.041946224837, 10648.14814814813, 10651.520681569347, 10625.78748425031, 10695.518701658444, 10705.304155229886, 10716.35701857891, 10719.35683858967, 10560.419176945265, 10602.946985265102, 10644.361338319686, 10645.467726613677, 10645.946770266177, 10471.10995565378, 10583.57665693379, 10593.152547796235, 10816.188785841015, 10849.891501085045, 44067.11865762667, 44294.33558496593, 44432.77783611061, 44499.11001779946, 44585.77707111444, 3750.19370835269, 3783.6783873370796, 3838.9616103838885, 4094.754314741125, 4494.5505449454795, 31587.0, 31588.052358429282, 31888.521672174935, 33868.83065584681, 33899.0, 4541.568550987651, 4548.6133678637025, 4586.082783443325, 4589.1510070636705, 4804.855854324341, 291891.54054229805, 291894.0, 292349.0, 293938.0, 294624.0, 40119.0, 40901.0, 63841.361586383544, 64340.678296609156, 64484.35515644877, 38220.42669359962, 38311.23377532434, 38416.42375364372, 38429.0, 38446.846594602204, 17188.742168867477, 17394.47816565505, 17413.0, 17415.91292043557, 17419.12904354777, 11847.644570662895, 14812.777808332883, 15161.924190379199, 15181.316840742193, 15182.392704291926, 9287.0, 9287.814243715224, 9290.210332121711, 9345.813083738287, 9388.389754665925, 3533.7349698772696, 3640.12636967126, 3657.1771351446246, 3671.30245253401, 3694.722895782827, 1118.7864551191408, 1162.3200427749691, 1182.640072960869, 1247.9625611231677, 1275.515304184404, 32654.346913061607, 33528.0, 33821.32357352839, 33824.830875845466, 34300.48549271763, 1237.4369661803858, 1283.7304166125218, 1313.848907375645, 1331.6071758831167, 1357.518081081202, 17801.376951806626, 17842.01868897223, 17864.106794660216, 18007.909960450113, 18167.818321816878, 532400.0, 541079.0, 542386.0, 543080.0, 543796.0, 64871.67564162243, 65529.344706553275, 65560.0, 65613.34386656072, 65796.67101664461, 1399.0766094377661, 1532.0348180646345, 1535.3628244278723, 1544.5829626000916, 1642.0476123848139, 30053.69946300509, 31158.844205778827, 31315.37369252648, 32264.35471290514, 32530.349393012482, 47389.0, 63254.683726582916, 65152.34847651463, 65225.347746521926, 65266.0, 332068.0, 334873.0, 335686.0, 336603.0, 336996.0, 39925.401118982656, 44054.3391849129, 48503.75748121237, 48581.27128093152, 49635.751821240665, 47067.0, 47807.0, 48022.0, 48966.26550601672, 57164.0, 41389.37915931203, 41800.37299440572, 42512.57487425086, 43584.0, 45416.0, 40986.590134098275, 42085.36871946862, 42607.57392426036, 43081.353779692705, 44835.0, 46389.76805115953, 47223.0, 47908.5209147918, 48056.759716201195, 48442.27336590025, 39884.40173397459, 41804.58195418007, 41855.7907210462, 41920.32318707217, 42422.787886061604, 30997.380052398374, 31008.22479438032, 31227.84386078055, 31259.218519537193, 31678.683213168497], "value": 20472.58745472798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.32752578451846, 430.7092712419116, 431.7754767520887, 437.52965562020813, 440.30871531695243, 18478.538036549093, 18822.811771882276, 19046.619067618638, 19349.322773702923, 19866.404007879788, 18910.432687019376, 19232.230710771553, 20249.69625455616, 20261.696074558895, 20273.898630506865, 5696.629719068258, 5736.0, 5743.167240750089, 5792.710364481759, 5896.498797602188, 4193.245215861159, 5828.795992140276, 5835.737391817378, 6207.565470417073, 6481.995290729945, 6439.58142720724, 6457.547971641987, 6461.450776683988, 6466.870662586745, 6468.223813142429, 5575.916361254584, 5814.825555233349, 5816.41835816415, 5816.825495235129, 6415.0, 3801.82891769871, 3953.09078911849, 5420.159875219348, 5664.490195882349, 5669.121286200645, 13467.057305988585, 13491.66270843227, 13695.520656777064, 13696.794548081787, 18561.0, 2409.6265078912797, 2456.8034557235555, 2495.8128140389545, 2553.2850801775535, 2986.566947792558, 10060.949695251476, 10316.226283028727, 10351.275410721253, 10692.732681682943, 10797.892021079768, 1946.7858535561077, 1977.73300604418, 1994.7406837111228, 2030.715699802029, 2075.5122546201633, 73673.6316318415, 75679.0, 81427.5928620359, 83253.58373208156, 83870.0, 11185.272957257752, 11287.548498059985, 11301.20891537601, 11312.434378281054, 11469.426528673699, 15786.289616967264, 15790.447334343244, 15900.840991589936, 15916.840831591537, 15918.204089795696, 8563.443376180529, 8565.14348565151, 8630.82738345242, 8650.610722517502, 8699.347548933856, 8412.8317433651, 8533.35999800005, 8832.936849049509, 8835.469871807712, 8982.056884027083, 5059.772310246048, 5090.185570308733, 5101.311322971425, 5122.564582010496, 5166.5866730661455, 1850.1674246589089, 2020.3332900142918, 2056.4447599148148, 2083.812456878888, 2108.420184449258, 995.576879826071, 1089.6839916424308, 1118.9552417903355, 1141.2923987127867, 1150.1661295560818, 18776.0, 18802.717959230624, 19006.429807105807, 19316.42050738452, 19538.12078456473, 1059.862217911682, 1069.5668254356997, 1088.9019988200941, 1119.5353928119903, 1139.47014638192, 10503.2122590806, 10747.247692661438, 10856.837147442795, 10862.34825910448, 10865.32656353618, 512709.0, 513941.17208284343, 514023.0, 521056.0, 535188.0, 67588.0, 86672.0, 92077.0, 93951.53024234972, 95534.0, 1062.86182796236, 1065.6536625596711, 1069.4973362519604, 1071.8499410082595, 1087.342157994418, 17026.574335641708, 17031.31874724997, 17331.0, 17389.565260868578, 17432.477025689248, 37927.0, 38600.034999125244, 39331.80334098311, 39496.0, 40503.0, 56676.716616416656, 57232.71383643055, 57419.0, 57493.42506574881, 57573.71213144075, 8551.914480855361, 8792.560371981503, 8826.382153249211, 8955.373123881527, 9128.817423651622, 12596.244225346509, 12601.306928119042, 12675.746485070431, 12843.743125137631, 13372.331383430985, 11300.773984520429, 11329.90396776599, 11450.484728187419, 11487.597934072268, 11549.307041577533, 10893.945530272298, 11174.944125279322, 11260.774784504429, 11658.475368608264, 11902.880971190523, 6369.7452101915405, 10404.803447603623, 10778.568857245622, 11686.474108664961, 11902.107341949215, 8464.407491475538, 8515.276201522693, 8761.03628600866, 8824.602892869965, 8834.160754728548, 9624.37441566296, 11831.70420739454, 11876.524939002344, 11911.940440298089, 12009.699757506132], "value": 9255.28046735621, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.1487379882767, 1624.309668390934, 1626.9674606507874, 1863.5900101977568, 1941.2041063164106, 8218.712345067925, 8381.958090209555, 8406.411551191419, 8414.15858414159, 8419.073901870797, 8273.420860539765, 8345.74962751117, 8399.370047246466, 8427.073021967593, 8445.95777021114, 2316.9073237070497, 2333.801626861719, 2335.532893421314, 2337.5091230841545, 2339.7192336919593, 2315.8610483370967, 2332.2536788227776, 2372.6559648850907, 2380.5357955198742, 2386.570417324881, 2285.3029825903095, 2309.030207312933, 2310.1798861404213, 2312.398776318161, 2322.2104484475276, 2353.823463240247, 2378.6907701998803, 2380.155044959049, 2394.988025059872, 2395.077895010425, 2316.2435381402533, 2368.46709490365, 2379.3575734551746, 2382.0590866607768, 2387.5224955008894, 7267.600281984489, 8154.673813047471, 8554.401191916568, 8595.656173753105, 8602.311815054843, 5133.743312834381, 5201.531862132426, 5238.423773384925, 5239.659422137549, 5254.894902101974, 3333.449980753173, 3367.4275373186615, 3424.07549961509, 3436.347094052122, 3456.9654303456896, 1068.5031460370888, 1077.6874706335154, 1086.4241951765578, 1092.579356947573, 1107.2526044919728, 11996.0, 12187.817182742267, 12193.085518586142, 12203.084768642299, 12215.93892030543, 4689.202835517902, 4694.413198350207, 4723.6929599575915, 4734.715917044989, 4775.450823155312, 10583.153347732163, 10590.682279531626, 10591.788164236672, 10596.947015264874, 10603.09873660732, 5420.295361603045, 5448.591355648263, 5465.562754979592, 5471.37079235885, 5472.808451704172, 4892.3884514435695, 4948.727819969936, 4951.207806750903, 4956.8760780980765, 4958.9504104959215, 4009.258287216874, 4086.6526345260986, 4118.835246590163, 4124.793760311973, 4126.711130220856, 1248.1949142802841, 1249.2254802022621, 1253.035162924543, 1254.1283807753707, 1264.0772236267392, 892.7054072156172, 1052.4316868890712, 1056.5351245451977, 1057.9471026448646, 1060.2419270221828, 5971.820845374646, 6088.665123418255, 6096.664683442365, 6124.326324104345, 6240.157578726905, 942.4251206763869, 1072.1637123044038, 1084.0839490630406, 1102.4212288548576, 1201.825735268381, 3996.440498330236, 4087.2642924273914, 4108.589141085868, 4161.334186530201, 4196.559361267084, 10328.845067323997, 10669.146468282519, 10712.0, 10739.194560408001, 10741.140708743282, 10334.483275836179, 10551.20865935058, 10561.788764224673, 10572.312799667998, 10586.841197382046, 8079.878801817978, 8212.63043163059, 8292.212239837207, 8318.875216871751, 8344.62449189788, 5755.395683453177, 5822.592418530662, 5835.9708201458725, 5839.182514447895, 5865.178874957594, 9542.85685714701, 9589.808203835744, 9628.518574071128, 9760.951195244263, 9771.951140244537, 9734.123928846439, 9791.167750740982, 9819.803603928025, 9827.85258221113, 9925.801483970135, 6906.930930690629, 7066.823329416806, 7071.681774320271, 7102.289771022856, 7456.552606843607, 8133.959330203311, 8167.305779008613, 8211.71259005932, 8221.958890205511, 8243.711470098518, 7113.0, 7228.421726261781, 7286.307800758919, 7358.11702595692, 7368.668409921674, 7112.6096693583695, 7198.460115491254, 7232.204457509775, 7297.416206703557, 7310.0, 6895.931040689529, 6918.481113916376, 6948.548344357803, 6948.826279343057, 6956.965215173892, 4423.646108311392, 4897.240927656219, 5091.796328146833, 5115.974420127875, 5240.842774716764, 5392.137258038695, 5418.701971391612, 5425.864353391197, 5442.102053161184, 5479.232907393048], "value": 4631.789779284229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.56577863224385, 342.31878561662285, 342.53073289593254, 342.55467891740744, 342.61626977784886, 6152.876942461154, 6170.0436432353, 6176.567640265172, 6219.813405597828, 6225.813225603228, 6091.573589848713, 6186.907196392058, 6202.06968954657, 6203.348648391921, 6213.316535181138, 4454.754988475633, 4530.682852200347, 4538.500764915857, 4615.676902616801, 4735.6921800083055, 4705.0, 4728.645351598627, 4735.242361222206, 4738.834140805073, 4749.881252968687, 4693.507181745918, 4700.942287985193, 4701.553352431531, 4701.764911754416, 4705.741184234866, 4409.757463339531, 4508.2336002879265, 4555.772211389451, 4672.486026537078, 4695.225287827504, 4110.835566577333, 4111.773852438115, 4119.290494444802, 4125.66994640428, 4140.3168477201225, 5930.614510056833, 5967.194428752106, 5973.551983601204, 5978.8505287367725, 5992.161097446361, 5427.538659213971, 5431.51116399522, 5431.967926094069, 5435.402105768362, 5454.509094181503, 6496.5127615428555, 6505.772297969548, 6506.3818937200895, 6507.3167317431935, 6519.282878883367, 4322.113966636832, 4443.200223959686, 4465.82136714531, 4546.499655113805, 4553.2942393929, 6745.628990405526, 6785.8642827143185, 6795.694193761293, 6797.898031529531, 6818.181818181801, 4531.184386810406, 4537.8411755588395, 4543.25036369002, 4550.840720574764, 4551.112533056088, 4572.908541829145, 4585.403897493371, 4596.10375976688, 4596.333531637893, 4600.447946246405, 5296.152615581488, 5300.0, 5300.09898317287, 5310.707911064851, 5376.731163441812, 6372.171617689671, 6481.638855840326, 6486.254080780676, 6490.707918143695, 6520.347965203537, 1587.0636324568559, 1594.0913679202974, 1603.9518814435585, 1605.5986003499124, 1610.62955520231, 1040.1210976724656, 1047.8428235764695, 1058.692979036071, 1061.0132576703586, 1065.6909496246, 6159.1069294951985, 6217.720202590895, 6355.0, 6370.713317900706, 6413.903791443132, 6821.761238356634, 6825.69284382204, 6830.214525329551, 6901.689423975933, 6913.89629155563, 6397.904031439532, 6416.165898433267, 6416.486681065504, 6421.101045853584, 6421.775237866652, 3645.8906232813056, 3681.208540163878, 3681.963180368162, 3689.262147570497, 3690.372636651776, 6798.354156355138, 6939.965300173568, 6957.2694867038235, 6958.65206739661, 6981.89527157093, 6884.896726549106, 6891.552049116792, 6901.896471552931, 6911.447084233249, 6914.239433662293, 6946.861062778716, 6948.33990770876, 6958.234594194634, 6964.79105626832, 6967.163940327193, 6791.0, 6799.524033317621, 6802.693878775368, 6818.590884546943, 6819.727210911508, 6491.091247225487, 6652.866942661217, 6704.631245281556, 6723.495737819585, 6751.696173672099, 6956.373926346653, 6958.756443524452, 6968.268331825086, 6971.407430368476, 6971.930280697331, 4586.656000799887, 4588.908221835612, 4591.081783643352, 4596.379488769107, 4596.563326483979, 6812.455003599799, 6813.829654258485, 6833.4191593715095, 6835.658217089026, 6836.863262734618, 6418.1656384669695, 6618.139641846529, 6629.502787290876, 6632.469402447696, 6633.336666333328, 6533.052707357501, 6538.248101468392, 6546.738130474728, 6557.475401967736, 6571.638559879252, 6501.577397469149, 6513.446357059703, 6519.641419721961, 6539.051837483634, 6539.640319782267, 6665.166854143232, 6667.533272670867, 6676.732930682719, 6677.998300255001, 6682.398584127257, 6388.621261633642, 6464.062710906798, 6484.157059582224, 6493.610383376824, 6504.512161587994], "value": 4916.732161949308, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.7816567692398, 865.8614621660536, 910.5447276361818, 931.0922198649569, 947.2658689515624, 13804.378802953866, 13976.650583735387, 13996.300184990761, 14008.159510429381, 14022.509212177563, 12780.61658150257, 12890.613281601567, 12893.74212515749, 12895.613131606044, 12906.161099528525, 716.0941409117471, 902.3322741171519, 909.9363044586881, 915.922146617535, 924.089771574998, 921.8663293822425, 925.3892430995544, 926.0276709455079, 926.6802952981211, 926.9026752191024, 964.2045312617084, 964.7105868239535, 965.0205041882494, 965.2133511188359, 965.9178969787577, 755.391909512842, 959.1799011844877, 964.5996911281844, 980.9607615695363, 981.2444417798256, 719.989200161998, 723.3273056057864, 723.7937187901475, 723.9095113110861, 724.7173602295109, 13446.865531344756, 13472.461101555926, 13499.0, 13550.0, 13580.253086080262, 14305.499307524291, 14630.341634626468, 14632.634184145376, 14915.105093694414, 15134.848651513454, 12229.571964981184, 12253.007511346303, 12253.448594813255, 12255.75488490234, 12373.876261237363, 3977.7215594908366, 4003.8598649047435, 4021.577734337882, 4057.57395473474, 4147.979260103711, 57984.420155798325, 58129.0, 58377.124343134885, 58761.0, 58945.705271473795, 11577.942110289394, 11679.649610511698, 11840.88159118415, 12364.319962401974, 12521.74956500865, 20864.687029694567, 21090.0, 21124.577508450053, 21125.0, 21137.89431052835, 8093.919060809317, 8305.086440491541, 8380.916190838136, 8414.0, 8898.555072246361, 4905.901881962341, 5019.372578427697, 5044.192929131322, 5065.0, 5068.873278168076, 3485.233248685285, 3550.680438760524, 3606.8737594184076, 3610.7472476926887, 3612.078919875415, 614.121805817685, 619.1146660275849, 717.3185473799911, 720.4524561333319, 721.1778572427437, 659.8383396067994, 674.3020973292619, 758.6017340895963, 762.5272331154608, 767.9577623230776, 8694.478331300015, 9355.90644093564, 9456.385334953206, 9577.569009394454, 9696.854547181798, 648.3516483516484, 701.2987012987013, 722.9349358557755, 756.580098045579, 775.2673723331397, 4452.109578084396, 4476.529964353761, 4514.954850451453, 4527.501974782771, 4599.172149013143, 65148.34851651423, 65455.345446544925, 65490.672546637914, 65561.67219163873, 65800.0, 57833.421665783644, 58822.0, 59802.40197598055, 59885.10172347418, 59986.400135998956, 51664.22503662448, 52419.73790131025, 53096.203556946675, 53873.730631347375, 54426.0, 9038.819223615359, 9082.40964337316, 9249.30630202751, 9261.305402094735, 9273.907260927304, 39733.2053358937, 39943.60056399515, 40462.0, 40973.79513102535, 41362.37956430596, 47196.0, 47215.0, 52184.47815521796, 52403.475965241385, 52719.472805271456, 11505.827412588986, 11518.251313664585, 11596.942015290208, 11631.0, 11873.940630296793, 11780.52877884875, 11897.583584574499, 12000.15998880105, 12020.63938081859, 12096.395180241128, 12247.0, 12455.93772031134, 12612.49550017989, 12635.684107897008, 12646.557370491988, 11687.649370518899, 11821.290722556674, 11821.645350639494, 11866.703332416759, 11895.643130706092, 11968.581099661471, 12170.208936419105, 12342.691432714253, 12388.690282743004, 12417.937910310391, 10306.33008854422, 10333.121684656888, 10504.632337868137, 10619.893801062199, 10854.457277135954, 9855.950720246354, 10357.792844143225, 10365.844512332473, 10378.636747713794, 10413.895861041292], "value": 7021.195789787057, "unit": "score"}], "name": "dromaeo_css", "value": 7405.386437330134, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 108.0, 110.0, 110.0, 110.0, 106.0, 110.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 157.0, 181.0, 126.0, 157.0, 149.0, 126.0, 180.0, 125.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 160.0, 161.0, 160.0, 161.0, 160.0, 160.0, 159.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 171.0, 75.0, 77.0, 77.0, 77.0, 166.0, 76.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 163.0, 92.0, 91.0, 93.0, 138.0, 92.0, 92.0, 155.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 56.0, 55.0, 55.0, 57.0, 54.0, 73.0, 53.0, 53.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 80.0, 80.0, 72.0, 73.0, 80.0, 72.0, 72.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 113.0, 111.0, 120.0, 112.0, 108.0, 119.0, 127.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 158.0, 156.0, 159.0, 159.0, 156.0, 163.0, 174.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 66.0, 66.0, 64.0, 66.0, 65.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1510.5000000000002, "alertThreshold": 2.0}]} 09:03:10 INFO - Return code: 0 09:03:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:03:10 ERROR - # TBPL SUCCESS # 09:03:10 INFO - Running post-action listener: _resource_record_post_action 09:03:10 INFO - Running post-run listener: _resource_record_post_run 09:03:11 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 28672; Write bytes: 312479744; Read time: 20; Write time: 243420 09:03:11 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 106201088; Read time: 0; Write time: 124192 09:03:11 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 206278656; Read time: 4; Write time: 119228 09:03:11 INFO - Running post-run listener: _upload_blobber_files 09:03:11 INFO - Blob upload gear active. 09:03:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:11 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 09:03:11 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:11 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:12 INFO - (blobuploader) - INFO - Done attempting. 09:03:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:13 INFO - (blobuploader) - INFO - Done attempting. 09:03:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:13 INFO - Return code: 0 09:03:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92adc9da3ba162c5ff7dbe95e886012b35ceeceb50ab3778aca115bea3d0f9b232096c5f384779515abd773195f16f6f5b19e85f780aa088a77701b2e5ad6922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/224af471d5110cbccb34a88ae0b343399c6ca6e30b1c72a345b466c22f155f0512993cae9bf0a060c533eb5c994b974938f2fdc4fc63a05968131b9c62f72b01"} 09:03:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:13 INFO - Contents: 09:03:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92adc9da3ba162c5ff7dbe95e886012b35ceeceb50ab3778aca115bea3d0f9b232096c5f384779515abd773195f16f6f5b19e85f780aa088a77701b2e5ad6922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/224af471d5110cbccb34a88ae0b343399c6ca6e30b1c72a345b466c22f155f0512993cae9bf0a060c533eb5c994b974938f2fdc4fc63a05968131b9c62f72b01"} 09:03:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:13 INFO - Copying logs to upload dir... 09:03:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.844631 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-07-13 09:03:12.712684) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:12.718670) ========= 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=826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92adc9da3ba162c5ff7dbe95e886012b35ceeceb50ab3778aca115bea3d0f9b232096c5f384779515abd773195f16f6f5b19e85f780aa088a77701b2e5ad6922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/224af471d5110cbccb34a88ae0b343399c6ca6e30b1c72a345b466c22f155f0512993cae9bf0a060c533eb5c994b974938f2fdc4fc63a05968131b9c62f72b01"} build_url:https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/AD9Vact1QIq4Y1cARcsWqw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92adc9da3ba162c5ff7dbe95e886012b35ceeceb50ab3778aca115bea3d0f9b232096c5f384779515abd773195f16f6f5b19e85f780aa088a77701b2e5ad6922", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/224af471d5110cbccb34a88ae0b343399c6ca6e30b1c72a345b466c22f155f0512993cae9bf0a060c533eb5c994b974938f2fdc4fc63a05968131b9c62f72b01"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:12.746596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:12.746923) ========= 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=826874ccc97bd7bf541b4875000001d5-1468424300.260131-5781732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 09:03:12.829117) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 09:03:12.829477) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 09:03:12.829781) ========= ========= Total master_lag: 0.17 =========